builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-057 starttime: 1506385350.3 results: success (0) revision: 641bfddb87113b45ee3df9849345dbcf821ef3da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:30.295965) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:30.296625) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:30.296976) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:30.330755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:30.331121) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 17:22:30-- 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% 22.3M=0.001s 2017-09-25 17:22:30 (22.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:30.468399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:30.469085) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022702 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:30.518772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:30.519108) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 641bfddb87113b45ee3df9849345dbcf821ef3da --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 641bfddb87113b45ee3df9849345dbcf821ef3da --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=934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 17:22:30,570 truncating revision to first 12 chars 2017-09-25 17:22:30,570 Setting DEBUG logging. 2017-09-25 17:22:30,570 attempt 1/10 2017-09-25 17:22:30,570 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/641bfddb8711?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 17:22:30,952 unpacking tar archive at: mozilla-central-641bfddb8711/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:31.208052) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:31.208360) ========= script_repo_revision: 641bfddb87113b45ee3df9849345dbcf821ef3da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:31.208739) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:31.209060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:31.222602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-25 17:22:31.222918) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:22:31 INFO - MultiFileLogger online at 20170925 17:22:31 in /builds/slave/test 17:22:31 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 17:22:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:22:31 INFO - {'append_to_log': False, 17:22:31 INFO - 'base_work_dir': '/builds/slave/test', 17:22:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:22:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:22:31 INFO - 'branch': 'Firefox-Non-PGO', 17:22:31 INFO - 'buildbot_json_path': 'buildprops.json', 17:22:31 INFO - 'code_coverage': False, 17:22:31 INFO - 'config_files': ('talos/linux_config.py',), 17:22:31 INFO - 'default_actions': ('clobber', 17:22:31 INFO - 'read-buildbot-config', 17:22:31 INFO - 'download-and-extract', 17:22:31 INFO - 'populate-webroot', 17:22:31 INFO - 'create-virtualenv', 17:22:31 INFO - 'install', 17:22:31 INFO - 'setup-mitmproxy', 17:22:31 INFO - 'run-tests'), 17:22:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:22:31 INFO - 'disable_ccov_upload': False, 17:22:31 INFO - 'disable_stylo': False, 17:22:31 INFO - 'download_minidump_stackwalk': True, 17:22:31 INFO - 'download_symbols': 'ondemand', 17:22:31 INFO - 'enable_stylo': False, 17:22:31 INFO - 'enable_webrender': False, 17:22:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:22:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:22:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:22:31 INFO - 'gecko_profile': False, 17:22:31 INFO - 'gecko_profile_interval': 0, 17:22:31 INFO - 'installer_path': 'installer.exe', 17:22:31 INFO - 'log_level': 'info', 17:22:31 INFO - 'log_name': 'talos', 17:22:31 INFO - 'log_to_console': True, 17:22:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:22:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:22:31 INFO - 'opt_config_files': (), 17:22:31 INFO - 'pip_index': False, 17:22:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:22:31 INFO - 'system_bits': '32', 17:22:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:22:31 INFO - 'title': 'talos-linux64-ix-057', 17:22:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:22:31 INFO - 'use_talos_json': True, 17:22:31 INFO - 'verify': 'False', 17:22:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:22:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:22:31 INFO - 'work_dir': 'build'} 17:22:31 INFO - [mozharness: 2017-09-26 00:22:31.418433Z] Running clobber step. 17:22:31 INFO - Running pre-action listener: _resource_record_pre_action 17:22:31 INFO - Running main action method: clobber 17:22:31 INFO - rmtree: /builds/slave/test/build 17:22:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:22:32 INFO - Running post-action listener: _resource_record_post_action 17:22:32 INFO - [mozharness: 2017-09-26 00:22:32.940057Z] Finished clobber step (success) 17:22:32 INFO - [mozharness: 2017-09-26 00:22:32.940156Z] Running read-buildbot-config step. 17:22:32 INFO - Running pre-action listener: _resource_record_pre_action 17:22:32 INFO - Running main action method: read_buildbot_config 17:22:32 INFO - Using buildbot properties: 17:22:32 INFO - { 17:22:32 INFO - "project": "", 17:22:32 INFO - "product": "firefox", 17:22:32 INFO - "who": "kwierso@gmail.com", 17:22:32 INFO - "installer_path": "public/build/target.tar.bz2", 17:22:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:22:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:22:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 17:22:32 INFO - "stage_platform": "linux64", 17:22:32 INFO - "basedir": "/builds/slave/test", 17:22:32 INFO - "buildnumber": 41, 17:22:32 INFO - "platform": "ubuntu64_hw", 17:22:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:22:32 INFO - "slavebuilddir": "test", 17:22:32 INFO - "taskId": "I2--pHNeSgq-hJyjEUX1QA", 17:22:32 INFO - "branch": "mozilla-central", 17:22:32 INFO - "script_repo_revision": "production", 17:22:32 INFO - "revision": "641bfddb87113b45ee3df9849345dbcf821ef3da", 17:22:32 INFO - "slavename": "talos-linux64-ix-057", 17:22:32 INFO - "repo_path": "mozilla-central" 17:22:32 INFO - } 17:22:32 INFO - Finding installer, test and symbols from parent task. 17:22:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I2--pHNeSgq-hJyjEUX1QA'}, attempt #1 17:22:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I2--pHNeSgq-hJyjEUX1QA'}, attempt #1 17:22:33 INFO - Task dependencies: T6YG80ZaRluUV1sg95wmlQ 17:22:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ'}, attempt #1 17:22:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 17:22:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.test_packages.json 17:22:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.crashreporter-symbols.zip 17:22:34 INFO - Running post-action listener: _resource_record_post_action 17:22:34 INFO - [mozharness: 2017-09-26 00:22:34.292214Z] Finished read-buildbot-config step (success) 17:22:34 INFO - [mozharness: 2017-09-26 00:22:34.292433Z] Running download-and-extract step. 17:22:34 INFO - Running pre-action listener: _resource_record_pre_action 17:22:34 INFO - Running main action method: download_and_extract 17:22:34 INFO - mkdir: /builds/slave/test/build/tests 17:22: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')]} 17:22:34 INFO - trying https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.test_packages.json 17:22:34 INFO - Downloading https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:22:34 INFO - Downloaded 989 bytes. 17:22:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:22:34 INFO - Using the following test package requirements: 17:22:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:22:34 INFO - u'common': [u'target.common.tests.zip'], 17:22:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:22:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:22:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:22:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:22:34 INFO - u'mozbase': [u'target.common.tests.zip'], 17:22:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:22:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:22:34 INFO - u'web-platform': [u'target.common.tests.zip', 17:22:34 INFO - u'target.web-platform.tests.tar.gz'], 17:22:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:22:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:22:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.common.tests.zip 17:22:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:22:34 INFO - Fetch https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.common.tests.zip into memory 17:22:35 INFO - Content-Length response header: 54943852 17:22:35 INFO - Bytes received: 54943852 17:22:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.talos.tests.zip 17:22:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:22:46 INFO - Fetch https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.talos.tests.zip into memory 17:22:47 INFO - Content-Length response header: 14513823 17:22:47 INFO - Bytes received: 14513823 17:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:47 INFO - trying https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 17:22:47 INFO - Downloading https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:22:48 INFO - Downloaded 61770111 bytes. 17:22:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 17:22:48 INFO - mkdir: /builds/slave/test/properties 17:22:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:22:48 INFO - Writing to file /builds/slave/test/properties/build_url 17:22:48 INFO - Contents: 17:22:48 INFO - build_url:https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 17:22:48 INFO - Running post-action listener: _resource_record_post_action 17:22:48 INFO - Running post-action listener: find_tests_for_verification 17:22:48 INFO - Running post-action listener: set_extra_try_arguments 17:22:48 INFO - [mozharness: 2017-09-26 00:22:48.854189Z] Finished download-and-extract step (success) 17:22:48 INFO - [mozharness: 2017-09-26 00:22:48.854304Z] Running populate-webroot step. 17:22:48 INFO - Running pre-action listener: _resource_record_pre_action 17:22:48 INFO - Running main action method: populate_webroot 17:22:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:22:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tresize', 17:22:48 INFO - 'tcanvasmark']}, 17:22:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:22:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['dromaeo_css', 17:22:48 INFO - 'kraken']}, 17:22:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'tests': ['damp', 'tps']}, 17:22:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['damp', 'tps']}, 17:22:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:22:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['dromaeo_dom']}, 17:22:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:22:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['basic_compositor_video', 17:22:48 INFO - 'glvideo']}, 17:22:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:22:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['ts_paint_webext', 17:22:48 INFO - 'tp5o_webext']}, 17:22:48 INFO - 'other-e10s': {'tests': ['a11yr', 17:22:48 INFO - 'ts_paint', 17:22:48 INFO - 'tpaint', 17:22:48 INFO - 'sessionrestore', 17:22:48 INFO - 'sessionrestore_many_windows', 17:22:48 INFO - 'sessionrestore_no_auto_restore', 17:22:48 INFO - 'tabpaint']}, 17:22:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['a11yr', 17:22:48 INFO - 'ts_paint', 17:22:48 INFO - 'tpaint', 17:22:48 INFO - 'sessionrestore', 17:22:48 INFO - 'sessionrestore_many_windows', 17:22:48 INFO - 'sessionrestore_no_auto_restore', 17:22:48 INFO - 'tabpaint']}, 17:22:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:22:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:22:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['perf_reftest_singletons']}, 17:22:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['perf_reftest']}, 17:22:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:22:48 INFO - 'tsvgr_opacity', 17:22:48 INFO - 'tart', 17:22:48 INFO - 'tscrollx', 17:22:48 INFO - 'tsvg_static']}, 17:22:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tsvgx', 17:22:48 INFO - 'tsvgr_opacity', 17:22:48 INFO - 'tart', 17:22:48 INFO - 'tscrollx', 17:22:48 INFO - 'tsvg_static']}, 17:22:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:22:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tp5o']}, 17:22:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:48 INFO - 'talos_options': ['--mitmproxy', 17:22:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:48 INFO - '--firstNonBlankPaint'], 17:22:48 INFO - 'tests': ['tp6_google', 17:22:48 INFO - 'tp6_youtube', 17:22:48 INFO - 'tp6_amazon', 17:22:48 INFO - 'tp6_facebook']}, 17:22:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:48 INFO - 'talos_options': ['--disable-stylo', 17:22:48 INFO - '--mitmproxy', 17:22:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:48 INFO - '--firstNonBlankPaint'], 17:22:48 INFO - 'tests': ['tp6_google', 17:22:48 INFO - 'tp6_youtube', 17:22:48 INFO - 'tp6_amazon', 17:22:48 INFO - 'tp6_facebook']}, 17:22:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:48 INFO - 'talos_options': ['--stylo-threads=1', 17:22:48 INFO - '--mitmproxy', 17:22:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:48 INFO - '--firstNonBlankPaint'], 17:22:48 INFO - 'tests': ['tp6_google', 17:22:48 INFO - 'tp6_youtube', 17:22:48 INFO - 'tp6_amazon', 17:22:48 INFO - 'tp6_facebook']}, 17:22:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--xperf_path', 17:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:48 INFO - 'tests': ['tp5n']}, 17:22:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo', 17:22:48 INFO - '--xperf_path', 17:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:48 INFO - 'tests': ['tp5n']}}} 17:22:48 INFO - Running post-action listener: _resource_record_post_action 17:22:48 INFO - [mozharness: 2017-09-26 00:22:48.871232Z] Finished populate-webroot step (success) 17:22:48 INFO - [mozharness: 2017-09-26 00:22:48.871339Z] Running create-virtualenv step. 17:22:48 INFO - Running pre-action listener: _resource_record_pre_action 17:22:48 INFO - Running main action method: create_virtualenv 17:22:48 INFO - Creating virtualenv /builds/slave/test/build/venv 17:22:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:22:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:22:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:22:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:22:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:22:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:22:49 INFO - Installing pip...............done. 17:22:49 INFO - Return code: 0 17:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:22:49 INFO - Reading from file tmpfile_stdout 17:22:49 INFO - Output received: 17:22:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:22:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, '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': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', '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 17:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:22:49 INFO - Using env: {'DISPLAY': ':0', 17:22:49 INFO - 'HOME': '/home/cltbld', 17:22:49 INFO - 'LANG': 'en_US.UTF-8', 17:22:49 INFO - 'LANGUAGE': 'en_US:en', 17:22:49 INFO - 'LOGNAME': 'cltbld', 17:22:49 INFO - 'MAIL': '/var/mail/cltbld', 17:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:49 INFO - 'MOZ_NO_REMOTE': '1', 17:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:49 INFO - 'NO_EM_RESTART': '1', 17:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:49 INFO - 'PWD': '/builds/slave/test', 17:22:49 INFO - 'SHELL': '/bin/bash', 17:22:49 INFO - 'SHLVL': '1', 17:22:49 INFO - 'TERM': 'linux', 17:22:49 INFO - 'TMOUT': '86400', 17:22:49 INFO - 'USER': 'cltbld', 17:22:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:49 INFO - '_': '/tools/buildbot/bin/python'} 17:22:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:22:51 INFO - Downloading/unpacking pip>=1.5 17:22:51 INFO - Running setup.py egg_info for package pip 17:22:51 INFO - warning: no files found matching 'pip/cacert.pem' 17:22:51 INFO - warning: no files found matching '*.html' under directory 'docs' 17:22:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:22:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:22:51 INFO - Installing collected packages: pip 17:22:51 INFO - Found existing installation: pip 1.1 17:22:51 INFO - Uninstalling pip: 17:22:51 INFO - Successfully uninstalled pip 17:22:51 INFO - Running setup.py install for pip 17:22:51 INFO - warning: no files found matching 'pip/cacert.pem' 17:22:51 INFO - warning: no files found matching '*.html' under directory 'docs' 17:22:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:22:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:22:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:22:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:22:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:22:51 INFO - Successfully installed pip 17:22:51 INFO - Cleaning up... 17:22:51 INFO - Return code: 0 17:22:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:22:51 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')]} 17:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:51 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')]} 17:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:51 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 0xf231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, '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': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', '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 17:22:51 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 17:22:51 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 17:22:51 INFO - Using env: {'DISPLAY': ':0', 17:22:51 INFO - 'HOME': '/home/cltbld', 17:22:51 INFO - 'LANG': 'en_US.UTF-8', 17:22:51 INFO - 'LANGUAGE': 'en_US:en', 17:22:51 INFO - 'LOGNAME': 'cltbld', 17:22:51 INFO - 'MAIL': '/var/mail/cltbld', 17:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:51 INFO - 'MOZ_NO_REMOTE': '1', 17:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:51 INFO - 'NO_EM_RESTART': '1', 17:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:51 INFO - 'PWD': '/builds/slave/test', 17:22:51 INFO - 'SHELL': '/bin/bash', 17:22:51 INFO - 'SHLVL': '1', 17:22:51 INFO - 'TERM': 'linux', 17:22:51 INFO - 'TMOUT': '86400', 17:22:51 INFO - 'USER': 'cltbld', 17:22:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:51 INFO - '_': '/tools/buildbot/bin/python'} 17:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:51 INFO - Downloading/unpacking psutil>=3.1.1 17:22:51 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 17:22:51 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 17:22:51 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 17:22:51 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 17:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:52 INFO - Installing collected packages: psutil 17:22:52 INFO - Running setup.py install for psutil 17:22:52 INFO - building 'psutil._psutil_linux' extension 17:22:52 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 17:22:52 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 17:22:52 INFO - building 'psutil._psutil_posix' extension 17:22:52 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 17:22:52 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 17:22:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:53 INFO - Successfully installed psutil 17:22:53 INFO - Cleaning up... 17:22:53 INFO - Return code: 0 17:22:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17: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')]} 17:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17: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')]} 17:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:53 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 0xf231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, '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': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', '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 17:22:53 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 17:22:53 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 17:22:53 INFO - Using env: {'DISPLAY': ':0', 17:22:53 INFO - 'HOME': '/home/cltbld', 17:22:53 INFO - 'LANG': 'en_US.UTF-8', 17:22:53 INFO - 'LANGUAGE': 'en_US:en', 17:22:53 INFO - 'LOGNAME': 'cltbld', 17:22:53 INFO - 'MAIL': '/var/mail/cltbld', 17:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:53 INFO - 'MOZ_NO_REMOTE': '1', 17:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:53 INFO - 'NO_EM_RESTART': '1', 17:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:53 INFO - 'PWD': '/builds/slave/test', 17:22:53 INFO - 'SHELL': '/bin/bash', 17:22:53 INFO - 'SHLVL': '1', 17:22:53 INFO - 'TERM': 'linux', 17:22:53 INFO - 'TMOUT': '86400', 17:22:53 INFO - 'USER': 'cltbld', 17:22:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:53 INFO - '_': '/tools/buildbot/bin/python'} 17:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:22:53 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 17:22:53 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 17:22:53 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 17:22:53 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 17:22:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:22:54 INFO - Installing collected packages: mozsystemmonitor 17:22:54 INFO - Running setup.py install for mozsystemmonitor 17:22:54 INFO - Successfully installed mozsystemmonitor 17:22:54 INFO - Cleaning up... 17:22:55 INFO - Return code: 0 17:22:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:22:55 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')]} 17:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:55 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')]} 17:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:55 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 0xf231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, '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': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', '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 17:22:55 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 17:22:55 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 17:22:55 INFO - Using env: {'DISPLAY': ':0', 17:22:55 INFO - 'HOME': '/home/cltbld', 17:22:55 INFO - 'LANG': 'en_US.UTF-8', 17:22:55 INFO - 'LANGUAGE': 'en_US:en', 17:22:55 INFO - 'LOGNAME': 'cltbld', 17:22:55 INFO - 'MAIL': '/var/mail/cltbld', 17:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:55 INFO - 'MOZ_NO_REMOTE': '1', 17:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:55 INFO - 'NO_EM_RESTART': '1', 17:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:55 INFO - 'PWD': '/builds/slave/test', 17:22:55 INFO - 'SHELL': '/bin/bash', 17:22:55 INFO - 'SHLVL': '1', 17:22:55 INFO - 'TERM': 'linux', 17:22:55 INFO - 'TMOUT': '86400', 17:22:55 INFO - 'USER': 'cltbld', 17:22:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:55 INFO - '_': '/tools/buildbot/bin/python'} 17:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:55 INFO - Downloading/unpacking jsonschema==2.5.1 17:22:55 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 17:22:55 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 17:22:55 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 17:22:55 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 17:22:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:22:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:22:58 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 17:22:58 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 17:22:58 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 17:22:58 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 17:22:58 INFO - Downloading functools32-3.2.3-2.tar.gz 17:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:22:58 INFO - warning: no files found matching '*.txt' 17:22:58 INFO - no previously-included directories found matching 'build' 17:22:58 INFO - no previously-included directories found matching 'dist' 17:22:58 INFO - no previously-included directories found matching '.git*' 17:22:58 INFO - Installing collected packages: jsonschema, functools32 17:22:58 INFO - Running setup.py install for functools32 17:22:58 INFO - warning: no files found matching '*.txt' 17:22:58 INFO - no previously-included directories found matching 'build' 17:22:58 INFO - no previously-included directories found matching 'dist' 17:22:58 INFO - no previously-included directories found matching '.git*' 17:22:58 INFO - Successfully installed jsonschema functools32 17:22:58 INFO - Cleaning up... 17:22:58 INFO - Return code: 0 17:22:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:22:58 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')]} 17:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:58 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')]} 17:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:58 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 0xf231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, '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': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', '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 17:22:58 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 17:22:58 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 17:22:58 INFO - Using env: {'DISPLAY': ':0', 17:22:58 INFO - 'HOME': '/home/cltbld', 17:22:58 INFO - 'LANG': 'en_US.UTF-8', 17:22:58 INFO - 'LANGUAGE': 'en_US:en', 17:22:58 INFO - 'LOGNAME': 'cltbld', 17:22:58 INFO - 'MAIL': '/var/mail/cltbld', 17:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:58 INFO - 'MOZ_NO_REMOTE': '1', 17:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:58 INFO - 'NO_EM_RESTART': '1', 17:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:58 INFO - 'PWD': '/builds/slave/test', 17:22:58 INFO - 'SHELL': '/bin/bash', 17:22:58 INFO - 'SHLVL': '1', 17:22:58 INFO - 'TERM': 'linux', 17:22:58 INFO - 'TMOUT': '86400', 17:22:58 INFO - 'USER': 'cltbld', 17:22:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:58 INFO - '_': '/tools/buildbot/bin/python'} 17:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:22:58 INFO - Cleaning up... 17:22:58 INFO - Return code: 0 17:22:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:22:58 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')]} 17:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:58 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')]} 17:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:58 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 0xf231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, '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': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', '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 17:22:58 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 17:22:58 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 17:22:58 INFO - Using env: {'DISPLAY': ':0', 17:22:58 INFO - 'HOME': '/home/cltbld', 17:22:58 INFO - 'LANG': 'en_US.UTF-8', 17:22:58 INFO - 'LANGUAGE': 'en_US:en', 17:22:58 INFO - 'LOGNAME': 'cltbld', 17:22:58 INFO - 'MAIL': '/var/mail/cltbld', 17:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:58 INFO - 'MOZ_NO_REMOTE': '1', 17:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:58 INFO - 'NO_EM_RESTART': '1', 17:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:58 INFO - 'PWD': '/builds/slave/test', 17:22:58 INFO - 'SHELL': '/bin/bash', 17:22:58 INFO - 'SHLVL': '1', 17:22:58 INFO - 'TERM': 'linux', 17:22:58 INFO - 'TMOUT': '86400', 17:22:58 INFO - 'USER': 'cltbld', 17:22:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:58 INFO - '_': '/tools/buildbot/bin/python'} 17:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:58 INFO - Downloading/unpacking blobuploader==1.2.4 17:22:58 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 17:22:58 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 17:22:58 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 17:22:58 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 17:23:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:23:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:23:00 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 17:23:00 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 17:23:00 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 17:23:00 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 17:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:23:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:23:00 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 17:23:00 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 17:23:00 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 17:23:00 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 17:23:00 INFO - Downloading docopt-0.6.1.tar.gz 17:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:23:00 INFO - Installing collected packages: blobuploader, requests, docopt 17:23:00 INFO - Running setup.py install for blobuploader 17:23:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:23:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:23:00 INFO - Running setup.py install for requests 17:23:01 INFO - Running setup.py install for docopt 17:23:01 INFO - Successfully installed blobuploader requests docopt 17:23:01 INFO - Cleaning up... 17:23:01 INFO - Return code: 0 17:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:01 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')]} 17:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:01 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')]} 17:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:01 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 0xf231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, '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': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', '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 17:23:01 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 17:23:01 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 17:23:01 INFO - Using env: {'DISPLAY': ':0', 17:23:01 INFO - 'HOME': '/home/cltbld', 17:23:01 INFO - 'LANG': 'en_US.UTF-8', 17:23:01 INFO - 'LANGUAGE': 'en_US:en', 17:23:01 INFO - 'LOGNAME': 'cltbld', 17:23:01 INFO - 'MAIL': '/var/mail/cltbld', 17:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:01 INFO - 'MOZ_NO_REMOTE': '1', 17:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:01 INFO - 'NO_EM_RESTART': '1', 17:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:01 INFO - 'PWD': '/builds/slave/test', 17:23:01 INFO - 'SHELL': '/bin/bash', 17:23:01 INFO - 'SHLVL': '1', 17:23:01 INFO - 'TERM': 'linux', 17:23:01 INFO - 'TMOUT': '86400', 17:23:01 INFO - 'USER': 'cltbld', 17:23:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:01 INFO - '_': '/tools/buildbot/bin/python'} 17:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:01 INFO - Running setup.py (path:/tmp/pip-iwG9Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:01 INFO - Running setup.py (path:/tmp/pip-VyFn_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:01 INFO - Running setup.py (path:/tmp/pip-0WPOMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:01 INFO - Running setup.py (path:/tmp/pip-Pbt7jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:01 INFO - Running setup.py (path:/tmp/pip-4_lkNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:01 INFO - Running setup.py (path:/tmp/pip-aDwzLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:01 INFO - Running setup.py (path:/tmp/pip-CXkeZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:01 INFO - Running setup.py (path:/tmp/pip-a5_9jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:01 INFO - Running setup.py (path:/tmp/pip-99cXtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:02 INFO - Running setup.py (path:/tmp/pip-iYRYqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:02 INFO - Running setup.py (path:/tmp/pip-dbTRV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:02 INFO - Running setup.py (path:/tmp/pip-DsJqiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:02 INFO - Running setup.py (path:/tmp/pip-55U_FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:02 INFO - Running setup.py (path:/tmp/pip-urj9Ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:02 INFO - Running setup.py (path:/tmp/pip-eG1RUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:02 INFO - Running setup.py (path:/tmp/pip-ct1p3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:02 INFO - Running setup.py (path:/tmp/pip-fkQ5Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:23:02 INFO - Running setup.py install for manifestparser 17:23:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Running setup.py install for mozcrash 17:23:02 INFO - Running setup.py install for mozdebug 17:23:02 INFO - Running setup.py install for mozdevice 17:23:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozfile 17:23:03 INFO - Running setup.py install for mozhttpd 17:23:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozinfo 17:23:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozInstall 17:23:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozleak 17:23:03 INFO - Running setup.py install for mozlog 17:23:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for moznetwork 17:23:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozprocess 17:23:03 INFO - Running setup.py install for mozprofile 17:23:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozrunner 17:23:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Running setup.py install for mozscreenshot 17:23:04 INFO - Running setup.py install for moztest 17:23:04 INFO - Running setup.py install for mozversion 17:23:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:23:04 INFO - Cleaning up... 17:23:04 INFO - Return code: 0 17:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:04 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')]} 17:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:04 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')]} 17:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:04 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 0xf231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, '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': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', '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 17:23:04 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 17:23:04 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 17:23:04 INFO - Using env: {'DISPLAY': ':0', 17:23:04 INFO - 'HOME': '/home/cltbld', 17:23:04 INFO - 'LANG': 'en_US.UTF-8', 17:23:04 INFO - 'LANGUAGE': 'en_US:en', 17:23:04 INFO - 'LOGNAME': 'cltbld', 17:23:04 INFO - 'MAIL': '/var/mail/cltbld', 17:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:04 INFO - 'MOZ_NO_REMOTE': '1', 17:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:04 INFO - 'NO_EM_RESTART': '1', 17:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:04 INFO - 'PWD': '/builds/slave/test', 17:23:04 INFO - 'SHELL': '/bin/bash', 17:23:04 INFO - 'SHLVL': '1', 17:23:04 INFO - 'TERM': 'linux', 17:23:04 INFO - 'TMOUT': '86400', 17:23:04 INFO - 'USER': 'cltbld', 17:23:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:04 INFO - '_': '/tools/buildbot/bin/python'} 17:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:04 INFO - Running setup.py (path:/tmp/pip-bS44K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:04 INFO - Running setup.py (path:/tmp/pip-gn0rTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:04 INFO - Running setup.py (path:/tmp/pip-RMgzXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:04 INFO - Running setup.py (path:/tmp/pip-ti_1Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:04 INFO - Running setup.py (path:/tmp/pip-w1bu5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:04 INFO - Running setup.py (path:/tmp/pip-HJ1aJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:05 INFO - Running setup.py (path:/tmp/pip-aRUkUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:05 INFO - Running setup.py (path:/tmp/pip-RTDAWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:05 INFO - Running setup.py (path:/tmp/pip-WwehWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:05 INFO - Running setup.py (path:/tmp/pip-B22FNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:05 INFO - Running setup.py (path:/tmp/pip-abAXAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:05 INFO - Running setup.py (path:/tmp/pip-R00HdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:05 INFO - Running setup.py (path:/tmp/pip-4ONwLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:05 INFO - Running setup.py (path:/tmp/pip-Fbq5IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:05 INFO - Running setup.py (path:/tmp/pip-kpJqmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:05 INFO - Running setup.py (path:/tmp/pip-Oictwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:05 INFO - Running setup.py (path:/tmp/pip-o0ycj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:05 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)) 17:23:05 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)) 17:23:05 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)) 17:23:05 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)) 17:23:05 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)) 17:23:05 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)) 17:23:05 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)) 17:23:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17: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 17: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 17: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 17: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 17:23:13 INFO - Downloading blessings-1.6.tar.gz 17:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:23:14 INFO - Installing collected packages: blessings 17:23:14 INFO - Running setup.py install for blessings 17:23:14 INFO - Successfully installed blessings 17:23:14 INFO - Cleaning up... 17:23:14 INFO - Return code: 0 17:23:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:14 INFO - Reading from file tmpfile_stdout 17:23:14 INFO - Current package versions: 17:23:14 INFO - argparse == 1.2.1 17:23:14 INFO - blessings == 1.6 17:23:14 INFO - blobuploader == 1.2.4 17:23:14 INFO - docopt == 0.6.1 17:23:14 INFO - functools32 == 3.2.3-2 17:23:14 INFO - jsonschema == 2.5.1 17:23:14 INFO - manifestparser == 1.1 17:23:14 INFO - mozInstall == 1.13 17:23:14 INFO - mozcrash == 1.0 17:23:14 INFO - mozdebug == 0.1 17:23:14 INFO - mozdevice == 0.51 17:23:14 INFO - mozfile == 1.2 17:23:14 INFO - mozhttpd == 0.7 17:23:14 INFO - mozinfo == 0.10 17:23:14 INFO - mozleak == 0.1 17:23:14 INFO - mozlog == 3.5 17:23:14 INFO - moznetwork == 0.27 17:23:14 INFO - mozprocess == 0.25 17:23:14 INFO - mozprofile == 0.28 17:23:14 INFO - mozrunner == 6.13 17:23:14 INFO - mozscreenshot == 0.1 17:23:14 INFO - mozsystemmonitor == 0.3 17:23:14 INFO - moztest == 0.8 17:23:14 INFO - mozversion == 1.4 17:23:14 INFO - psutil == 3.1.1 17:23:14 INFO - requests == 1.2.3 17:23:14 INFO - wsgiref == 0.1.2 17:23:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:14 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 0xf231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, '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': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', '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 17:23:14 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 17:23:14 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 17:23:14 INFO - Using env: {'DISPLAY': ':0', 17:23:14 INFO - 'HOME': '/home/cltbld', 17:23:14 INFO - 'LANG': 'en_US.UTF-8', 17:23:14 INFO - 'LANGUAGE': 'en_US:en', 17:23:14 INFO - 'LOGNAME': 'cltbld', 17:23:14 INFO - 'MAIL': '/var/mail/cltbld', 17:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:14 INFO - 'MOZ_NO_REMOTE': '1', 17:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:14 INFO - 'NO_EM_RESTART': '1', 17:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:14 INFO - 'PWD': '/builds/slave/test', 17:23:14 INFO - 'SHELL': '/bin/bash', 17:23:14 INFO - 'SHLVL': '1', 17:23:14 INFO - 'TERM': 'linux', 17:23:14 INFO - 'TMOUT': '86400', 17:23:14 INFO - 'USER': 'cltbld', 17:23:14 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:14 INFO - '_': '/tools/buildbot/bin/python'} 17:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17: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)) 17: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)) 17: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)) 17: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)) 17: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)) 17: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)) 17: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)) 17: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)) 17: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)) 17:23:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17: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 17: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 17: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 17: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 17:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17: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)) 17: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)) 17:23:15 INFO - Installing collected packages: simplejson 17:23:15 INFO - Running setup.py install for simplejson 17:23:15 INFO - building 'simplejson._speedups' extension 17: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 17: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 17:23:16 INFO - Successfully installed simplejson 17:23:16 INFO - Cleaning up... 17:23:16 INFO - Return code: 0 17:23:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17: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')]} 17:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17: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')]} 17:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17: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 0xf231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, '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': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', '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 17: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 17: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 17:23:16 INFO - Using env: {'DISPLAY': ':0', 17:23:16 INFO - 'HOME': '/home/cltbld', 17:23:16 INFO - 'LANG': 'en_US.UTF-8', 17:23:16 INFO - 'LANGUAGE': 'en_US:en', 17:23:16 INFO - 'LOGNAME': 'cltbld', 17:23:16 INFO - 'MAIL': '/var/mail/cltbld', 17:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:16 INFO - 'MOZ_NO_REMOTE': '1', 17:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:16 INFO - 'NO_EM_RESTART': '1', 17:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:16 INFO - 'PWD': '/builds/slave/test', 17:23:16 INFO - 'SHELL': '/bin/bash', 17:23:16 INFO - 'SHLVL': '1', 17:23:16 INFO - 'TERM': 'linux', 17:23:16 INFO - 'TMOUT': '86400', 17:23:16 INFO - 'USER': 'cltbld', 17:23:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:16 INFO - '_': '/tools/buildbot/bin/python'} 17:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:23:17 INFO - Cleaning up... 17:23:17 INFO - Return code: 0 17:23:17 INFO - Running post-action listener: _resource_record_post_action 17:23:17 INFO - Running post-action listener: _start_resource_monitoring 17:23:17 INFO - Starting resource monitoring. 17:23:17 INFO - [mozharness: 2017-09-26 00:23:17.113308Z] Finished create-virtualenv step (success) 17:23:17 INFO - [mozharness: 2017-09-26 00:23:17.113829Z] Running install step. 17:23:17 INFO - Running pre-action listener: _resource_record_pre_action 17:23:17 INFO - Running main action method: install 17:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:17 INFO - Reading from file tmpfile_stdout 17:23:17 INFO - Detecting whether we're running mozinstall >=1.0... 17:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:23:17 INFO - Reading from file tmpfile_stdout 17:23:17 INFO - Output received: 17:23:17 INFO - Usage: mozinstall [options] installer 17:23:17 INFO - Options: 17:23:17 INFO - -h, --help show this help message and exit 17:23:17 INFO - -d DEST, --destination=DEST 17:23:17 INFO - Directory to install application into. [default: 17:23:17 INFO - "/builds/slave/test"] 17:23:17 INFO - --app=APP Application being installed. [default: firefox] 17:23:17 INFO - mkdir: /builds/slave/test/build/application 17:23:17 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'] 17:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:23:35 INFO - Reading from file tmpfile_stdout 17:23:35 INFO - Output received: 17:23:35 INFO - /builds/slave/test/build/application/firefox/firefox 17:23:35 INFO - Running post-action listener: _resource_record_post_action 17:23:35 INFO - [mozharness: 2017-09-26 00:23:35.255579Z] Finished install step (success) 17:23:35 INFO - [mozharness: 2017-09-26 00:23:35.255833Z] Running setup-mitmproxy step. 17:23:35 INFO - Running pre-action listener: _resource_record_pre_action 17:23:35 INFO - Running main action method: setup_mitmproxy 17:23:35 INFO - Skipping: mitmproxy is not required 17:23:35 INFO - Running post-action listener: _resource_record_post_action 17:23:35 INFO - [mozharness: 2017-09-26 00:23:35.257013Z] Finished setup-mitmproxy step (success) 17:23:35 INFO - [mozharness: 2017-09-26 00:23:35.257237Z] Running run-tests step. 17:23:35 INFO - Running pre-action listener: _resource_record_pre_action 17:23:35 INFO - Running pre-action listener: _set_gcov_prefix 17:23:35 INFO - Running main action method: run_tests 17:23:35 WARNING - Try message not found. 17:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:23:35 INFO - Python 2.7.3 17:23:35 INFO - Return code: 0 17:23:35 INFO - grabbing minidump binary from tooltool 17:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:35 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 0x1292440>, '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 0x1293130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d320>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:23:35 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 17:23:35 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 17:23:35 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 17:23:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:23:35 INFO - Return code: 0 17:23:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:23:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:23:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:23:35 INFO - ENV: RUST_BACKTRACE is now full 17:23:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:23:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:23:35 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/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 17:23:35 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/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 17:23:35 INFO - Using env: {'DISPLAY': ':0', 17:23:35 INFO - 'HOME': '/home/cltbld', 17:23:35 INFO - 'LANG': 'en_US.UTF-8', 17:23:35 INFO - 'LANGUAGE': 'en_US:en', 17:23:35 INFO - 'LOGNAME': 'cltbld', 17:23:35 INFO - 'MAIL': '/var/mail/cltbld', 17:23:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:35 INFO - 'MOZ_NO_REMOTE': '1', 17:23:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:35 INFO - 'NO_EM_RESTART': '1', 17:23:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:35 INFO - 'PWD': '/builds/slave/test', 17:23:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:35 INFO - 'RUST_BACKTRACE': 'full', 17:23:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:23:35 INFO - 'SHELL': '/bin/bash', 17:23:35 INFO - 'SHLVL': '1', 17:23:35 INFO - 'TERM': 'linux', 17:23:35 INFO - 'TMOUT': '86400', 17:23:35 INFO - 'USER': 'cltbld', 17:23:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:35 INFO - '_': '/tools/buildbot/bin/python'} 17:23:35 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/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 17:23:35 INFO - mozversion application_buildid: 20170925232538 17:23:35 INFO - mozversion application_changeset: 641bfddb87113b45ee3df9849345dbcf821ef3da 17:23:35 INFO - mozversion application_display_name: Nightly 17:23:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:23:35 INFO - mozversion application_name: Firefox 17:23:35 INFO - mozversion application_remotingname: firefox 17:23:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:23:35 INFO - mozversion application_vendor: Mozilla 17:23:35 INFO - mozversion application_version: 58.0a1 17:23:35 INFO - mozversion platform_buildid: 20170925232538 17:23:35 INFO - mozversion platform_changeset: 641bfddb87113b45ee3df9849345dbcf821ef3da 17:23:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:23:35 INFO - mozversion platform_version: 58.0a1 17:23:35 INFO - using testdate: 1506385415 17:23:35 INFO - actual date: 1506385415 17:23:35 INFO - starting webserver on 'localhost:39052' 17:23:35 INFO - SUITE-START | Running 2 tests 17:23:35 INFO - TEST-START | dromaeo_css 17:23:35 INFO - Initialising browser for dromaeo_css test... 17:23:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39052/getInfo.html -profile /tmp/tmpITrlLh/profile 17:23:35 INFO - TEST-INFO | started process 6725 (/builds/slave/test/build/application/firefox/firefox http://localhost:39052/getInfo.html) 17:23:41 INFO - TEST-INFO | 6725: exit 0 17:23:41 INFO - Browser initialized. 17:23:41 INFO - Running cycle 1/1 for dromaeo_css test... 17:23:41 INFO - Using env: {'DISPLAY': ':0', 17:23:41 INFO - 'HOME': '/home/cltbld', 17:23:41 INFO - 'JSGC_DISABLE_POISONING': '1', 17:23:41 INFO - 'LANG': 'en_US.UTF-8', 17:23:41 INFO - 'LANGUAGE': 'en_US:en', 17:23:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:23:41 INFO - 'LOGNAME': 'cltbld', 17:23:41 INFO - 'MAIL': '/var/mail/cltbld', 17:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:41 INFO - 'MOZ_CRASHREPORTER': '1', 17:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:23:41 INFO - 'MOZ_NO_REMOTE': '1', 17:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:41 INFO - 'NO_EM_RESTART': '1', 17:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:41 INFO - 'PWD': '/builds/slave/test', 17:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:41 INFO - 'RUST_BACKTRACE': 'full', 17:23:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:23:41 INFO - 'SHELL': '/bin/bash', 17:23:41 INFO - 'SHLVL': '1', 17:23:41 INFO - 'STYLO_FORCE_DISABLED': '1', 17:23:41 INFO - 'TERM': 'linux', 17:23:41 INFO - 'TMOUT': '86400', 17:23:41 INFO - 'USER': 'cltbld', 17:23:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:41 INFO - '_': '/tools/buildbot/bin/python'} 17:23:41 INFO - TEST-INFO | started process 6957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpITrlLh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:41 INFO - PID 6957 | 17:23:41 INFO - PID 6957 | (/builds/slave/test/build/application/firefox/firefox:7006): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:23:41 INFO - PID 6957 | 17:23:52 INFO - PID 6957 | RSS: Main: 153653248 17:23:52 INFO - PID 6957 | 17:26:49 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:39052/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39052/tests/dromaeo/cssquery-ext.html) 17:26:51 INFO - PID 6957 | RSS: Main: 154046464 17:26:51 INFO - PID 6957 | 17:29:52 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:39052/tests/dromaeo/cssquery-ext.html (next: http://localhost:39052/tests/dromaeo/cssquery-jquery.html) 17:29:53 INFO - PID 6957 | RSS: Main: 152285184 17:29:53 INFO - PID 6957 | 17:32:55 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:39052/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39052/tests/dromaeo/cssquery-mootools.html) 17:32:55 INFO - PID 6957 | RSS: Main: 155713536 17:32:55 INFO - PID 6957 | 17:35:57 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:39052/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39052/tests/dromaeo/cssquery-prototype.html) 17:35:58 INFO - PID 6957 | RSS: Main: 154157056 17:35:58 INFO - PID 6957 | 17:39:01 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:39052/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39052/tests/dromaeo/cssquery-yui.html) 17:39:01 INFO - PID 6957 | RSS: Main: 155488256 17:39:01 INFO - PID 6957 | 17:42:03 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:39052/tests/dromaeo/cssquery-yui.html (next: http://localhost:39052/tests/dromaeo/cssquery-dojo.html) 17:42:03 INFO - PID 6957 | RSS: Main: 157638656 17:42:03 INFO - PID 6957 | 17:42:03 INFO - PID 6957 | __start_tp_report 17:42:03 INFO - PID 6957 | _x_x_mozilla_page_load 17:42:03 INFO - PID 6957 | _x_x_mozilla_page_load_details 17:42:03 INFO - PID 6957 | |i|pagename|runs| 17:42:03 INFO - PID 6957 | |0;dojo.html;3142.7171554560086;3171.825549594773;3177.2851108500604;3179.411808815369;3182.4112539180246;6191.783287584935;6318.747250109996;6332.1768170137875;6345.809625711236;6399.232092148943;6257;6308.337624549425;6319.368063193679;6321.5890967087225;6361.586496877711;5762.481376676098;5779.508741756956;5786.276715410574;5835.795747148851;5907.172995780573;5844.590878638497;5857.85355366115;5930.140129681194;5935.228420305354;5948.494377977877;5670.06443936754;5707.486326230618;5833.824985250428;5915.940840591582;5921.052631578927;5687.0900655895275;5784.971075144639;5814.156947242626;5831.650100993954;5867.794627188071;5768.711564421804;5771.740271687784;5843.9707801461145;5844.1818145459665;5845.386234445365;6171.074338849208;6201.131841542187;6201.937980620181;6228.346023667495;6243.937560624381;6696.06255124283;6696.397324240842;6702.966485167592;6703.162104736908;6712.160979877515;6733.865322693568;6770.424513916323;6855.4172895303955;6909.585424874524;6930.584164950069;6248.343923887972;6311.305756366796;6374.362563743635;6381.361863813628;6424.903626445607;6981.162260528769;6986.9650651746415;7029.61337126463;7092.822679432952;7109.502334836512;6722.462203023844;6747.392734653905;6792.150981127359;6802.387785099266;6822.283660215705;6814.114165158498;6885.793426197222;6919.446444284546;6919.861602767916;6921.134858142732;6775.22084960226;6783.321667833177;6797.830054248683;6887.483438742114;6900.551464154814;6643.966780166068;6767.052612634235;6811.2167100784045;6926.030355750199;6928.480363972722;5405.135178371442;5418.539424148913;5423.376311724123;5433.510984011458;5438.45615438453;4585.495595484494;4726.1020406122725;4757.857264282077;4771.355866957986;4800.759962001886;5839.211706419579;5855.355910849803;5913.733881975321;5923.881522369528;5931.051031834886;6707.295733947963;6731.798046058626;6741.325867413219;6805.489588280899;6935.375816176568;5767.077267637158;5778.162166485836;5859.355470898197;5866.67733274674;5877.853053673607;5805.535557155502;5925.496332811673;5949.672767997802;5972.880542389128;5974.880502389928;6564.770233041916;6569.80290591283;6644.368784965421;6659.86680266392;6664.033715111379;6589.47284217271;6728.226253980855;6771.661416929035;6844.623545704934;6887.414569761627;6521.250056243403;6521.836954075996;6528.281888992302;6556.377144171296;6644.069830223676;6737.056812046219;6762.49281303914;6819.2498825128205;6833.624150671562;6853.828654283483;6838.042674025541;6838.829029274308;6843.7604683835825;6936.653167341512;6941.409980151541;6456.709448074942;6536.738530458729;6591.077249185022;6667.599944003376;6683;6591.769288074895;6654.401103900672;6677.265500795006;6686.465082793267;6687.398134167948;6570.704318305783;6571.835704107436;6572.572782769104;6670.232923213893;6670.9332906670315;6514.3811337922825;6651.534392592472;6698.966505167443;6748.69630866622;6788.796336109925;6372.87254254903;6380.266269378895;6388.87222255543;6394.5523813334485;6401.135846660642 17:42:03 INFO - PID 6957 | |1;ext.html;816.9836603267935;885.7652722028663;911.4531281231262;917.9311551633629;1143.4454289669504;29262.999999999975;29695.406091878176;39168.60831391689;39895;39933.60066399343;39998;40558.59441405585;40643.18713625726;40652.59347406525;40789.59210407903;7702.6533805978725;7712.267334603203;7865.331446827026;7866.724664636738;7921.683132674686;7670.27132422419;7765.728199513018;7769.689212431496;7770.728024519143;7777.494462859896;7761;7805.5706936118495;7820.45256832022;7821;7828.725994590191;7762.922370776277;7764.145943946161;7784.494007889497;7794.2205779422175;7794.493357931717;7655.693772249103;7766.456348055638;7771.455998080137;7772.65023073963;7783.377329813601;36347.4547881782;36466.27067458636;36485.63514364849;36564.268714625825;36737.81631091854;3475.5308033415417;3512.6487351264923;3515.753897227195;3516.4022116240044;3518.489818976234;29982.55026174609;30067.849660751555;30143.397132057235;30191.547126793117;30196;5131.666441681279;5151.356080489939;5198.636095473318;5204.34945631796;5205.27126202332;180402;181433;182121;182643;182795;46713.766431168304;46958;46983;47083.764581176874;47125;51434.48565514372;52779.73610131925;52963;53111;53331.73334133304;15816.209189540707;15851.603709907344;15938.60153496172;15941.44204952821;15957.04257744539;10610.257281990342;10738.892611073945;10761.730956725987;12417.875821241672;12593.055520835975;14137.929310353587;14149.221792801289;14166.929165354108;14213.43146274158;14294.142351458946;5583.832485025456;5635.323761148688;5721.170430287585;5800.796972105956;5885;986.6004268271362;1012.6000229909145;1024.7847951930178;1029.2383636109375;1037.2583602723937;22179.66730499044;22278.665820012713;22315;22392.992315345848;22636.434089147904;1120.7030137013699;1131.9830202546968;1134.3420815926743;1139.9259048161844;1149.1151813103863;11927.463264153133;11942.462589183508;11967.820482692767;12035.578754743541;12207.938960305142;226639;229364;229648;229674;230879;49053.26420103701;49331.50668493341;49441.50558494369;49698.254526182136;49747;1439.8344190418027;1459.8905082118883;1460.839307676176;1469.0744830756555;1474.8598883106088;21609.243676471247;21884.562308754055;21992.89003554972;22023.559528809015;22207.1117155312;35661.28677426489;35723.28553428969;35744.82127589345;35778.64221357753;35781.28437431289;182871;185278;185429;185589;185631;29560.408791824473;30113.548296776004;30190.245243869078;32745;33363;40047;40149.799251003555;40320.798396009006;40940.59059409368;41097;29895;29902.850485747433;29927.55108673328;29956.400871982;30203;29833.850830746575;29843.552346714383;30239.244018899702;30505.389892202475;31100.22249443782;34105.65894341124;34228.315433691685;34230.82884585661;34282.314353713286;34295.14262143367;28602.284942876595;28967.986120485682;29307.26731831636;29363.265918352212;30392.392152157274;22034.669479957494;22274.109035638394;22351;22461.43846403853;22489.32532024042 17:42:03 INFO - PID 6957 | |2;jquery.html;563.1805722673511;573.3148887079941;578.9768409263627;588.6468119128523;588.7792077970762;21266.25568105115;21903.342899712996;21966.890165549168;22024.779752202474;22034.11863525461;22130;23523.882380588115;23605.64591531124;23892.402689932762;23996.1601343953;6417.871642567135;6524.641144737037;6567.6059436433725;6574.14536110305;6596.109525214107;6425.678716064202;6534.379233972765;6538.150040494729;6541.345865413468;6544.247411547685;5969;6200.81397558074;6246.875062498747;6249.468795152395;6489.156409666737;6219.067139929024;6281.87436251277;6284.402981716729;6284.7486100555925;6287.276963149251;5863.208466856962;5882.088276317178;6398.616083034986;6649.468042556584;6709.597424154566;28673.28316792076;28922.566161507595;29283.121506354844;29506.409871802443;29550.40899182026;2063.432556047099;2081.6253074446595;2083.6874468829647;2091.069474084033;2098.5278312379746;19224.90387548067;19722.70415943762;20003.799962000485;20015.79984200154;20066.89966550158;2431.124795073772;2441.9743707642833;2477.36827109086;2545.643609894616;2546.5543529882198;117498.41250793777;124979;139072;146744;146875.26562367225;19300.32448864283;19920.561564787407;19955;20491.28280510175;20711.378658640264;39801.40297895534;39803.40294895579;39804.20391592152;39824.40263396051;39860.20978531533;10935.398553079498;11115.333080015225;11304.30871188464;11309.660710178709;11361.545538178545;9306.53467326631;9504.382215155993;9512.90487095134;9543.379680320757;9569.138777510057;10597.735056623646;10739.194560408001;10742;10907.945460272807;11146.832797508045;3509.701675357572;3667.8349474273186;3698;4063.553009168989;4241.957580424218;945.8723072385278;976.6386437018349;979.2851218610311;981.3915372469115;985.6353149334792;18065;18384.264629414673;18466.169022394024;18469;18842;1002.774375765447;1031.654395777408;1040.095117247984;1041.5052849896238;1048.3447845096814;10048.547815348327;10271.640492582725;10360.171186305077;10414.791704165875;10467.476626168662;455075;458859;468735;470257;470595;106050.46974765077;108416.45791771148;108804.45597771961;109125.45437272763;109305;1011.3830563356347;1100.9229353945148;1139.6125317392127;1150.9366984815747;1177.0583533173426;19081.809181908004;19099.236030558623;19266;19448.70826937569;19671.508212294808;51132.74433627957;52343.738281309874;53049.73475132754;53321;53371.19943200777;62359.37640623717;63403.0489542648;63908.680456597416;64446.67776661087;64477.35522644714;17452.82547174512;18257.726134107732;19125.330613428465;19150.425487235407;19164.520886977938;21335.46661333479;21388;21410.678839817105;21593.35219943404;21637.891810541478;17392.130393480023;17406.0426676534;17450.563735906704;17695.292188312324;17756.822431775516;15551;15677.372905083668;15912.92043539775;15973.281202346156;16092.758608621114;17751.64496710033;17920.641587168444;17958.91020544889;17989.820101799338;18137.637247255247;17586;18246.817531825043;18581.72127418063;18653.253869845597;18661.626767464848;17111;17482.30070797205;17594.64810703753;17595.56011099733;17785.377511787025 17:42:03 INFO - PID 6957 | |3;mootools.html;1299.9415026323816;1348.5077946549507;1368.117564171109;1371.7462269480147;1374.7731624281996;14997.92501037496;15504.224788760559;15704.685906281868;15710.371585136581;15711.135887526181;15479.14864682442;15576.688466230697;15605.219739013033;15620.921895390507;15627.609309767262;2713.81003329767;2726.481968425993;2763.46112508061;2778.097118436506;2780.5968134620466;2751.1058905855575;2792.0925699147756;2802.9439411211765;2804.0466241477893;2814.408974115438;2718.143784707811;2808.0452646100425;2838.9858050709718;2839.0489186122672;2839.8154119982137;2771.1409463066516;2793.1201671473523;2822.6612806463254;2824.3362809739797;2825.434913017384;2634.0780726745484;2709.91870243893;2716.9320766980786;2719.225020869043;2730.6723193216744;15204.16377099259;15287.923560382127;15317.923410382988;15328.310226039855;15364.231788410534;8035.437519373646;8258.958705206496;8320.625571849281;8320.916790832074;8345.207205315486;5437.463242017005;5557.527610153102;5660.745266463019;5736.196932429463;5768.596198266081;1937.4381429385462;1966.3314473079079;1975.3580086471954;2012.7584689837167;2018.7880272571463;26785.33036674099;27013.324666883287;27026;27027.72972270272;27038.32404189891;6634.23706273775;6830.21452532965;6865.5537390069485;7019.789406317818;7079.1858936223;17462.65074698499;17608.471745847644;17618.383356582715;17618.559536011704;17642.1178941055;7978.082520510099;8094.51432914027;8200.58997050145;8548.572571371407;8578.270846977952;7517.060367454068;7517.699292028367;7656.885146722803;7668.846623067619;7670.232976702285;5259;5406.83779486616;5419.972900135474;5426.701531415731;5433.6196466247775;1560.2744723703531;1568.8352722964153;1569.3330334607747;1588.7537431698106;1590.6262028423312;888.3825741109996;908.2143945487106;908.8046070094962;916.3127654259306;925.8657494663236;7769.689212431553;7789.3768498519985;7797.571133587594;7812.257835505618;7854.253845884632;717.824133087397;720.1646090534954;721.3976329764705;727.5380133615087;731.352752813753;4582.633389328846;5202.375714914235;5463.808766693147;5501.2121060655445;5677.233573467529;20962.790372096082;21616.35150945474;21990.45023874384;22163.77836221617;22295.665565016538;21928.671069933964;22233.888830555745;22270.888645556668;22318.107275709113;22379.328620141096;10685.732856678645;10801.83797243042;10993.725156871142;11043.944780276208;11163.665090047312;8308.916910830814;8441.66233350659;8453.746387608382;8503.362247831314;8583.442076265022;18785.34251301198;19229.90385048066;19262.903685482044;19420.70868936939;19619.70570441416;19225.423237302904;19659.41021769349;19848;20375.592488149858;20422.897885510476;11275.887241127484;11522.711932201762;11523.078153747512;11535.711607209887;11548.711282218012;13942.4423023082;14066.367013484622;14207.857921420653;14210.218437985597;14226.644333891736;11459.885401145882;11490.827637585277;11586.246893952204;11704.824427633763;11815.763684726086;11127.332360058423;11378.260413073123;11495.942520287344;11607.593734219261;11729.35488548104;9751.414915105117;9792.902070979198;9855.35940163887;9929.851052234368;9930.106290433896;6567.835804104744;6599.175103112111;6643.435307998681;6736.5958042517605;6790.049393084873;6951.478639101986;7120.643967801486;7156.248593897566;7164.247753985965;7220.927790722026 17:42:03 INFO - PID 6957 | |4;prototype.html;494.72789965518933;519.7063659032648;529.8463445600776;531.0785786660144;536.1823219590125;6375.203099612549;6433.841908456476;6439.388258115471;6453.580517266386;6465.806025819221;6351.3966173213585;6352.82472742543;6370.458511026568;6407.647579383144;6424.453921416685;5268.288781014562;5299.920501192485;5300.814471493499;5309.354100228922;5309.601779866506;4882.681675947492;5220.712860792655;5242.292290540785;5250.553702935255;5288.127458969285;4999.350084489011;5000.849974500771;5018.498150184989;5037.798488060474;5054.41874184468;5033.245013248005;5050.393952725696;5053.949460505385;5055.191169412895;5055.761338472061;4379.189849877751;4470.642348612103;4538.546145385468;4555.838261243395;4568.451785785727;6034.668093254869;6063.302720187191;6130.946133045435;6151.446369826737;6184.412480814315;5704.372519022904;5738.454846789548;5785.103308987113;5792.131180322943;5797.217375654275;6411.647359395231;6541.542092053558;6620.172478440195;6649.634270115142;6671.766488172939;4932.309476673268;4940.011997600458;4960.206366981266;4985.601151907875;4987.526185012418;6635.568688035262;6726;6752.2234942981695;6876.69054892526;6894.689738961759;5077.796888124433;5095;5098.037255656599;5102.795888164506;5120.769565369567;5097.719625420564;5117.181250999822;5129.256257842592;5150.356205474316;5181.222816577543;5728.198052272685;5750.88498230033;5759.3061654751245;5810.912836307459;5824.737886795019;6655.700493477805;6664.333566643394;6682.699278532477;6713.985804258703;6728.3271672832325;1785.259117466263;1786.8302511261409;1789.3895494055455;1791.6864548703925;1804.3414153833755;1170.3796987596588;1213.538855235005;1228.2569045727384;1240.4232032104935;1249.4752204074312;5646.378898321182;5683.914741278884;5699.518125287373;5735.541156707453;5761;6714.764983225564;6732.663366831639;6766.357196066366;6777.695003724844;6788.151481064867;5650.491455768918;5656.236408084938;5707.571932105026;5739.311282646109;5794.101914203306;3509.4560343146854;3546.5744110706883;3550.2721942001826;3561.216532362876;3577.749557531;6391.808245752542;6394.168758061515;6423.389777971085;6441.227052753699;6509.967450162719;6357.205349331333;6772.8984065239065;6858.622775747282;6911.5853048817235;6963.234044255128;6311.495080393649;6315.400036996478;6321.3678632137335;6361.586496877688;6521.7065232065615;6539.509536784665;6625.801225963229;6687.431568316748;6723.4285085766305;6739.5619284746335;6531.563056127644;6665.267450227888;6669.599824010575;6724.193096828412;6760.18877734675;6352.6506042166275;6374.171357723466;6432.163818703539;6446.290908000023;6456.644884531396;4981.252812078217;5022.522860328263;5024.472430394756;5043.773030213576;5092.134337162765;6317.399847014526;6615.867682646416;6634.402903738686;6683.933160668331;6695.631740254333;6433.517486188461;6458.38645328693;6497.610143391412;6586.1438013059915;6597.3072827352435;6461.515386345949;6546.738130474728;6547.476201903932;6550.7707230246715;6581.440577550962;6433.105102703708;6464.967675161783;6483.281930288572;6494;6571.112899758471;6601.53789234749;6675.7329706813125;6704.966475167593;6719.932800671931;6730.394264516217;6315.0742420911765;6377.808665740035;6409.9679501602195;6439.846299137124;6485.513586481127 17:42:03 INFO - PID 6957 | |5;yui.html;907.9001309855917;909.4179724976012;930.1628534319112;931.9767005824849;941.2987324443286;19478.123484443215;19979.400617981482;20192.798072019275;20193.39419817406;20228.59542809143;18127.274909003623;18160;18220.635587288245;19496.317628882993;19613.705794413094;978.144123891593;1001.0840081325579;1004.397361583048;1007.1288335589735;1007.2445665750687;941.4351389166513;980.872486576744;985.4235272365675;987.1559816357019;992.5285489392517;1031.520343040486;1031.582209205273;1031.9535620897077;1032.1330082730506;1038.2057725839738;995.2784231432154;1022.6931920423917;1025.5948900184424;1026.4098143567403;1036.461040259065;738.3133685672323;754.3474894216519;756.4855897989365;756.8259300360893;757.1860250231024;20017.29939452127;20261.392158235278;20300.5939881203;20365.389038328874;20373.08321125553;21520.246791362228;21656;22069.448263793372;22203.22288719887;22259.109635614557;17287.827121728747;17567.64864702699;17737.29050837965;17874.374396896048;17898.194581243875;3737.831797569116;3807;3815.5802861685193;3816;3818.3317919364;140810.29594852164;140823;141466;143669;143688;16872.493825185265;16970.660586788195;17105.486835394957;17132.914335428493;17164.31342746301;31817.52273715896;31858.681413186034;31878.521822172686;31965;32115.67884321127;8719.65121395137;8773.42972706772;8779.385443019055;8795.51624660637;8821.117888211127;4314.439122914001;4523.977380113144;4557.02024064821;4558.931616025762;4559.908801823945;5448.210009548672;5553.750081246354;5573.442655734394;5593.972030139905;5599.216109744639;924.5746956400131;956.2780101023683;963.5182408795603;965.5220665770348;983.0513554420019;665.2216906219735;687.2611942162096;688.9379955803902;708.6138054760169;713.3829237709344;11454.656360309204;11639.883601164049;11799.053156229125;11951.984081353183;12143.939280303719;676.1750664189681;683.5420268420171;689.5070024932197;690.2407351912956;691.6368906324119;5635.746391412396;5764.221830052889;5867.677277749679;5949.851253718605;5954.672493012839;118620;118675.40662296633;118880.40559797146;120708;124171;101072.49463752634;104894;108257.45871270593;108389;109655;90404.54797725838;91158.54420727854;92437;95188;96267.51866240765;12841.101122921305;13377.53178638743;13442.93278533601;13525.053246272666;13651.79522307186;41760.58239417567;41802.79098604488;42135;42577.361339579315;42737.14525709406;55380.72309638426;55749.44250557605;56399.71800140973;56882.7155864218;57174.7141264291;18652.067396629842;18874.339398121;18889.90555047216;18913.810861891754;18989.810101898805;19932.70100948458;20086.09612567409;20189.293374731813;20203;20348;19280.132394042583;19623.509412264808;19674.11466483983;19686.704699429807;19817;16939.407120750715;16947.81365304417;17136.742948856026;17304.307827687255;17398.913005434893;18909.810901891356;19096.80903191006;19295.324663636704;19301.517462063563;19661;13526.797098043735;13562.457501699822;13605.931970340085;13657.453701852211;13841.515546955809;13831.861681383058;14041.648958776112;14117.647058823612;14176;14262.358193881508 17:42:03 INFO - PID 6957 | __end_tp_report 17:42:03 INFO - PID 6957 | __start_cc_report 17:42:03 INFO - PID 6957 | _x_x_mozilla_cycle_collect,290 17:42:03 INFO - PID 6957 | __end_cc_report 17:42:03 INFO - PID 6957 | __startTimestamp1506386523753__endTimestamp 17:42:03 INFO - PID 6957 | 17:42:03 INFO - PID 6957 | ------- Summary: start ------- 17:42:03 INFO - PID 6957 | Number of tests: 6 17:42:03 INFO - PID 6957 | 17:42:03 INFO - PID 6957 | [#0] dojo.html Cycles:165 Average:6258.32 Median:6521.25 stddev:751.82 (11.5%) stddev-sans-first:713.29 17:42:03 INFO - PID 6957 | Values: 3142.7 3171.8 3177.3 3179.4 3182.4 6191.8 6318.7 6332.2 6345.8 6399.2 6257.0 6308.3 6319.4 6321.6 6361.6 5762.5 5779.5 5786.3 5835.8 5907.2 5844.6 5857.9 5930.1 5935.2 5948.5 5670.1 5707.5 5833.8 5915.9 5921.1 5687.1 5785.0 5814.2 5831.7 5867.8 5768.7 5771.7 5844.0 5844.2 5845.4 6171.1 6201.1 6201.9 6228.3 6243.9 6696.1 6696.4 6703.0 6703.2 6712.2 6733.9 6770.4 6855.4 6909.6 6930.6 6248.3 6311.3 6374.4 6381.4 6424.9 6981.2 6987.0 7029.6 7092.8 7109.5 6722.5 6747.4 6792.2 6802.4 6822.3 6814.1 6885.8 6919.4 6919.9 6921.1 6775.2 6783.3 6797.8 6887.5 6900.6 6644.0 6767.1 6811.2 6926.0 6928.5 5405.1 5418.5 5423.4 5433.5 5438.5 4585.5 4726.1 4757.9 4771.4 4800.8 5839.2 5855.4 5913.7 5923.9 5931.1 6707.3 6731.8 6741.3 6805.5 6935.4 5767.1 5778.2 5859.4 5866.7 5877.9 5805.5 5925.5 5949.7 5972.9 5974.9 6564.8 6569.8 6644.4 6659.9 6664.0 6589.5 6728.2 6771.7 6844.6 6887.4 6521.3 6521.8 6528.3 6556.4 6644.1 6737.1 6762.5 6819.2 6833.6 6853.8 6838.0 6838.8 6843.8 6936.7 6941.4 6456.7 6536.7 6591.1 6667.6 6683.0 6591.8 6654.4 6677.3 6686.5 6687.4 6570.7 6571.8 6572.6 6670.2 6670.9 6514.4 6651.5 6699.0 6748.7 6788.8 6372.9 6380.3 6388.9 6394.6 6401.1 17:42:03 INFO - PID 6957 | 17:42:03 INFO - PID 6957 | [#1] ext.html Cycles:180 Average:36035.79 Median:33054.00 stddev:51793.78 (156.7%) stddev-sans-first:51871.57 17:42:03 INFO - PID 6957 | Values: 817.0 885.8 911.5 917.9 1143.4 29263.0 29695.4 39168.6 39895.0 39933.6 39998.0 40558.6 40643.2 40652.6 40789.6 7702.7 7712.3 7865.3 7866.7 7921.7 7670.3 7765.7 7769.7 7770.7 7777.5 7761.0 7805.6 7820.5 7821.0 7828.7 7762.9 7764.1 7784.5 7794.2 7794.5 7655.7 7766.5 7771.5 7772.7 7783.4 36347.5 36466.3 36485.6 36564.3 36737.8 3475.5 3512.6 3515.8 3516.4 3518.5 29982.6 30067.8 30143.4 30191.5 30196.0 5131.7 5151.4 5198.6 5204.3 5205.3 180402.0 181433.0 182121.0 182643.0 182795.0 46713.8 46958.0 46983.0 47083.8 47125.0 51434.5 52779.7 52963.0 53111.0 53331.7 15816.2 15851.6 15938.6 15941.4 15957.0 10610.3 10738.9 10761.7 12417.9 12593.1 14137.9 14149.2 14166.9 14213.4 14294.1 5583.8 5635.3 5721.2 5800.8 5885.0 986.6 1012.6 1024.8 1029.2 1037.3 22179.7 22278.7 22315.0 22393.0 22636.4 1120.7 1132.0 1134.3 1139.9 1149.1 11927.5 11942.5 11967.8 12035.6 12207.9 226639.0 229364.0 229648.0 229674.0 230879.0 49053.3 49331.5 49441.5 49698.3 49747.0 1439.8 1459.9 1460.8 1469.1 1474.9 21609.2 21884.6 21992.9 22023.6 22207.1 35661.3 35723.3 35744.8 35778.6 35781.3 182871.0 185278.0 185429.0 185589.0 185631.0 29560.4 30113.5 30190.2 32745.0 33363.0 40047.0 40149.8 40320.8 40940.6 41097.0 29895.0 29902.9 29927.6 29956.4 30203.0 29833.9 29843.6 30239.2 30505.4 31100.2 34105.7 34228.3 34230.8 34282.3 34295.1 28602.3 28968.0 29307.3 29363.3 30392.4 22034.7 22274.1 22351.0 22461.4 22489.3 17:42:03 INFO - PID 6957 | 17:42:03 INFO - PID 6957 | [#2] jquery.html Cycles:180 Average:34151.40 Median:21300.86 stddev:78200.46 (367.1%) stddev-sans-first:78379.17 17:42:03 INFO - PID 6957 | Values: 563.2 573.3 579.0 588.6 588.8 21266.3 21903.3 21966.9 22024.8 22034.1 22130.0 23523.9 23605.6 23892.4 23996.2 6417.9 6524.6 6567.6 6574.1 6596.1 6425.7 6534.4 6538.2 6541.3 6544.2 5969.0 6200.8 6246.9 6249.5 6489.2 6219.1 6281.9 6284.4 6284.7 6287.3 5863.2 5882.1 6398.6 6649.5 6709.6 28673.3 28922.6 29283.1 29506.4 29550.4 2063.4 2081.6 2083.7 2091.1 2098.5 19224.9 19722.7 20003.8 20015.8 20066.9 2431.1 2442.0 2477.4 2545.6 2546.6 117498.4 124979.0 139072.0 146744.0 146875.3 19300.3 19920.6 19955.0 20491.3 20711.4 39801.4 39803.4 39804.2 39824.4 39860.2 10935.4 11115.3 11304.3 11309.7 11361.5 9306.5 9504.4 9512.9 9543.4 9569.1 10597.7 10739.2 10742.0 10907.9 11146.8 3509.7 3667.8 3698.0 4063.6 4242.0 945.9 976.6 979.3 981.4 985.6 18065.0 18384.3 18466.2 18469.0 18842.0 1002.8 1031.7 1040.1 1041.5 1048.3 10048.5 10271.6 10360.2 10414.8 10467.5 455075.0 458859.0 468735.0 470257.0 470595.0 106050.5 108416.5 108804.5 109125.5 109305.0 1011.4 1100.9 1139.6 1150.9 1177.1 19081.8 19099.2 19266.0 19448.7 19671.5 51132.7 52343.7 53049.7 53321.0 53371.2 62359.4 63403.0 63908.7 64446.7 64477.4 17452.8 18257.7 19125.3 19150.4 19164.5 21335.5 21388.0 21410.7 21593.4 21637.9 17392.1 17406.0 17450.6 17695.3 17756.8 15551.0 15677.4 15912.9 15973.3 16092.8 17751.6 17920.6 17958.9 17989.8 18137.6 17586.0 18246.8 18581.7 18653.3 18661.6 17111.0 17482.3 17594.6 17595.6 17785.4 17:42:03 INFO - PID 6957 | 17:42:03 INFO - PID 6957 | [#3] mootools.html Cycles:180 Average:9484.84 Median:2722.85 stddev:6840.83 (251.2%) stddev-sans-first:6832.38 17:42:03 INFO - PID 6957 | Values: 1299.9 1348.5 1368.1 1371.7 1374.8 14997.9 15504.2 15704.7 15710.4 15711.1 15479.1 15576.7 15605.2 15620.9 15627.6 2713.8 2726.5 2763.5 2778.1 2780.6 2751.1 2792.1 2802.9 2804.0 2814.4 2718.1 2808.0 2839.0 2839.0 2839.8 2771.1 2793.1 2822.7 2824.3 2825.4 2634.1 2709.9 2716.9 2719.2 2730.7 15204.2 15287.9 15317.9 15328.3 15364.2 8035.4 8259.0 8320.6 8320.9 8345.2 5437.5 5557.5 5660.7 5736.2 5768.6 1937.4 1966.3 1975.4 2012.8 2018.8 26785.3 27013.3 27026.0 27027.7 27038.3 6634.2 6830.2 6865.6 7019.8 7079.2 17462.7 17608.5 17618.4 17618.6 17642.1 7978.1 8094.5 8200.6 8548.6 8578.3 7517.1 7517.7 7656.9 7668.8 7670.2 5259.0 5406.8 5420.0 5426.7 5433.6 1560.3 1568.8 1569.3 1588.8 1590.6 888.4 908.2 908.8 916.3 925.9 7769.7 7789.4 7797.6 7812.3 7854.3 717.8 720.2 721.4 727.5 731.4 4582.6 5202.4 5463.8 5501.2 5677.2 20962.8 21616.4 21990.5 22163.8 22295.7 21928.7 22233.9 22270.9 22318.1 22379.3 10685.7 10801.8 10993.7 11043.9 11163.7 8308.9 8441.7 8453.7 8503.4 8583.4 18785.3 19229.9 19262.9 19420.7 19619.7 19225.4 19659.4 19848.0 20375.6 20422.9 11275.9 11522.7 11523.1 11535.7 11548.7 13942.4 14066.4 14207.9 14210.2 14226.6 11459.9 11490.8 11586.2 11704.8 11815.8 11127.3 11378.3 11495.9 11607.6 11729.4 9751.4 9792.9 9855.4 9929.9 9930.1 6567.8 6599.2 6643.4 6736.6 6790.0 6951.5 7120.6 7156.2 7164.2 7220.9 17:42:03 INFO - PID 6957 | 17:42:03 INFO - PID 6957 | [#4] prototype.html Cycles:180 Average:5543.94 Median:6313.28 stddev:1535.94 (24.3%) stddev-sans-first:1492.76 17:42:03 INFO - PID 6957 | Values: 494.7 519.7 529.8 531.1 536.2 6375.2 6433.8 6439.4 6453.6 6465.8 6351.4 6352.8 6370.5 6407.6 6424.5 5268.3 5299.9 5300.8 5309.4 5309.6 4882.7 5220.7 5242.3 5250.6 5288.1 4999.4 5000.8 5018.5 5037.8 5054.4 5033.2 5050.4 5053.9 5055.2 5055.8 4379.2 4470.6 4538.5 4555.8 4568.5 6034.7 6063.3 6130.9 6151.4 6184.4 5704.4 5738.5 5785.1 5792.1 5797.2 6411.6 6541.5 6620.2 6649.6 6671.8 4932.3 4940.0 4960.2 4985.6 4987.5 6635.6 6726.0 6752.2 6876.7 6894.7 5077.8 5095.0 5098.0 5102.8 5120.8 5097.7 5117.2 5129.3 5150.4 5181.2 5728.2 5750.9 5759.3 5810.9 5824.7 6655.7 6664.3 6682.7 6714.0 6728.3 1785.3 1786.8 1789.4 1791.7 1804.3 1170.4 1213.5 1228.3 1240.4 1249.5 5646.4 5683.9 5699.5 5735.5 5761.0 6714.8 6732.7 6766.4 6777.7 6788.2 5650.5 5656.2 5707.6 5739.3 5794.1 3509.5 3546.6 3550.3 3561.2 3577.7 6391.8 6394.2 6423.4 6441.2 6510.0 6357.2 6772.9 6858.6 6911.6 6963.2 6311.5 6315.4 6321.4 6361.6 6521.7 6539.5 6625.8 6687.4 6723.4 6739.6 6531.6 6665.3 6669.6 6724.2 6760.2 6352.7 6374.2 6432.2 6446.3 6456.6 4981.3 5022.5 5024.5 5043.8 5092.1 6317.4 6615.9 6634.4 6683.9 6695.6 6433.5 6458.4 6497.6 6586.1 6597.3 6461.5 6546.7 6547.5 6550.8 6581.4 6433.1 6465.0 6483.3 6494.0 6571.1 6601.5 6675.7 6705.0 6719.9 6730.4 6315.1 6377.8 6410.0 6439.8 6485.5 17:42:03 INFO - PID 6957 | 17:42:03 INFO - PID 6957 | [#5] yui.html Cycles:180 Average:24788.72 Median:20198.20 stddev:34840.59 (172.5%) stddev-sans-first:34892.19 17:42:03 INFO - PID 6957 | Values: 907.9 909.4 930.2 932.0 941.3 19478.1 19979.4 20192.8 20193.4 20228.6 18127.3 18160.0 18220.6 19496.3 19613.7 978.1 1001.1 1004.4 1007.1 1007.2 941.4 980.9 985.4 987.2 992.5 1031.5 1031.6 1032.0 1032.1 1038.2 995.3 1022.7 1025.6 1026.4 1036.5 738.3 754.3 756.5 756.8 757.2 20017.3 20261.4 20300.6 20365.4 20373.1 21520.2 21656.0 22069.4 22203.2 22259.1 17287.8 17567.6 17737.3 17874.4 17898.2 3737.8 3807.0 3815.6 3816.0 3818.3 140810.3 140823.0 141466.0 143669.0 143688.0 16872.5 16970.7 17105.5 17132.9 17164.3 31817.5 31858.7 31878.5 31965.0 32115.7 8719.7 8773.4 8779.4 8795.5 8821.1 4314.4 4524.0 4557.0 4558.9 4559.9 5448.2 5553.8 5573.4 5594.0 5599.2 924.6 956.3 963.5 965.5 983.1 665.2 687.3 688.9 708.6 713.4 11454.7 11639.9 11799.1 11952.0 12143.9 676.2 683.5 689.5 690.2 691.6 5635.7 5764.2 5867.7 5949.9 5954.7 118620.0 118675.4 118880.4 120708.0 124171.0 101072.5 104894.0 108257.5 108389.0 109655.0 90404.5 91158.5 92437.0 95188.0 96267.5 12841.1 13377.5 13442.9 13525.1 13651.8 41760.6 41802.8 42135.0 42577.4 42737.1 55380.7 55749.4 56399.7 56882.7 57174.7 18652.1 18874.3 18889.9 18913.8 18989.8 19932.7 20086.1 20189.3 20203.0 20348.0 19280.1 19623.5 19674.1 19686.7 19817.0 16939.4 16947.8 17136.7 17304.3 17398.9 18909.8 19096.8 19295.3 19301.5 19661.0 13526.8 13562.5 13605.9 13657.5 13841.5 13831.9 14041.6 14117.6 14176.0 14262.4 17:42:03 INFO - PID 6957 | -------- Summary: end -------- 17:42:03 INFO - PID 6957 | 17:42:04 INFO - TEST-INFO | 6957: exit 0 17:42:04 INFO - TEST-OK | dromaeo_css | took 1108815ms 17:42:04 INFO - TEST-START | kraken 17:42:04 INFO - Initialising browser for kraken test... 17:42:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39052/getInfo.html -profile /tmp/tmpdFhr15/profile 17:42:04 INFO - TEST-INFO | started process 7323 (/builds/slave/test/build/application/firefox/firefox http://localhost:39052/getInfo.html) 17:42:10 INFO - TEST-INFO | 7323: exit 0 17:42:10 INFO - Browser initialized. 17:42:10 INFO - Running cycle 1/1 for kraken test... 17:42:10 INFO - Using env: {'DISPLAY': ':0', 17:42:10 INFO - 'HOME': '/home/cltbld', 17:42:10 INFO - 'JSGC_DISABLE_POISONING': '1', 17:42:10 INFO - 'LANG': 'en_US.UTF-8', 17:42:10 INFO - 'LANGUAGE': 'en_US:en', 17:42:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:42:10 INFO - 'LOGNAME': 'cltbld', 17:42:10 INFO - 'MAIL': '/var/mail/cltbld', 17:42:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:42:10 INFO - 'MOZ_CRASHREPORTER': '1', 17:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:42:10 INFO - 'MOZ_NO_REMOTE': '1', 17:42:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:10 INFO - 'NO_EM_RESTART': '1', 17:42:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:10 INFO - 'PWD': '/builds/slave/test', 17:42:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:10 INFO - 'RUST_BACKTRACE': 'full', 17:42:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:42:10 INFO - 'SHELL': '/bin/bash', 17:42:10 INFO - 'SHLVL': '1', 17:42:10 INFO - 'STYLO_FORCE_DISABLED': '1', 17:42:10 INFO - 'TERM': 'linux', 17:42:10 INFO - 'TMOUT': '86400', 17:42:10 INFO - 'USER': 'cltbld', 17:42:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887', 17:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:10 INFO - '_': '/tools/buildbot/bin/python'} 17:42:10 INFO - TEST-INFO | started process 7561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdFhr15/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:11 INFO - PID 7561 | 17:42:11 INFO - PID 7561 | (/builds/slave/test/build/application/firefox/firefox:7610): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:42:11 INFO - PID 7561 | 17:42:21 INFO - PID 7561 | RSS: Main: 151732224 17:42:21 INFO - PID 7561 | 17:42:24 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39052/tests/kraken/driver.html?testName=audio-beat-detection) 17:42:25 INFO - PID 7561 | RSS: Main: 157462528 17:42:25 INFO - PID 7561 | 17:42:27 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39052/tests/kraken/driver.html?testName=audio-dft) 17:42:28 INFO - PID 7561 | RSS: Main: 157855744 17:42:28 INFO - PID 7561 | 17:42:31 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39052/tests/kraken/driver.html?testName=audio-fft) 17:42:32 INFO - PID 7561 | RSS: Main: 154992640 17:42:32 INFO - PID 7561 | 17:42:34 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39052/tests/kraken/driver.html?testName=audio-oscillator) 17:42:34 INFO - PID 7561 | RSS: Main: 155193344 17:42:34 INFO - PID 7561 | 17:42:36 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39052/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:42:37 INFO - PID 7561 | RSS: Main: 155373568 17:42:37 INFO - PID 7561 | 17:42:40 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39052/tests/kraken/driver.html?testName=imaging-darkroom) 17:42:41 INFO - PID 7561 | RSS: Main: 157798400 17:42:41 INFO - PID 7561 | 17:42:44 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39052/tests/kraken/driver.html?testName=imaging-desaturate) 17:42:45 INFO - PID 7561 | RSS: Main: 158126080 17:42:45 INFO - PID 7561 | 17:42:48 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39052/tests/kraken/driver.html?testName=json-parse-financial) 17:42:49 INFO - PID 7561 | RSS: Main: 158093312 17:42:49 INFO - PID 7561 | 17:42:50 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39052/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:42:51 INFO - PID 7561 | RSS: Main: 158265344 17:42:51 INFO - PID 7561 | 17:42:52 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39052/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:42:53 INFO - PID 7561 | RSS: Main: 158081024 17:42:53 INFO - PID 7561 | 17:42:55 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39052/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:42:56 INFO - PID 7561 | RSS: Main: 155099136 17:42:56 INFO - PID 7561 | 17:42:58 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:42:59 INFO - PID 7561 | RSS: Main: 155459584 17:42:59 INFO - PID 7561 | 17:43:02 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:43:03 INFO - PID 7561 | RSS: Main: 155611136 17:43:03 INFO - PID 7561 | 17:43:04 INFO - PID 7561 | Cycle 1(1): loaded http://localhost:39052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39052/tests/kraken/driver.html?testName=ai-astar) 17:43:05 INFO - PID 7561 | RSS: Main: 157106176 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | __start_tp_report 17:43:05 INFO - PID 7561 | _x_x_mozilla_page_load 17:43:05 INFO - PID 7561 | _x_x_mozilla_page_load_details 17:43:05 INFO - PID 7561 | |i|pagename|runs| 17:43:05 INFO - PID 7561 | |0;ai-astar;109;108;107;110;106;108;108;108;108;107 17:43:05 INFO - PID 7561 | |1;audio-beat-detection;117;121;117;125;143;116;143;119;119;119 17:43:05 INFO - PID 7561 | |2;audio-dft;166;164;164;165;164;163;163;168;165;164 17:43:05 INFO - PID 7561 | |3;audio-fft;74;74;74;73;73;74;73;73;75;75 17:43:05 INFO - PID 7561 | |4;audio-oscillator;82;80;79;79;80;80;80;80;81;79 17:43:05 INFO - PID 7561 | |5;imaging-gaussian-blur;117;114;113;115;113;115;113;110;114;115 17:43:05 INFO - PID 7561 | |6;imaging-darkroom;146;148;150;149;148;148;149;149;150;150 17:43:05 INFO - PID 7561 | |7;imaging-desaturate;100;95;94;96;94;94;95;94;95;95 17:43:05 INFO - PID 7561 | |8;json-parse-financial;55;54;53;56;55;57;56;54;56;52 17:43:05 INFO - PID 7561 | |9;json-stringify-tinderbox;38;38;38;39;38;38;37;38;39;38 17:43:05 INFO - PID 7561 | |10;stanford-crypto-aes;74;77;78;74;78;75;80;75;80;74 17:43:05 INFO - PID 7561 | |11;stanford-crypto-ccm;113;114;111;115;120;116;123;113;113;118 17:43:05 INFO - PID 7561 | |12;stanford-crypto-pbkdf2;173;171;171;171;172;177;180;172;176;178 17:43:05 INFO - PID 7561 | |13;stanford-crypto-sha256-iterative;76;74;67;67;66;66;70;65;65;65 17:43:05 INFO - PID 7561 | __end_tp_report 17:43:05 INFO - PID 7561 | __start_cc_report 17:43:05 INFO - PID 7561 | _x_x_mozilla_cycle_collect,721 17:43:05 INFO - PID 7561 | __end_cc_report 17:43:05 INFO - PID 7561 | __startTimestamp1506386585166__endTimestamp 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | ------- Summary: start ------- 17:43:05 INFO - PID 7561 | Number of tests: 14 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 17:43:05 INFO - PID 7561 | Values: 109.0 108.0 107.0 110.0 106.0 108.0 108.0 108.0 108.0 107.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:120.00 stddev:10.38 (8.6%) stddev-sans-first:10.70 17:43:05 INFO - PID 7561 | Values: 117.0 121.0 117.0 125.0 143.0 116.0 143.0 119.0 119.0 119.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:1.51 (0.9%) stddev-sans-first:1.51 17:43:05 INFO - PID 7561 | Values: 166.0 164.0 164.0 165.0 164.0 163.0 163.0 168.0 165.0 164.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 17:43:05 INFO - PID 7561 | Values: 74.0 74.0 74.0 73.0 73.0 74.0 73.0 73.0 75.0 75.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:80.00 stddev:0.94 (1.2%) stddev-sans-first:0.67 17:43:05 INFO - PID 7561 | Values: 82.0 80.0 79.0 79.0 80.0 80.0 80.0 80.0 81.0 79.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.50 stddev:1.85 (1.6%) stddev-sans-first:1.59 17:43:05 INFO - PID 7561 | Values: 117.0 114.0 113.0 115.0 113.0 115.0 113.0 110.0 114.0 115.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.25 (0.8%) stddev-sans-first:0.87 17:43:05 INFO - PID 7561 | Values: 146.0 148.0 150.0 149.0 148.0 148.0 149.0 149.0 150.0 150.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.81 (1.9%) stddev-sans-first:0.71 17:43:05 INFO - PID 7561 | Values: 100.0 95.0 94.0 96.0 94.0 94.0 95.0 94.0 95.0 95.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.50 stddev:1.55 (2.8%) stddev-sans-first:1.64 17:43:05 INFO - PID 7561 | Values: 55.0 54.0 53.0 56.0 55.0 57.0 56.0 54.0 56.0 52.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 17:43:05 INFO - PID 7561 | Values: 38.0 38.0 38.0 39.0 38.0 38.0 37.0 38.0 39.0 38.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:77.50 stddev:2.42 (3.1%) stddev-sans-first:2.39 17:43:05 INFO - PID 7561 | Values: 74.0 77.0 78.0 74.0 78.0 75.0 80.0 75.0 80.0 74.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:115.50 stddev:3.72 (3.2%) stddev-sans-first:3.82 17:43:05 INFO - PID 7561 | Values: 113.0 114.0 111.0 115.0 120.0 116.0 123.0 113.0 113.0 118.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:174.50 stddev:3.35 (1.9%) stddev-sans-first:3.53 17:43:05 INFO - PID 7561 | Values: 173.0 171.0 171.0 171.0 172.0 177.0 180.0 172.0 176.0 178.0 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.00 stddev:3.96 (5.9%) stddev-sans-first:2.99 17:43:05 INFO - PID 7561 | Values: 76.0 74.0 67.0 67.0 66.0 66.0 70.0 65.0 65.0 65.0 17:43:05 INFO - PID 7561 | -------- Summary: end -------- 17:43:05 INFO - PID 7561 | 17:43:05 INFO - PID 7561 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:43:05 INFO - TEST-INFO | 7561: exit 0 17:43:05 INFO - TEST-OK | kraken | took 61424ms 17:43:05 INFO - SUITE-END | took 1170s 17:43:06 INFO - Completed test suite (00:19:30) 17:43:06 INFO - javascript benchmark 17:43:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8609.265269766089, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3142.7171554560086, 3171.825549594773, 3177.2851108500604, 3179.411808815369, 3182.4112539180246, 6191.783287584935, 6318.747250109996, 6332.1768170137875, 6345.809625711236, 6399.232092148943, 6257.0, 6308.337624549425, 6319.368063193679, 6321.5890967087225, 6361.586496877711, 5762.481376676098, 5779.508741756956, 5786.276715410574, 5835.795747148851, 5907.172995780573, 5844.590878638497, 5857.85355366115, 5930.140129681194, 5935.228420305354, 5948.494377977877, 5670.06443936754, 5707.486326230618, 5833.824985250428, 5915.940840591582, 5921.052631578927, 5687.0900655895275, 5784.971075144639, 5814.156947242626, 5831.650100993954, 5867.794627188071, 5768.711564421804, 5771.740271687784, 5843.9707801461145, 5844.1818145459665, 5845.386234445365, 6171.074338849208, 6201.131841542187, 6201.937980620181, 6228.346023667495, 6243.937560624381, 6696.06255124283, 6696.397324240842, 6702.966485167592, 6703.162104736908, 6712.160979877515, 6733.865322693568, 6770.424513916323, 6855.4172895303955, 6909.585424874524, 6930.584164950069, 6248.343923887972, 6311.305756366796, 6374.362563743635, 6381.361863813628, 6424.903626445607, 6981.162260528769, 6986.9650651746415, 7029.61337126463, 7092.822679432952, 7109.502334836512, 6722.462203023844, 6747.392734653905, 6792.150981127359, 6802.387785099266, 6822.283660215705, 6814.114165158498, 6885.793426197222, 6919.446444284546, 6919.861602767916, 6921.134858142732, 6775.22084960226, 6783.321667833177, 6797.830054248683, 6887.483438742114, 6900.551464154814, 6643.966780166068, 6767.052612634235, 6811.2167100784045, 6926.030355750199, 6928.480363972722, 5405.135178371442, 5418.539424148913, 5423.376311724123, 5433.510984011458, 5438.45615438453, 4585.495595484494, 4726.1020406122725, 4757.857264282077, 4771.355866957986, 4800.759962001886, 5839.211706419579, 5855.355910849803, 5913.733881975321, 5923.881522369528, 5931.051031834886, 6707.295733947963, 6731.798046058626, 6741.325867413219, 6805.489588280899, 6935.375816176568, 5767.077267637158, 5778.162166485836, 5859.355470898197, 5866.67733274674, 5877.853053673607, 5805.535557155502, 5925.496332811673, 5949.672767997802, 5972.880542389128, 5974.880502389928, 6564.770233041916, 6569.80290591283, 6644.368784965421, 6659.86680266392, 6664.033715111379, 6589.47284217271, 6728.226253980855, 6771.661416929035, 6844.623545704934, 6887.414569761627, 6521.250056243403, 6521.836954075996, 6528.281888992302, 6556.377144171296, 6644.069830223676, 6737.056812046219, 6762.49281303914, 6819.2498825128205, 6833.624150671562, 6853.828654283483, 6838.042674025541, 6838.829029274308, 6843.7604683835825, 6936.653167341512, 6941.409980151541, 6456.709448074942, 6536.738530458729, 6591.077249185022, 6667.599944003376, 6683.0, 6591.769288074895, 6654.401103900672, 6677.265500795006, 6686.465082793267, 6687.398134167948, 6570.704318305783, 6571.835704107436, 6572.572782769104, 6670.232923213893, 6670.9332906670315, 6514.3811337922825, 6651.534392592472, 6698.966505167443, 6748.69630866622, 6788.796336109925, 6372.87254254903, 6380.266269378895, 6388.87222255543, 6394.5523813334485, 6401.135846660642], "value": 6200.831319419519, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.9836603267935, 885.7652722028663, 911.4531281231262, 917.9311551633629, 1143.4454289669504, 29262.999999999975, 29695.406091878176, 39168.60831391689, 39895.0, 39933.60066399343, 39998.0, 40558.59441405585, 40643.18713625726, 40652.59347406525, 40789.59210407903, 7702.6533805978725, 7712.267334603203, 7865.331446827026, 7866.724664636738, 7921.683132674686, 7670.27132422419, 7765.728199513018, 7769.689212431496, 7770.728024519143, 7777.494462859896, 7761.0, 7805.5706936118495, 7820.45256832022, 7821.0, 7828.725994590191, 7762.922370776277, 7764.145943946161, 7784.494007889497, 7794.2205779422175, 7794.493357931717, 7655.693772249103, 7766.456348055638, 7771.455998080137, 7772.65023073963, 7783.377329813601, 36347.4547881782, 36466.27067458636, 36485.63514364849, 36564.268714625825, 36737.81631091854, 3475.5308033415417, 3512.6487351264923, 3515.753897227195, 3516.4022116240044, 3518.489818976234, 29982.55026174609, 30067.849660751555, 30143.397132057235, 30191.547126793117, 30196.0, 5131.666441681279, 5151.356080489939, 5198.636095473318, 5204.34945631796, 5205.27126202332, 180402.0, 181433.0, 182121.0, 182643.0, 182795.0, 46713.766431168304, 46958.0, 46983.0, 47083.764581176874, 47125.0, 51434.48565514372, 52779.73610131925, 52963.0, 53111.0, 53331.73334133304, 15816.209189540707, 15851.603709907344, 15938.60153496172, 15941.44204952821, 15957.04257744539, 10610.257281990342, 10738.892611073945, 10761.730956725987, 12417.875821241672, 12593.055520835975, 14137.929310353587, 14149.221792801289, 14166.929165354108, 14213.43146274158, 14294.142351458946, 5583.832485025456, 5635.323761148688, 5721.170430287585, 5800.796972105956, 5885.0, 986.6004268271362, 1012.6000229909145, 1024.7847951930178, 1029.2383636109375, 1037.2583602723937, 22179.66730499044, 22278.665820012713, 22315.0, 22392.992315345848, 22636.434089147904, 1120.7030137013699, 1131.9830202546968, 1134.3420815926743, 1139.9259048161844, 1149.1151813103863, 11927.463264153133, 11942.462589183508, 11967.820482692767, 12035.578754743541, 12207.938960305142, 226639.0, 229364.0, 229648.0, 229674.0, 230879.0, 49053.26420103701, 49331.50668493341, 49441.50558494369, 49698.254526182136, 49747.0, 1439.8344190418027, 1459.8905082118883, 1460.839307676176, 1469.0744830756555, 1474.8598883106088, 21609.243676471247, 21884.562308754055, 21992.89003554972, 22023.559528809015, 22207.1117155312, 35661.28677426489, 35723.28553428969, 35744.82127589345, 35778.64221357753, 35781.28437431289, 182871.0, 185278.0, 185429.0, 185589.0, 185631.0, 29560.408791824473, 30113.548296776004, 30190.245243869078, 32745.0, 33363.0, 40047.0, 40149.799251003555, 40320.798396009006, 40940.59059409368, 41097.0, 29895.0, 29902.850485747433, 29927.55108673328, 29956.400871982, 30203.0, 29833.850830746575, 29843.552346714383, 30239.244018899702, 30505.389892202475, 31100.22249443782, 34105.65894341124, 34228.315433691685, 34230.82884585661, 34282.314353713286, 34295.14262143367, 28602.284942876595, 28967.986120485682, 29307.26731831636, 29363.265918352212, 30392.392152157274, 22034.669479957494, 22274.109035638394, 22351.0, 22461.43846403853, 22489.32532024042], "value": 16673.408063727093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.1805722673511, 573.3148887079941, 578.9768409263627, 588.6468119128523, 588.7792077970762, 21266.25568105115, 21903.342899712996, 21966.890165549168, 22024.779752202474, 22034.11863525461, 22130.0, 23523.882380588115, 23605.64591531124, 23892.402689932762, 23996.1601343953, 6417.871642567135, 6524.641144737037, 6567.6059436433725, 6574.14536110305, 6596.109525214107, 6425.678716064202, 6534.379233972765, 6538.150040494729, 6541.345865413468, 6544.247411547685, 5969.0, 6200.81397558074, 6246.875062498747, 6249.468795152395, 6489.156409666737, 6219.067139929024, 6281.87436251277, 6284.402981716729, 6284.7486100555925, 6287.276963149251, 5863.208466856962, 5882.088276317178, 6398.616083034986, 6649.468042556584, 6709.597424154566, 28673.28316792076, 28922.566161507595, 29283.121506354844, 29506.409871802443, 29550.40899182026, 2063.432556047099, 2081.6253074446595, 2083.6874468829647, 2091.069474084033, 2098.5278312379746, 19224.90387548067, 19722.70415943762, 20003.799962000485, 20015.79984200154, 20066.89966550158, 2431.124795073772, 2441.9743707642833, 2477.36827109086, 2545.643609894616, 2546.5543529882198, 117498.41250793777, 124979.0, 139072.0, 146744.0, 146875.26562367225, 19300.32448864283, 19920.561564787407, 19955.0, 20491.28280510175, 20711.378658640264, 39801.40297895534, 39803.40294895579, 39804.20391592152, 39824.40263396051, 39860.20978531533, 10935.398553079498, 11115.333080015225, 11304.30871188464, 11309.660710178709, 11361.545538178545, 9306.53467326631, 9504.382215155993, 9512.90487095134, 9543.379680320757, 9569.138777510057, 10597.735056623646, 10739.194560408001, 10742.0, 10907.945460272807, 11146.832797508045, 3509.701675357572, 3667.8349474273186, 3698.0, 4063.553009168989, 4241.957580424218, 945.8723072385278, 976.6386437018349, 979.2851218610311, 981.3915372469115, 985.6353149334792, 18065.0, 18384.264629414673, 18466.169022394024, 18469.0, 18842.0, 1002.774375765447, 1031.654395777408, 1040.095117247984, 1041.5052849896238, 1048.3447845096814, 10048.547815348327, 10271.640492582725, 10360.171186305077, 10414.791704165875, 10467.476626168662, 455075.0, 458859.0, 468735.0, 470257.0, 470595.0, 106050.46974765077, 108416.45791771148, 108804.45597771961, 109125.45437272763, 109305.0, 1011.3830563356347, 1100.9229353945148, 1139.6125317392127, 1150.9366984815747, 1177.0583533173426, 19081.809181908004, 19099.236030558623, 19266.0, 19448.70826937569, 19671.508212294808, 51132.74433627957, 52343.738281309874, 53049.73475132754, 53321.0, 53371.19943200777, 62359.37640623717, 63403.0489542648, 63908.680456597416, 64446.67776661087, 64477.35522644714, 17452.82547174512, 18257.726134107732, 19125.330613428465, 19150.425487235407, 19164.520886977938, 21335.46661333479, 21388.0, 21410.678839817105, 21593.35219943404, 21637.891810541478, 17392.130393480023, 17406.0426676534, 17450.563735906704, 17695.292188312324, 17756.822431775516, 15551.0, 15677.372905083668, 15912.92043539775, 15973.281202346156, 16092.758608621114, 17751.64496710033, 17920.641587168444, 17958.91020544889, 17989.820101799338, 18137.637247255247, 17586.0, 18246.817531825043, 18581.72127418063, 18653.253869845597, 18661.626767464848, 17111.0, 17482.30070797205, 17594.64810703753, 17595.56011099733, 17785.377511787025], "value": 12349.100467082155, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.9415026323816, 1348.5077946549507, 1368.117564171109, 1371.7462269480147, 1374.7731624281996, 14997.92501037496, 15504.224788760559, 15704.685906281868, 15710.371585136581, 15711.135887526181, 15479.14864682442, 15576.688466230697, 15605.219739013033, 15620.921895390507, 15627.609309767262, 2713.81003329767, 2726.481968425993, 2763.46112508061, 2778.097118436506, 2780.5968134620466, 2751.1058905855575, 2792.0925699147756, 2802.9439411211765, 2804.0466241477893, 2814.408974115438, 2718.143784707811, 2808.0452646100425, 2838.9858050709718, 2839.0489186122672, 2839.8154119982137, 2771.1409463066516, 2793.1201671473523, 2822.6612806463254, 2824.3362809739797, 2825.434913017384, 2634.0780726745484, 2709.91870243893, 2716.9320766980786, 2719.225020869043, 2730.6723193216744, 15204.16377099259, 15287.923560382127, 15317.923410382988, 15328.310226039855, 15364.231788410534, 8035.437519373646, 8258.958705206496, 8320.625571849281, 8320.916790832074, 8345.207205315486, 5437.463242017005, 5557.527610153102, 5660.745266463019, 5736.196932429463, 5768.596198266081, 1937.4381429385462, 1966.3314473079079, 1975.3580086471954, 2012.7584689837167, 2018.7880272571463, 26785.33036674099, 27013.324666883287, 27026.0, 27027.72972270272, 27038.32404189891, 6634.23706273775, 6830.21452532965, 6865.5537390069485, 7019.789406317818, 7079.1858936223, 17462.65074698499, 17608.471745847644, 17618.383356582715, 17618.559536011704, 17642.1178941055, 7978.082520510099, 8094.51432914027, 8200.58997050145, 8548.572571371407, 8578.270846977952, 7517.060367454068, 7517.699292028367, 7656.885146722803, 7668.846623067619, 7670.232976702285, 5259.0, 5406.83779486616, 5419.972900135474, 5426.701531415731, 5433.6196466247775, 1560.2744723703531, 1568.8352722964153, 1569.3330334607747, 1588.7537431698106, 1590.6262028423312, 888.3825741109996, 908.2143945487106, 908.8046070094962, 916.3127654259306, 925.8657494663236, 7769.689212431553, 7789.3768498519985, 7797.571133587594, 7812.257835505618, 7854.253845884632, 717.824133087397, 720.1646090534954, 721.3976329764705, 727.5380133615087, 731.352752813753, 4582.633389328846, 5202.375714914235, 5463.808766693147, 5501.2121060655445, 5677.233573467529, 20962.790372096082, 21616.35150945474, 21990.45023874384, 22163.77836221617, 22295.665565016538, 21928.671069933964, 22233.888830555745, 22270.888645556668, 22318.107275709113, 22379.328620141096, 10685.732856678645, 10801.83797243042, 10993.725156871142, 11043.944780276208, 11163.665090047312, 8308.916910830814, 8441.66233350659, 8453.746387608382, 8503.362247831314, 8583.442076265022, 18785.34251301198, 19229.90385048066, 19262.903685482044, 19420.70868936939, 19619.70570441416, 19225.423237302904, 19659.41021769349, 19848.0, 20375.592488149858, 20422.897885510476, 11275.887241127484, 11522.711932201762, 11523.078153747512, 11535.711607209887, 11548.711282218012, 13942.4423023082, 14066.367013484622, 14207.857921420653, 14210.218437985597, 14226.644333891736, 11459.885401145882, 11490.827637585277, 11586.246893952204, 11704.824427633763, 11815.763684726086, 11127.332360058423, 11378.260413073123, 11495.942520287344, 11607.593734219261, 11729.35488548104, 9751.414915105117, 9792.902070979198, 9855.35940163887, 9929.851052234368, 9930.106290433896, 6567.835804104744, 6599.175103112111, 6643.435307998681, 6736.5958042517605, 6790.049393084873, 6951.478639101986, 7120.643967801486, 7156.248593897566, 7164.247753985965, 7220.927790722026], "value": 6724.654749697708, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.72789965518933, 519.7063659032648, 529.8463445600776, 531.0785786660144, 536.1823219590125, 6375.203099612549, 6433.841908456476, 6439.388258115471, 6453.580517266386, 6465.806025819221, 6351.3966173213585, 6352.82472742543, 6370.458511026568, 6407.647579383144, 6424.453921416685, 5268.288781014562, 5299.920501192485, 5300.814471493499, 5309.354100228922, 5309.601779866506, 4882.681675947492, 5220.712860792655, 5242.292290540785, 5250.553702935255, 5288.127458969285, 4999.350084489011, 5000.849974500771, 5018.498150184989, 5037.798488060474, 5054.41874184468, 5033.245013248005, 5050.393952725696, 5053.949460505385, 5055.191169412895, 5055.761338472061, 4379.189849877751, 4470.642348612103, 4538.546145385468, 4555.838261243395, 4568.451785785727, 6034.668093254869, 6063.302720187191, 6130.946133045435, 6151.446369826737, 6184.412480814315, 5704.372519022904, 5738.454846789548, 5785.103308987113, 5792.131180322943, 5797.217375654275, 6411.647359395231, 6541.542092053558, 6620.172478440195, 6649.634270115142, 6671.766488172939, 4932.309476673268, 4940.011997600458, 4960.206366981266, 4985.601151907875, 4987.526185012418, 6635.568688035262, 6726.0, 6752.2234942981695, 6876.69054892526, 6894.689738961759, 5077.796888124433, 5095.0, 5098.037255656599, 5102.795888164506, 5120.769565369567, 5097.719625420564, 5117.181250999822, 5129.256257842592, 5150.356205474316, 5181.222816577543, 5728.198052272685, 5750.88498230033, 5759.3061654751245, 5810.912836307459, 5824.737886795019, 6655.700493477805, 6664.333566643394, 6682.699278532477, 6713.985804258703, 6728.3271672832325, 1785.259117466263, 1786.8302511261409, 1789.3895494055455, 1791.6864548703925, 1804.3414153833755, 1170.3796987596588, 1213.538855235005, 1228.2569045727384, 1240.4232032104935, 1249.4752204074312, 5646.378898321182, 5683.914741278884, 5699.518125287373, 5735.541156707453, 5761.0, 6714.764983225564, 6732.663366831639, 6766.357196066366, 6777.695003724844, 6788.151481064867, 5650.491455768918, 5656.236408084938, 5707.571932105026, 5739.311282646109, 5794.101914203306, 3509.4560343146854, 3546.5744110706883, 3550.2721942001826, 3561.216532362876, 3577.749557531, 6391.808245752542, 6394.168758061515, 6423.389777971085, 6441.227052753699, 6509.967450162719, 6357.205349331333, 6772.8984065239065, 6858.622775747282, 6911.5853048817235, 6963.234044255128, 6311.495080393649, 6315.400036996478, 6321.3678632137335, 6361.586496877688, 6521.7065232065615, 6539.509536784665, 6625.801225963229, 6687.431568316748, 6723.4285085766305, 6739.5619284746335, 6531.563056127644, 6665.267450227888, 6669.599824010575, 6724.193096828412, 6760.18877734675, 6352.6506042166275, 6374.171357723466, 6432.163818703539, 6446.290908000023, 6456.644884531396, 4981.252812078217, 5022.522860328263, 5024.472430394756, 5043.773030213576, 5092.134337162765, 6317.399847014526, 6615.867682646416, 6634.402903738686, 6683.933160668331, 6695.631740254333, 6433.517486188461, 6458.38645328693, 6497.610143391412, 6586.1438013059915, 6597.3072827352435, 6461.515386345949, 6546.738130474728, 6547.476201903932, 6550.7707230246715, 6581.440577550962, 6433.105102703708, 6464.967675161783, 6483.281930288572, 6494.0, 6571.112899758471, 6601.53789234749, 6675.7329706813125, 6704.966475167593, 6719.932800671931, 6730.394264516217, 6315.0742420911765, 6377.808665740035, 6409.9679501602195, 6439.846299137124, 6485.513586481127], "value": 5092.2277326940975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.9001309855917, 909.4179724976012, 930.1628534319112, 931.9767005824849, 941.2987324443286, 19478.123484443215, 19979.400617981482, 20192.798072019275, 20193.39419817406, 20228.59542809143, 18127.274909003623, 18160.0, 18220.635587288245, 19496.317628882993, 19613.705794413094, 978.144123891593, 1001.0840081325579, 1004.397361583048, 1007.1288335589735, 1007.2445665750687, 941.4351389166513, 980.872486576744, 985.4235272365675, 987.1559816357019, 992.5285489392517, 1031.520343040486, 1031.582209205273, 1031.9535620897077, 1032.1330082730506, 1038.2057725839738, 995.2784231432154, 1022.6931920423917, 1025.5948900184424, 1026.4098143567403, 1036.461040259065, 738.3133685672323, 754.3474894216519, 756.4855897989365, 756.8259300360893, 757.1860250231024, 20017.29939452127, 20261.392158235278, 20300.5939881203, 20365.389038328874, 20373.08321125553, 21520.246791362228, 21656.0, 22069.448263793372, 22203.22288719887, 22259.109635614557, 17287.827121728747, 17567.64864702699, 17737.29050837965, 17874.374396896048, 17898.194581243875, 3737.831797569116, 3807.0, 3815.5802861685193, 3816.0, 3818.3317919364, 140810.29594852164, 140823.0, 141466.0, 143669.0, 143688.0, 16872.493825185265, 16970.660586788195, 17105.486835394957, 17132.914335428493, 17164.31342746301, 31817.52273715896, 31858.681413186034, 31878.521822172686, 31965.0, 32115.67884321127, 8719.65121395137, 8773.42972706772, 8779.385443019055, 8795.51624660637, 8821.117888211127, 4314.439122914001, 4523.977380113144, 4557.02024064821, 4558.931616025762, 4559.908801823945, 5448.210009548672, 5553.750081246354, 5573.442655734394, 5593.972030139905, 5599.216109744639, 924.5746956400131, 956.2780101023683, 963.5182408795603, 965.5220665770348, 983.0513554420019, 665.2216906219735, 687.2611942162096, 688.9379955803902, 708.6138054760169, 713.3829237709344, 11454.656360309204, 11639.883601164049, 11799.053156229125, 11951.984081353183, 12143.939280303719, 676.1750664189681, 683.5420268420171, 689.5070024932197, 690.2407351912956, 691.6368906324119, 5635.746391412396, 5764.221830052889, 5867.677277749679, 5949.851253718605, 5954.672493012839, 118620.0, 118675.40662296633, 118880.40559797146, 120708.0, 124171.0, 101072.49463752634, 104894.0, 108257.45871270593, 108389.0, 109655.0, 90404.54797725838, 91158.54420727854, 92437.0, 95188.0, 96267.51866240765, 12841.101122921305, 13377.53178638743, 13442.93278533601, 13525.053246272666, 13651.79522307186, 41760.58239417567, 41802.79098604488, 42135.0, 42577.361339579315, 42737.14525709406, 55380.72309638426, 55749.44250557605, 56399.71800140973, 56882.7155864218, 57174.7141264291, 18652.067396629842, 18874.339398121, 18889.90555047216, 18913.810861891754, 18989.810101898805, 19932.70100948458, 20086.09612567409, 20189.293374731813, 20203.0, 20348.0, 19280.132394042583, 19623.509412264808, 19674.11466483983, 19686.704699429807, 19817.0, 16939.407120750715, 16947.81365304417, 17136.742948856026, 17304.307827687255, 17398.913005434893, 18909.810901891356, 19096.80903191006, 19295.324663636704, 19301.517462063563, 19661.0, 13526.797098043735, 13562.457501699822, 13605.931970340085, 13657.453701852211, 13841.515546955809, 13831.861681383058, 14041.648958776112, 14117.647058823612, 14176.0, 14262.358193881508], "value": 9312.880444935585, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1435.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 107.0, 110.0, 106.0, 108.0, 108.0, 108.0, 108.0, 107.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 117.0, 125.0, 143.0, 116.0, 143.0, 119.0, 119.0, 119.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 165.0, 164.0, 163.0, 163.0, 168.0, 165.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 73.0, 73.0, 74.0, 73.0, 73.0, 75.0, 75.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 79.0, 79.0, 80.0, 80.0, 80.0, 80.0, 81.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 113.0, 115.0, 113.0, 115.0, 113.0, 110.0, 114.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 150.0, 149.0, 148.0, 148.0, 149.0, 149.0, 150.0, 150.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 94.0, 96.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 56.0, 55.0, 57.0, 56.0, 54.0, 56.0, 52.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 37.0, 38.0, 39.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 78.0, 74.0, 78.0, 75.0, 80.0, 75.0, 80.0, 74.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 111.0, 115.0, 120.0, 116.0, 123.0, 113.0, 113.0, 118.0], "value": 115.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 171.0, 171.0, 172.0, 177.0, 180.0, 172.0, 176.0, 178.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 67.0, 67.0, 66.0, 66.0, 70.0, 65.0, 65.0, 65.0], "value": 68.1, "unit": "score"}]}]} 17:43:06 INFO - Return code: 0 17:43:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:43:06 INFO - # TBPL SUCCESS # 17:43:06 INFO - Running post-action listener: _package_coverage_data 17:43:06 INFO - Running post-action listener: _resource_record_post_action 17:43:06 INFO - [mozharness: 2017-09-26 00:43:06.456099Z] Finished run-tests step (success) 17:43:06 INFO - Running post-run listener: _resource_record_post_run 17:43:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 338124800; Read time: 16; Write time: 273524 17:43:06 INFO - TinderboxPrint: CPU usage
13.1% 17:43:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:43:06 INFO - TinderboxPrint: I/O write bytes / time
338,124,800 / 273,524 17:43:06 INFO - TinderboxPrint: CPU idle
8,233.5 (86.9%) 17:43:06 INFO - TinderboxPrint: CPU user
1,194.0 (12.6%) 17:43:06 INFO - TinderboxPrint: Swap in / out
0 / 0 17:43:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 18075648; Read time: 0; Write time: 11652 17:43:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:43:06 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 320049152; Read time: 0; Write time: 261872 17:43:07 INFO - Running post-run listener: _upload_blobber_files 17:43:07 INFO - Blob upload gear active. 17:43:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:43:07 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 17:43:07 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'] 17:43:07 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 17:43:07 INFO - (blobuploader) - INFO - Open directory for files ... 17:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:08 INFO - (blobuploader) - INFO - Done attempting. 17:43:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:43:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:10 INFO - (blobuploader) - INFO - Done attempting. 17:43:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:43:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:43:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:17 INFO - (blobuploader) - INFO - Done attempting. 17:43:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:43:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:43:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:18 INFO - (blobuploader) - INFO - Done attempting. 17:43:18 INFO - (blobuploader) - INFO - Iteration through files over. 17:43:18 INFO - Return code: 0 17:43:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:43:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:43:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98974afdfc5015d7587d11e2036474c2d3c4bbc5b91f5a9c1e4bfc94004dd0a7185df95a5208834a0a554e21663de8184a3dabb8a94c3d0ced7dba3c4713f700", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7442b291b4afed7dc1390efff6b1f8c8b69a2fee44372b0d17bc1c094f4cdbe39305cade094f8e09e87c892bb7e7f9b24f8dc1b6ba601624331c08040a2db666", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb40093fd68eebd36057d799303c4fe51826cf74fc45b361cee5ea4053959429eb8b70e31e8f7d01a0dc7be2e48f902da43547db72f28c2c9134b291ca0eeb7f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27717d5407d5800a2d7d1a86ecb02ca2ba5156098ec23114cda5914350ddad6cb8adb0c724d29950da93e1ea39f77715a3f5a7cb5bd8ea87fbc982866aecce69"} 17:43:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:43:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:43:18 INFO - Contents: 17:43:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98974afdfc5015d7587d11e2036474c2d3c4bbc5b91f5a9c1e4bfc94004dd0a7185df95a5208834a0a554e21663de8184a3dabb8a94c3d0ced7dba3c4713f700", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7442b291b4afed7dc1390efff6b1f8c8b69a2fee44372b0d17bc1c094f4cdbe39305cade094f8e09e87c892bb7e7f9b24f8dc1b6ba601624331c08040a2db666", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb40093fd68eebd36057d799303c4fe51826cf74fc45b361cee5ea4053959429eb8b70e31e8f7d01a0dc7be2e48f902da43547db72f28c2c9134b291ca0eeb7f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27717d5407d5800a2d7d1a86ecb02ca2ba5156098ec23114cda5914350ddad6cb8adb0c724d29950da93e1ea39f77715a3f5a7cb5bd8ea87fbc982866aecce69"} 17:43:18 INFO - Running post-run listener: copy_logs_to_upload_dir 17:43:18 INFO - Copying logs to upload dir... 17:43:18 INFO - mkdir: /builds/slave/test/build/upload/logs 17:43:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.228228 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-25 17:43:18.482487) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 17:43:18.488281) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887 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/98974afdfc5015d7587d11e2036474c2d3c4bbc5b91f5a9c1e4bfc94004dd0a7185df95a5208834a0a554e21663de8184a3dabb8a94c3d0ced7dba3c4713f700", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7442b291b4afed7dc1390efff6b1f8c8b69a2fee44372b0d17bc1c094f4cdbe39305cade094f8e09e87c892bb7e7f9b24f8dc1b6ba601624331c08040a2db666", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb40093fd68eebd36057d799303c4fe51826cf74fc45b361cee5ea4053959429eb8b70e31e8f7d01a0dc7be2e48f902da43547db72f28c2c9134b291ca0eeb7f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27717d5407d5800a2d7d1a86ecb02ca2ba5156098ec23114cda5914350ddad6cb8adb0c724d29950da93e1ea39f77715a3f5a7cb5bd8ea87fbc982866aecce69"} build_url:https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98974afdfc5015d7587d11e2036474c2d3c4bbc5b91f5a9c1e4bfc94004dd0a7185df95a5208834a0a554e21663de8184a3dabb8a94c3d0ced7dba3c4713f700", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7442b291b4afed7dc1390efff6b1f8c8b69a2fee44372b0d17bc1c094f4cdbe39305cade094f8e09e87c892bb7e7f9b24f8dc1b6ba601624331c08040a2db666", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb40093fd68eebd36057d799303c4fe51826cf74fc45b361cee5ea4053959429eb8b70e31e8f7d01a0dc7be2e48f902da43547db72f28c2c9134b291ca0eeb7f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27717d5407d5800a2d7d1a86ecb02ca2ba5156098ec23114cda5914350ddad6cb8adb0c724d29950da93e1ea39f77715a3f5a7cb5bd8ea87fbc982866aecce69"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 17:43:18.516446) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:43:18.516823) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1506381406.24863-461988887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:43:18.599738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 17:43:18.600051) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 17:43:18.600346) ========= ========= Total master_lag: 0.19 =========