builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1493998346.69 results: success (0) revision: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:26.685872) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:26.686309) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:26.686619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:26.701489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:26.701783) ========= 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=d2a8c569965ab8367867b893000001a1-1493996357.873603-963067919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 08:32:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2017-05-05 08:32:27 (40.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123230 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:26.839423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:26.839774) ========= 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=d2a8c569965ab8367867b893000001a1-1493996357.873603-963067919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017012 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:26.889355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:26.889713) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23fe0b76a018a5077a0f7234cff91c41e4b6af64 --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 23fe0b76a018a5077a0f7234cff91c41e4b6af64 --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=d2a8c569965ab8367867b893000001a1-1493996357.873603-963067919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 08:32:27,211 truncating revision to first 12 chars 2017-05-05 08:32:27,211 Setting DEBUG logging. 2017-05-05 08:32:27,211 attempt 1/10 2017-05-05 08:32:27,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23fe0b76a018?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 08:32:27,592 unpacking tar archive at: mozilla-central-23fe0b76a018/testing/mozharness/ program finished with exit code 0 elapsedTime=0.751300 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:27.654313) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:27.654647) ========= script_repo_revision: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:27.655002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:27.655282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 08:32:27.665748) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-05 08:32:27.666080) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1493996357.873603-963067919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:28 INFO - MultiFileLogger online at 20170505 08:32:28 in /builds/slave/test 08:32:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:32:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:28 INFO - {'append_to_log': False, 08:32:28 INFO - 'base_work_dir': '/builds/slave/test', 08:32:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:32:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:28 INFO - 'branch': 'Firefox-Non-PGO', 08:32:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:28 INFO - 'config_files': ('talos/linux_config.py',), 08:32:28 INFO - 'default_actions': ('clobber', 08:32:28 INFO - 'read-buildbot-config', 08:32:28 INFO - 'download-and-extract', 08:32:28 INFO - 'populate-webroot', 08:32:28 INFO - 'create-virtualenv', 08:32:28 INFO - 'install', 08:32:28 INFO - 'run-tests'), 08:32:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:28 INFO - 'download_minidump_stackwalk': True, 08:32:28 INFO - 'download_symbols': 'ondemand', 08:32:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:28 INFO - 'gecko_profile': False, 08:32:28 INFO - 'gecko_profile_interval': 0, 08:32:28 INFO - 'installer_path': 'installer.exe', 08:32:28 INFO - 'log_level': 'info', 08:32:28 INFO - 'log_name': 'talos', 08:32:28 INFO - 'log_to_console': True, 08:32:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:28 INFO - 'opt_config_files': (), 08:32:28 INFO - 'pip_index': False, 08:32:28 INFO - 'suite': 'dromaeojs-e10s', 08:32:28 INFO - 'system_bits': '32', 08:32:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:28 INFO - 'title': 'talos-linux64-ix-043', 08:32:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:28 INFO - 'use_talos_json': True, 08:32:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:28 INFO - 'work_dir': 'build'} 08:32:28 INFO - [mozharness: 2017-05-05 15:32:28.094193Z] Running clobber step. 08:32:28 INFO - Running pre-action listener: _resource_record_pre_action 08:32:28 INFO - Running main action method: clobber 08:32:28 INFO - rmtree: /builds/slave/test/build 08:32:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:29 INFO - Running post-action listener: _resource_record_post_action 08:32:29 INFO - [mozharness: 2017-05-05 15:32:29.541436Z] Finished clobber step (success) 08:32:29 INFO - [mozharness: 2017-05-05 15:32:29.541537Z] Running read-buildbot-config step. 08:32:29 INFO - Running pre-action listener: _resource_record_pre_action 08:32:29 INFO - Running main action method: read_buildbot_config 08:32:29 INFO - Using buildbot properties: 08:32:29 INFO - { 08:32:29 INFO - "project": "", 08:32:29 INFO - "product": "firefox", 08:32:29 INFO - "who": "ffxbld@noreply.mozilla.org", 08:32:29 INFO - "installer_path": "public/build/target.tar.bz2", 08:32:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:32:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:32:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:32:29 INFO - "stage_platform": "linux64", 08:32:29 INFO - "basedir": "/builds/slave/test", 08:32:29 INFO - "buildnumber": 854, 08:32:29 INFO - "platform": "ubuntu64_hw", 08:32:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:32:29 INFO - "slavebuilddir": "test", 08:32:29 INFO - "taskId": "Jkz-pQRJQOi2TMpChIhusQ", 08:32:29 INFO - "branch": "mozilla-central", 08:32:29 INFO - "script_repo_revision": "production", 08:32:29 INFO - "revision": "23fe0b76a018a5077a0f7234cff91c41e4b6af64", 08:32:29 INFO - "slavename": "talos-linux64-ix-043", 08:32:29 INFO - "repo_path": "mozilla-central" 08:32:29 INFO - } 08:32:29 INFO - Finding installer, test and symbols from parent task. 08:32:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jkz-pQRJQOi2TMpChIhusQ'}, attempt #1 08:32:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jkz-pQRJQOi2TMpChIhusQ'}, attempt #1 08:32:30 INFO - Task dependencies: d4JL1crRRLCMzVyKyrpSZA 08:32:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA'}, attempt #1 08:32:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.tar.bz2 08:32:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/test_packages.json 08:32:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.crashreporter-symbols.zip 08:32:30 INFO - Running post-action listener: _resource_record_post_action 08:32:30 INFO - [mozharness: 2017-05-05 15:32:30.919851Z] Finished read-buildbot-config step (success) 08:32:30 INFO - [mozharness: 2017-05-05 15:32:30.920068Z] Running download-and-extract step. 08:32:30 INFO - Running pre-action listener: _resource_record_pre_action 08:32:30 INFO - Running main action method: download_and_extract 08:32:30 INFO - mkdir: /builds/slave/test/build/tests 08:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:32:30 INFO - trying https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.test_packages.json 08:32:30 INFO - Downloading https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:32:31 INFO - Downloaded 986 bytes. 08:32:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:32:31 INFO - Using the following test package requirements: 08:32:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:32:31 INFO - u'common': [u'target.common.tests.zip'], 08:32:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:32:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:32:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:32:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:32:31 INFO - u'mozbase': [u'target.common.tests.zip'], 08:32:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:32:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:32:31 INFO - u'web-platform': [u'target.common.tests.zip', 08:32:31 INFO - u'target.web-platform.tests.zip'], 08:32:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:32:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:32:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.common.tests.zip 08:32:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:31 INFO - Fetch https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.common.tests.zip into memory 08:32:32 INFO - Content-Length response header: 58444235 08:32:32 INFO - Bytes received: 58444235 08:32:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:32:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.common.tests.zip 08:32:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:42 INFO - Fetch https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.common.tests.zip into memory 08:32:43 INFO - Content-Length response header: 58444235 08:32:43 INFO - Bytes received: 58444235 08:32:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.talos.tests.zip 08:32:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:32:54 INFO - Fetch https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.talos.tests.zip into memory 08:32:55 INFO - Content-Length response header: 14408697 08:32:55 INFO - Bytes received: 14408697 08:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:32:55 INFO - trying https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.tar.bz2 08:32:55 INFO - Downloading https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:32:56 INFO - Downloaded 58358518 bytes. 08:32:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.tar.bz2 08:32:56 INFO - mkdir: /builds/slave/test/properties 08:32:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:56 INFO - Contents: 08:32:56 INFO - build_url:https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.tar.bz2 08:32:56 INFO - Running post-action listener: _resource_record_post_action 08:32:56 INFO - Running post-action listener: set_extra_try_arguments 08:32:56 INFO - [mozharness: 2017-05-05 15:32:56.497391Z] Finished download-and-extract step (success) 08:32:56 INFO - [mozharness: 2017-05-05 15:32:56.497491Z] Running populate-webroot step. 08:32:56 INFO - Running pre-action listener: _resource_record_pre_action 08:32:56 INFO - Running main action method: populate_webroot 08:32:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:56 INFO - '--tppagecycles', 08:32:56 INFO - '7'], 08:32:56 INFO - 'tests': ['tsvgm']}}, 08:32:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:32:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:32:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:32:56 INFO - 'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:32:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:32:56 INFO - 'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['damp', 'tps']}, 08:32:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:32:56 INFO - 'tests': ['damp', 'tps']}, 08:32:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['dromaeo_dom']}, 08:32:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:32:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:32:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['a11yr', 08:32:56 INFO - 'ts_paint', 08:32:56 INFO - 'tpaint', 08:32:56 INFO - 'sessionrestore', 08:32:56 INFO - 'sessionrestore_no_auto_restore', 08:32:56 INFO - 'tabpaint']}, 08:32:56 INFO - 'other-e10s': {'tests': ['a11yr', 08:32:56 INFO - 'ts_paint', 08:32:56 INFO - 'tpaint', 08:32:56 INFO - 'sessionrestore', 08:32:56 INFO - 'sessionrestore_no_auto_restore', 08:32:56 INFO - 'tabpaint']}, 08:32:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:32:56 INFO - 'ts_paint', 08:32:56 INFO - 'tpaint', 08:32:56 INFO - 'sessionrestore', 08:32:56 INFO - 'sessionrestore_no_auto_restore', 08:32:56 INFO - 'tabpaint']}, 08:32:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:32:56 INFO - 'ts_paint', 08:32:56 INFO - 'tpaint', 08:32:56 INFO - 'sessionrestore', 08:32:56 INFO - 'sessionrestore_no_auto_restore', 08:32:56 INFO - 'tabpaint']}, 08:32:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['a11yr', 08:32:56 INFO - 'ts_paint', 08:32:56 INFO - 'tpaint', 08:32:56 INFO - 'sessionrestore', 08:32:56 INFO - 'sessionrestore_no_auto_restore', 08:32:56 INFO - 'tabpaint']}, 08:32:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['a11yr', 08:32:56 INFO - 'ts_paint', 08:32:56 INFO - 'tpaint', 08:32:56 INFO - 'sessionrestore', 08:32:56 INFO - 'sessionrestore_no_auto_restore', 08:32:56 INFO - 'tabpaint']}, 08:32:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:32:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:32:56 INFO - 'bloom_basic_ref']}, 08:32:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['tsvgx', 08:32:56 INFO - 'tsvgr_opacity', 08:32:56 INFO - 'tart', 08:32:56 INFO - 'tscrollx', 08:32:56 INFO - 'cart', 08:32:56 INFO - 'tsvg_static']}, 08:32:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:32:56 INFO - 'tsvgr_opacity', 08:32:56 INFO - 'tart', 08:32:56 INFO - 'tscrollx', 08:32:56 INFO - 'cart', 08:32:56 INFO - 'tsvg_static']}, 08:32:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:32:56 INFO - 'talos_options': ['--disable-e10s'], 08:32:56 INFO - 'tests': ['tp5o']}, 08:32:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:32:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:32:56 INFO - 'talos_options': ['--disable-e10s', 08:32:56 INFO - '--xperf_path', 08:32:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:56 INFO - 'tests': ['tp5n']}, 08:32:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:32:56 INFO - 'talos_options': ['--xperf_path', 08:32:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:56 INFO - 'tests': ['tp5n']}}, 08:32:56 INFO - 'talos.zip': {'path': '', 08:32:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:56 INFO - Running post-action listener: _resource_record_post_action 08:32:56 INFO - [mozharness: 2017-05-05 15:32:56.511126Z] Finished populate-webroot step (success) 08:32:56 INFO - [mozharness: 2017-05-05 15:32:56.511215Z] Running create-virtualenv step. 08:32:56 INFO - Running pre-action listener: _resource_record_pre_action 08:32:56 INFO - Running main action method: create_virtualenv 08:32:56 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:32:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:56 INFO - Using real prefix '/usr' 08:32:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:59 INFO - Installing pip.................done. 08:32:59 INFO - Return code: 0 08:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:32:59 INFO - Reading from file tmpfile_stdout 08:32:59 INFO - Output received: 08:32:59 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:32:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xeb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, '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': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', '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 08:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:32:59 INFO - Using env: {'DISPLAY': ':0', 08:32:59 INFO - 'HOME': '/home/cltbld', 08:32:59 INFO - 'LANG': 'en_US.UTF-8', 08:32:59 INFO - 'LANGUAGE': 'en_US:en', 08:32:59 INFO - 'LOGNAME': 'cltbld', 08:32:59 INFO - 'MAIL': '/var/mail/cltbld', 08:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:59 INFO - 'MOZ_NO_REMOTE': '1', 08:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:59 INFO - 'NO_EM_RESTART': '1', 08:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:59 INFO - 'PWD': '/builds/slave/test', 08:32:59 INFO - 'SHELL': '/bin/bash', 08:32:59 INFO - 'SHLVL': '1', 08:32:59 INFO - 'TERM': 'linux', 08:32:59 INFO - 'TMOUT': '86400', 08:32:59 INFO - 'USER': 'cltbld', 08:32:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:59 INFO - '_': '/tools/buildbot/bin/python'} 08:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:32:59 INFO - Cleaning up... 08:32:59 INFO - Return code: 0 08:32:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xeb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, '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': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', '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 08:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:32:59 INFO - Using env: {'DISPLAY': ':0', 08:32:59 INFO - 'HOME': '/home/cltbld', 08:32:59 INFO - 'LANG': 'en_US.UTF-8', 08:32:59 INFO - 'LANGUAGE': 'en_US:en', 08:32:59 INFO - 'LOGNAME': 'cltbld', 08:32:59 INFO - 'MAIL': '/var/mail/cltbld', 08:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:59 INFO - 'MOZ_NO_REMOTE': '1', 08:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:59 INFO - 'NO_EM_RESTART': '1', 08:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:59 INFO - 'PWD': '/builds/slave/test', 08:32:59 INFO - 'SHELL': '/bin/bash', 08:32:59 INFO - 'SHLVL': '1', 08:32:59 INFO - 'TERM': 'linux', 08:32:59 INFO - 'TMOUT': '86400', 08:32:59 INFO - 'USER': 'cltbld', 08:32:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:59 INFO - '_': '/tools/buildbot/bin/python'} 08:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:59 INFO - Downloading/unpacking psutil>=3.1.1 08:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:33:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:00 INFO - Installing collected packages: psutil 08:33:00 INFO - Running setup.py install for psutil 08:33:00 INFO - building 'psutil._psutil_linux' extension 08:33:00 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 08:33:01 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 08:33:01 INFO - building 'psutil._psutil_posix' extension 08:33:01 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 08:33:01 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 08:33:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:01 INFO - Successfully installed psutil 08:33:01 INFO - Cleaning up... 08:33:01 INFO - Return code: 0 08:33:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xeb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, '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': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', '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 08:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:33:01 INFO - Using env: {'DISPLAY': ':0', 08:33:01 INFO - 'HOME': '/home/cltbld', 08:33:01 INFO - 'LANG': 'en_US.UTF-8', 08:33:01 INFO - 'LANGUAGE': 'en_US:en', 08:33:01 INFO - 'LOGNAME': 'cltbld', 08:33:01 INFO - 'MAIL': '/var/mail/cltbld', 08:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:01 INFO - 'MOZ_NO_REMOTE': '1', 08:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:01 INFO - 'NO_EM_RESTART': '1', 08:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:01 INFO - 'PWD': '/builds/slave/test', 08:33:01 INFO - 'SHELL': '/bin/bash', 08:33:01 INFO - 'SHLVL': '1', 08:33:01 INFO - 'TERM': 'linux', 08:33:01 INFO - 'TMOUT': '86400', 08:33:01 INFO - 'USER': 'cltbld', 08:33:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:01 INFO - '_': '/tools/buildbot/bin/python'} 08:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:33:01 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 08:33:01 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 08:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:01 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 08:33:01 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 08:33:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:33:02 INFO - Installing collected packages: mozsystemmonitor 08:33:02 INFO - Running setup.py install for mozsystemmonitor 08:33:02 INFO - Successfully installed mozsystemmonitor 08:33:02 INFO - Cleaning up... 08:33:02 INFO - Return code: 0 08:33:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xeb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, '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': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', '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 08:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:33:02 INFO - Using env: {'DISPLAY': ':0', 08:33:02 INFO - 'HOME': '/home/cltbld', 08:33:02 INFO - 'LANG': 'en_US.UTF-8', 08:33:02 INFO - 'LANGUAGE': 'en_US:en', 08:33:02 INFO - 'LOGNAME': 'cltbld', 08:33:02 INFO - 'MAIL': '/var/mail/cltbld', 08:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:02 INFO - 'MOZ_NO_REMOTE': '1', 08:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:02 INFO - 'NO_EM_RESTART': '1', 08:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:02 INFO - 'PWD': '/builds/slave/test', 08:33:02 INFO - 'SHELL': '/bin/bash', 08:33:02 INFO - 'SHLVL': '1', 08:33:02 INFO - 'TERM': 'linux', 08:33:02 INFO - 'TMOUT': '86400', 08:33:02 INFO - 'USER': 'cltbld', 08:33:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:02 INFO - '_': '/tools/buildbot/bin/python'} 08:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:03 INFO - Downloading/unpacking jsonschema==2.5.1 08:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:33:04 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 08:33:04 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 08:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:04 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 08:33:04 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 08:33:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:04 INFO - warning: no files found matching '*.txt' 08:33:04 INFO - no previously-included directories found matching 'build' 08:33:04 INFO - no previously-included directories found matching 'dist' 08:33:04 INFO - no previously-included directories found matching '.git*' 08:33:04 INFO - Installing collected packages: jsonschema, functools32 08:33:04 INFO - Running setup.py install for functools32 08:33:04 INFO - warning: no files found matching '*.txt' 08:33:04 INFO - no previously-included directories found matching 'build' 08:33:04 INFO - no previously-included directories found matching 'dist' 08:33:04 INFO - no previously-included directories found matching '.git*' 08:33:04 INFO - Successfully installed jsonschema functools32 08:33:04 INFO - Cleaning up... 08:33:04 INFO - Return code: 0 08:33:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xeb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, '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': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', '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 08:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:33:04 INFO - Using env: {'DISPLAY': ':0', 08:33:04 INFO - 'HOME': '/home/cltbld', 08:33:04 INFO - 'LANG': 'en_US.UTF-8', 08:33:04 INFO - 'LANGUAGE': 'en_US:en', 08:33:04 INFO - 'LOGNAME': 'cltbld', 08:33:04 INFO - 'MAIL': '/var/mail/cltbld', 08:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:04 INFO - 'MOZ_NO_REMOTE': '1', 08:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:04 INFO - 'NO_EM_RESTART': '1', 08:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:04 INFO - 'PWD': '/builds/slave/test', 08:33:04 INFO - 'SHELL': '/bin/bash', 08:33:04 INFO - 'SHLVL': '1', 08:33:04 INFO - 'TERM': 'linux', 08:33:04 INFO - 'TMOUT': '86400', 08:33:04 INFO - 'USER': 'cltbld', 08:33:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:04 INFO - '_': '/tools/buildbot/bin/python'} 08:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:33:04 INFO - Cleaning up... 08:33:04 INFO - Return code: 0 08:33:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xeb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, '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': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', '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 08:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:33:04 INFO - Using env: {'DISPLAY': ':0', 08:33:04 INFO - 'HOME': '/home/cltbld', 08:33:04 INFO - 'LANG': 'en_US.UTF-8', 08:33:04 INFO - 'LANGUAGE': 'en_US:en', 08:33:04 INFO - 'LOGNAME': 'cltbld', 08:33:04 INFO - 'MAIL': '/var/mail/cltbld', 08:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:04 INFO - 'MOZ_NO_REMOTE': '1', 08:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:04 INFO - 'NO_EM_RESTART': '1', 08:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:04 INFO - 'PWD': '/builds/slave/test', 08:33:04 INFO - 'SHELL': '/bin/bash', 08:33:04 INFO - 'SHLVL': '1', 08:33:04 INFO - 'TERM': 'linux', 08:33:04 INFO - 'TMOUT': '86400', 08:33:04 INFO - 'USER': 'cltbld', 08:33:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:04 INFO - '_': '/tools/buildbot/bin/python'} 08:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:05 INFO - Downloading/unpacking blobuploader==1.2.4 08:33: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 08:33: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 08:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33: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 08:33: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 08:33:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:33:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:33:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:06 INFO - Downloading docopt-0.6.1.tar.gz 08:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:33:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:33:06 INFO - Running setup.py install for blobuploader 08:33:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:33:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:33:06 INFO - Running setup.py install for requests 08:33:07 INFO - Running setup.py install for docopt 08:33:07 INFO - Successfully installed blobuploader requests docopt 08:33:07 INFO - Cleaning up... 08:33:07 INFO - Return code: 0 08:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xeb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, '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': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', '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 08:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:07 INFO - Using env: {'DISPLAY': ':0', 08:33:07 INFO - 'HOME': '/home/cltbld', 08:33:07 INFO - 'LANG': 'en_US.UTF-8', 08:33:07 INFO - 'LANGUAGE': 'en_US:en', 08:33:07 INFO - 'LOGNAME': 'cltbld', 08:33:07 INFO - 'MAIL': '/var/mail/cltbld', 08:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:07 INFO - 'MOZ_NO_REMOTE': '1', 08:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:07 INFO - 'NO_EM_RESTART': '1', 08:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:07 INFO - 'PWD': '/builds/slave/test', 08:33:07 INFO - 'SHELL': '/bin/bash', 08:33:07 INFO - 'SHLVL': '1', 08:33:07 INFO - 'TERM': 'linux', 08:33:07 INFO - 'TMOUT': '86400', 08:33:07 INFO - 'USER': 'cltbld', 08:33:07 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:07 INFO - '_': '/tools/buildbot/bin/python'} 08:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:07 INFO - Running setup.py (path:/tmp/pip-YsULNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:07 INFO - Running setup.py (path:/tmp/pip-ms1rng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:07 INFO - Running setup.py (path:/tmp/pip-qBVL4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:07 INFO - Running setup.py (path:/tmp/pip-wAsmVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:08 INFO - Running setup.py (path:/tmp/pip-77GJxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:08 INFO - Running setup.py (path:/tmp/pip-7RkkiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:08 INFO - Running setup.py (path:/tmp/pip-w7CSPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:08 INFO - Running setup.py (path:/tmp/pip-cKNykv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:08 INFO - Running setup.py (path:/tmp/pip-hJ0j9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:08 INFO - Running setup.py (path:/tmp/pip-MKgUbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:08 INFO - Running setup.py (path:/tmp/pip-Iy2Sh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:08 INFO - Running setup.py (path:/tmp/pip-9Q1pmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:08 INFO - Running setup.py (path:/tmp/pip-IgY7Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:08 INFO - Running setup.py (path:/tmp/pip-jbylwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:08 INFO - Running setup.py (path:/tmp/pip-3zU2B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:08 INFO - Running setup.py (path:/tmp/pip-OyTPqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:08 INFO - Running setup.py (path:/tmp/pip-TaBAX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:08 INFO - Running setup.py install for manifestparser 08:33:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:33:09 INFO - Running setup.py install for mozcrash 08:33:09 INFO - Running setup.py install for mozdebug 08:33:09 INFO - Running setup.py install for mozdevice 08:33:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:33:09 INFO - Running setup.py install for mozfile 08:33:09 INFO - Running setup.py install for mozhttpd 08:33:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:33:09 INFO - Running setup.py install for mozinfo 08:33:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:33:09 INFO - Running setup.py install for mozInstall 08:33:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:33:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:33:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:33:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:33:09 INFO - Running setup.py install for mozleak 08:33:09 INFO - Running setup.py install for mozlog 08:33:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:33:09 INFO - Running setup.py install for moznetwork 08:33:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:33:10 INFO - Running setup.py install for mozprocess 08:33:10 INFO - Running setup.py install for mozprofile 08:33:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:33:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:33:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:33:10 INFO - Running setup.py install for mozrunner 08:33:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:33:10 INFO - Running setup.py install for mozscreenshot 08:33:10 INFO - Running setup.py install for moztest 08:33:10 INFO - Running setup.py install for mozversion 08:33:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:33:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:10 INFO - Cleaning up... 08:33:10 INFO - Return code: 0 08:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xeb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, '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': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', '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 08:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:10 INFO - Using env: {'DISPLAY': ':0', 08:33:10 INFO - 'HOME': '/home/cltbld', 08:33:10 INFO - 'LANG': 'en_US.UTF-8', 08:33:10 INFO - 'LANGUAGE': 'en_US:en', 08:33:10 INFO - 'LOGNAME': 'cltbld', 08:33:10 INFO - 'MAIL': '/var/mail/cltbld', 08:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:10 INFO - 'MOZ_NO_REMOTE': '1', 08:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:10 INFO - 'NO_EM_RESTART': '1', 08:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:10 INFO - 'PWD': '/builds/slave/test', 08:33:10 INFO - 'SHELL': '/bin/bash', 08:33:10 INFO - 'SHLVL': '1', 08:33:10 INFO - 'TERM': 'linux', 08:33:10 INFO - 'TMOUT': '86400', 08:33:10 INFO - 'USER': 'cltbld', 08:33:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:10 INFO - '_': '/tools/buildbot/bin/python'} 08:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:10 INFO - Running setup.py (path:/tmp/pip-Oy0loU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:11 INFO - Running setup.py (path:/tmp/pip-bm99Qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:11 INFO - Running setup.py (path:/tmp/pip-nhPQSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:11 INFO - Running setup.py (path:/tmp/pip-6CDLzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:11 INFO - Running setup.py (path:/tmp/pip-VQXJQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:11 INFO - Running setup.py (path:/tmp/pip-Bfl7xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:11 INFO - Running setup.py (path:/tmp/pip-ZL0Lhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:11 INFO - Running setup.py (path:/tmp/pip-Q2Pbtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:11 INFO - Running setup.py (path:/tmp/pip-uhf5zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:11 INFO - Running setup.py (path:/tmp/pip-1QECMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:11 INFO - Running setup.py (path:/tmp/pip-yYc6Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:11 INFO - Running setup.py (path:/tmp/pip-PYXv9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:11 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)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:11 INFO - Running setup.py (path:/tmp/pip-XmNp0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:11 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)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:11 INFO - Running setup.py (path:/tmp/pip-x67tFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:11 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)) 08:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:11 INFO - Running setup.py (path:/tmp/pip-ZD6dtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:12 INFO - Running setup.py (path:/tmp/pip-IU8xqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:12 INFO - Running setup.py (path:/tmp/pip-BMGsPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:13 INFO - Downloading blessings-1.6.tar.gz 08:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:13 INFO - Installing collected packages: blessings 08:33:13 INFO - Running setup.py install for blessings 08:33:13 INFO - Successfully installed blessings 08:33:13 INFO - Cleaning up... 08:33:13 INFO - Return code: 0 08:33:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:13 INFO - Reading from file tmpfile_stdout 08:33:13 INFO - Current package versions: 08:33:13 INFO - argparse == 1.2.1 08:33:13 INFO - blessings == 1.6 08:33:13 INFO - blobuploader == 1.2.4 08:33:13 INFO - docopt == 0.6.1 08:33:13 INFO - functools32 == 3.2.3-2 08:33:13 INFO - jsonschema == 2.5.1 08:33:13 INFO - manifestparser == 1.1 08:33:13 INFO - mozInstall == 1.12 08:33:13 INFO - mozcrash == 1.0 08:33:13 INFO - mozdebug == 0.1 08:33:13 INFO - mozdevice == 0.50 08:33:13 INFO - mozfile == 1.2 08:33:13 INFO - mozhttpd == 0.7 08:33:13 INFO - mozinfo == 0.9 08:33:13 INFO - mozleak == 0.1 08:33:13 INFO - mozlog == 3.4 08:33:13 INFO - moznetwork == 0.27 08:33:13 INFO - mozprocess == 0.25 08:33:13 INFO - mozprofile == 0.28 08:33:13 INFO - mozrunner == 6.13 08:33:13 INFO - mozscreenshot == 0.1 08:33:13 INFO - mozsystemmonitor == 0.3 08:33:13 INFO - moztest == 0.8 08:33:13 INFO - mozversion == 1.4 08:33:13 INFO - psutil == 3.1.1 08:33:13 INFO - requests == 1.2.3 08:33:13 INFO - wsgiref == 0.1.2 08:33:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xeb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, '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': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', '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 08:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:13 INFO - Using env: {'DISPLAY': ':0', 08:33:13 INFO - 'HOME': '/home/cltbld', 08:33:13 INFO - 'LANG': 'en_US.UTF-8', 08:33:13 INFO - 'LANGUAGE': 'en_US:en', 08:33:13 INFO - 'LOGNAME': 'cltbld', 08:33:13 INFO - 'MAIL': '/var/mail/cltbld', 08:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:13 INFO - 'MOZ_NO_REMOTE': '1', 08:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:13 INFO - 'NO_EM_RESTART': '1', 08:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:13 INFO - 'PWD': '/builds/slave/test', 08:33:13 INFO - 'SHELL': '/bin/bash', 08:33:13 INFO - 'SHLVL': '1', 08:33:13 INFO - 'TERM': 'linux', 08:33:13 INFO - 'TMOUT': '86400', 08:33:13 INFO - 'USER': 'cltbld', 08:33:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:13 INFO - '_': '/tools/buildbot/bin/python'} 08:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:13 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)) 08:33:13 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)) 08:33:13 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)) 08:33:13 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)) 08:33:13 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)) 08:33:13 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)) 08:33:13 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)) 08:33:13 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)) 08:33:13 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)) 08:33:13 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)) 08:33:13 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)) 08:33:13 INFO - Cleaning up... 08:33:13 INFO - Return code: 0 08:33:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:13 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0xeb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, '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': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', '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 08:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:33:13 INFO - Using env: {'DISPLAY': ':0', 08:33:13 INFO - 'HOME': '/home/cltbld', 08:33:13 INFO - 'LANG': 'en_US.UTF-8', 08:33:13 INFO - 'LANGUAGE': 'en_US:en', 08:33:13 INFO - 'LOGNAME': 'cltbld', 08:33:13 INFO - 'MAIL': '/var/mail/cltbld', 08:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:13 INFO - 'MOZ_NO_REMOTE': '1', 08:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:13 INFO - 'NO_EM_RESTART': '1', 08:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:13 INFO - 'PWD': '/builds/slave/test', 08:33:13 INFO - 'SHELL': '/bin/bash', 08:33:13 INFO - 'SHLVL': '1', 08:33:13 INFO - 'TERM': 'linux', 08:33:13 INFO - 'TMOUT': '86400', 08:33:13 INFO - 'USER': 'cltbld', 08:33:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:13 INFO - '_': '/tools/buildbot/bin/python'} 08:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:33:14 INFO - Cleaning up... 08:33:14 INFO - Return code: 0 08:33:14 INFO - Running post-action listener: _resource_record_post_action 08:33:14 INFO - Running post-action listener: _start_resource_monitoring 08:33:14 INFO - Starting resource monitoring. 08:33:14 INFO - [mozharness: 2017-05-05 15:33:14.229445Z] Finished create-virtualenv step (success) 08:33:14 INFO - [mozharness: 2017-05-05 15:33:14.229980Z] Running install step. 08:33:14 INFO - Running pre-action listener: _resource_record_pre_action 08:33:14 INFO - Running main action method: install 08:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:14 INFO - Reading from file tmpfile_stdout 08:33:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:33:14 INFO - Reading from file tmpfile_stdout 08:33:14 INFO - Output received: 08:33:14 INFO - Usage: mozinstall [options] installer 08:33:14 INFO - Options: 08:33:14 INFO - -h, --help show this help message and exit 08:33:14 INFO - -d DEST, --destination=DEST 08:33:14 INFO - Directory to install application into. [default: 08:33:14 INFO - "/builds/slave/test"] 08:33:14 INFO - --app=APP Application being installed. [default: firefox] 08:33:14 INFO - mkdir: /builds/slave/test/build/application 08:33:14 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'] 08:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:33:29 INFO - Reading from file tmpfile_stdout 08:33:29 INFO - Output received: 08:33:29 INFO - /builds/slave/test/build/application/firefox/firefox 08:33:29 INFO - Running post-action listener: _resource_record_post_action 08:33:29 INFO - [mozharness: 2017-05-05 15:33:29.374323Z] Finished install step (success) 08:33:29 INFO - [mozharness: 2017-05-05 15:33:29.374601Z] Running run-tests step. 08:33:29 INFO - Running pre-action listener: _resource_record_pre_action 08:33:29 INFO - Running main action method: run_tests 08:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:29 INFO - Python 2.7.3 08:33:29 INFO - Return code: 0 08:33:29 INFO - grabbing minidump binary from tooltool 08:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:33:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b290>, '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 0x114bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114c040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:33:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:33:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:33:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:29 INFO - Return code: 0 08:33:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:33:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:29 INFO - ENV: RUST_BACKTRACE is now 1 08:33:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:33:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:33:29 INFO - Using env: {'DISPLAY': ':0', 08:33:29 INFO - 'HOME': '/home/cltbld', 08:33:29 INFO - 'LANG': 'en_US.UTF-8', 08:33:29 INFO - 'LANGUAGE': 'en_US:en', 08:33:29 INFO - 'LOGNAME': 'cltbld', 08:33:29 INFO - 'MAIL': '/var/mail/cltbld', 08:33:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:29 INFO - 'MOZ_NO_REMOTE': '1', 08:33:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:29 INFO - 'NO_EM_RESTART': '1', 08:33:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:29 INFO - 'PWD': '/builds/slave/test', 08:33:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:29 INFO - 'RUST_BACKTRACE': '1', 08:33:29 INFO - 'SHELL': '/bin/bash', 08:33:29 INFO - 'SHLVL': '1', 08:33:29 INFO - 'TERM': 'linux', 08:33:29 INFO - 'TMOUT': '86400', 08:33:29 INFO - 'USER': 'cltbld', 08:33:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1493996357.873603-963067919', 08:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:29 INFO - '_': '/tools/buildbot/bin/python'} 08:33:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:33:29 INFO - mozversion application_buildid: 20170505150510 08:33:29 INFO - mozversion application_changeset: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 08:33:29 INFO - mozversion application_display_name: Nightly 08:33:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:29 INFO - mozversion application_name: Firefox 08:33:29 INFO - mozversion application_remotingname: firefox 08:33:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:33:29 INFO - mozversion application_vendor: Mozilla 08:33:29 INFO - mozversion application_version: 55.0a1 08:33:29 INFO - mozversion platform_buildid: 20170505150510 08:33:29 INFO - mozversion platform_changeset: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 08:33:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:33:29 INFO - mozversion platform_version: 55.0a1 08:33:29 INFO - using testdate: 1493998409 08:33:29 INFO - actual date: 1493998409 08:33:29 INFO - starting webserver on 'localhost:56228' 08:33:29 INFO - SUITE-START | Running 2 tests 08:33:29 INFO - TEST-START | dromaeo_css 08:33:29 INFO - operating with platform_type : linux_ 08:33:29 INFO - Initialising browser for dromaeo_css test... 08:33:29 INFO - TEST-INFO | started process 30372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz6Vj7P/profile http://localhost:56228/getInfo.html) 08:33:33 INFO - PID 30372 | __metrics Screen width/height:1600/1200 08:33:33 INFO - PID 30372 | colorDepth:24 08:33:33 INFO - PID 30372 | Browser inner width/height: 1024/695 08:33:33 INFO - PID 30372 | __metrics 08:33:36 INFO - TEST-INFO | 30372: exit 0 08:33:36 INFO - Browser initialized. 08:33:36 INFO - Running cycle 1/1 for dromaeo_css test... 08:33:36 INFO - TEST-INFO | started process 30540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz6Vj7P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:48 INFO - PID 30540 | RSS: Main: 159637504 08:33:48 INFO - PID 30540 | 08:36:51 INFO - PID 30540 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56228/tests/dromaeo/cssquery-ext.html) 08:36:54 INFO - PID 30540 | RSS: Main: 164601856 08:36:54 INFO - PID 30540 | 08:39:57 INFO - PID 30540 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-ext.html (next: http://localhost:56228/tests/dromaeo/cssquery-jquery.html) 08:39:57 INFO - PID 30540 | RSS: Main: 158781440 08:39:57 INFO - PID 30540 | 08:42:59 INFO - PID 30540 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56228/tests/dromaeo/cssquery-mootools.html) 08:43:00 INFO - PID 30540 | RSS: Main: 166854656 08:43:00 INFO - PID 30540 | 08:46:02 INFO - PID 30540 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56228/tests/dromaeo/cssquery-prototype.html) 08:46:02 INFO - PID 30540 | RSS: Main: 159473664 08:46:02 INFO - PID 30540 | 08:49:05 INFO - PID 30540 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56228/tests/dromaeo/cssquery-yui.html) 08:49:06 INFO - PID 30540 | RSS: Main: 162430976 08:49:06 INFO - PID 30540 | 08:52:08 INFO - PID 30540 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-yui.html (next: http://localhost:56228/tests/dromaeo/cssquery-dojo.html) 08:52:08 INFO - PID 30540 | RSS: Main: 165855232 08:52:08 INFO - PID 30540 | 08:52:08 INFO - PID 30540 | __start_tp_report 08:52:08 INFO - PID 30540 | _x_x_mozilla_page_load 08:52:08 INFO - PID 30540 | _x_x_mozilla_page_load_details 08:52:08 INFO - PID 30540 | |i|pagename|runs| 08:52:08 INFO - PID 30540 | |0;dojo.html;2722.904698335559;2734.38476342823;2743.7804975601953;2755;2766.225456872076;5105.106606343894;5141.22881567765;5146.176611742122;5240.737963101848;5264.341957255343;5210.400803907552;5226.686398816074;5234.79060837567;5309.442508536606;5310.840674779763;4618.815247390117;4637.65217608679;4651.279051746985;4658.371119898804;4674.672772905898;4660.906781864361;4664.626829853603;4700.130475861959;4712.552307530779;4717.882052948687;4547.727136371828;4607.401037865089;4626.958934239803;4640.466346370177;4677.976610116962;4667.066586682677;4667.113248482778;4668.813247470097;4703.270992996091;4724.480307166244;4577.725336479822;4646.465656449518;4649.372334734835;4650.441946966352;4672.182368085571;5158.148905430599;5167.302414174076;5177.974110129463;5229.633925625208;5232.92150617741;5531.3915469298345;5563.833085007456;5672.773089076473;5674.233978412903;5683.0338842396895;5593.049181639131;5609.1305847593685;5646.6894320812335;5655.0386434306265;5682.40334764852;5206.791728330824;5212.843614691566;5215.942395524918;5227.2420499028185;5227.817026404057;5595.7481913313995;5729.455701708331;5735.311762588432;5744.540436765133;5774.249347584787;5481.232627432163;5542.584306177053;5559.610827242135;5599.720013999366;5602.1036634138345;5558.638688485235;5573.359063707644;5582.218489411485;5600.355959064678;5619.494245517842;5446.128619420873;5501.257330260363;5504.6421982571;5510.779568817283;5614.354349249807;5460.372057213392;5512.586556008316;5539.861503462445;5546.889062218733;5570.053090974544;4547.47704014036;4549.839790853312;4552.271636538138;4559.635229181657;4599.08018396322;3922.4116382542848;3932.9213415731524;3951.209758048344;3976.324024915771;3986;4691.296305554194;4759.309900064472;4833.637477189154;4889.926651100236;4902.166631672624;5592.273004509388;5641.576881733887;5646.011947909182;5648.6893220872425;5688.260526131659;4822.7829747661435;4832.44426890912;4834.250691142878;4835.903281934412;4839.322494850724;4886.047220791983;4948.455669876239;4950.554450099508;4951.752412379366;4953.6037117030555;5245.160774276097;5267.89464210706;5270.78916843322;5300.443453437333;5306.442823503477;5597.3003374578175;5650.773969041356;5650.943490565206;5652.180433837153;5658.490735833795;5295.364556253275;5314.22943673173;5315.6279060465395;5338.733063346895;5353.170258609922;5435.809746658848;5536.280283563111;5559.0827513461445;5573.164025396223;5573.665580065209;5496.780128794803;5553.888922221614;5655.915161272502;5685.857853553694;5733.684647344436;5423.430539793265;5427.267318911896;5459.044667183148;5469.2616496772425;5491.560675146058;5421.7560209791445;5447.455254474521;5454.481824226692;5459.317585301837;5466;5335.813246536508;5352.919706204488;5390.946090539202;5393.110136827379;5424.864378390572;5466.535344495763;5498.340199176125;5509.173623956439;5510.980468613319;5524.8342549723575;5350.357957045179;5388.622796404214;5405.027095122916;5447.455254474521;5454.836354909359 08:52:08 INFO - PID 30540 | |1;ext.html;734.8126227811908;757.651480319053;1056.2553399853105;1072.5280876414377;1140.3215087023218;32309.515357269658;33107.17232069199;33491.49762753557;33578;33578.8321058395;30822.84588577054;31128;31199.68800311996;31224.21939451515;31251.531227031614;6419.518536109787;6472.741090356392;6589.769358072468;6607.834804129911;7014.123234595676;7024.473164512657;7058.964705176492;7119.9288007119785;7122.465815063865;7141.071660684104;7088.85822283554;7168.462365322622;7171.390431813302;7175.067241258629;7189.137303523585;7048.788536343918;7087;7103.573785572857;7137.643117844113;7140.5358651687475;6961.930380696179;6970.571032938286;7043.68303426347;7058.435325173974;7059.364657180879;32152.6784732152;32267.193320167185;32388.676113238802;32480;32501.51247731286;3068.8312142832137;3102.348506813572;3111.1444352802932;3131.01373067483;3131.18589166816;24882.253532394057;24886.5022699545;24894;24912;24984.250472485855;2575.3947822261753;2602.10227471522;2633.7629613334893;2637.31429828246;2644.7090820009785;146854;147424;147573.2621336897;148323;148750;38247.23505529874;40282.39576406356;40312.59687403088;40934.59065409308;41134.177316453504;41951;41991.79004105021;42051.36922946158;42080.158396831896;42099;11064.889351106547;11312.94343528277;11313.547458101748;11332.943335283435;11363.431828408711;8904;9170.495622740813;9231.861522077174;9233.492157931378;9241.445513269226;12986.220826750425;12989;13090.280034598189;13150.802737958938;13209.207447553177;5335.919961200585;5406.6215364924865;5440.755166017539;5516;5528.889422211614;860.6428332242175;893.3746377535621;913.0230653201011;914.337105598449;947.545178314413;20078.498037548885;21387.8930605346;21757.456063598536;25201;26208.73791262101;970.3547141151056;973.8149751547184;991.613270824379;994.4530508220449;998.276249718948;11194.944025279821;11487.827682584768;11536.884631153749;11560.479778409992;11681.415929203677;173235;175439;175491.12254438645;175728;175987;39352.60647393547;39359;39368.409473857915;39761.80119099444;39810.800945995084;1197.4192516629428;1235.8949489293511;1237.2205510528308;1237.8824011718873;1248.219862585884;19725.112369943676;19927.800721993175;20019;20970.790292097496;21176.152953882287;29794.553081704224;29985;30077.3984520304;30089.796408144306;30093;141176;158664;159009;159985;160115;31353;31444.685553144176;31504.684953150176;31541.36917261688;31828;36732.44901326429;37400.43899341457;37689.24621507609;37854;37989.81005095068;28986.855065724536;29497.557536637396;29593.26016849596;29929.850350748107;30364.544531831598;28224.85887570549;28326.43347133087;29021.274468138465;29457.558136628395;29702;31717.841410792797;31815.522767158975;31856.840715796272;31963;32043.839780801878;26587.33531661724;27505.587416189173;27903.441931160858;28151.71848281573;28210.85894570514;22319.218827340967;23202.41993950097;23369.182078627848;23466.296011119695;23478.29565112981 08:52:08 INFO - PID 30540 | |2;jquery.html;418.92249933762236;422.93947688564464;425.26004751731983;438.2221556736792;451.952544982777;17000.4049858255;17235.74146387805;17866.106694665265;18492.167852446637;18781.718274225863;18538.53653658656;18754.624907501875;18877.433676989676;18971.90514047431;18983.33558325459;5393.6763794172275;5409.29679141711;5625.46558076982;5627.7467513961765;5648.802291919784;5466.070767969435;5581.525570326507;5602;5606.523445507137;5610.607257491977;5332.973335133319;5476.452354764531;5521.861953451155;5528.226048353234;5547.583931205156;5487.890242195133;5555;5610.943890561083;5615;5615.803446879339;4975.925361119586;5030.270610761419;5049.974750126263;5060.645754797166;5089.185730283174;21643.134274628996;21740;21796.45508862275;21832.78167218339;21933.670994935088;1629.722947098996;1645.539249010267;1657.5773177839694;1658.071479971208;1658.8672906167599;14445.49440769568;14572.854271457361;15041.473548425862;15041.849581504155;15315.31081101353;1948.259661328686;2008.7489063867017;2068.1210485543734;2076.045019291128;2089.4671858676093;79774.60112699399;82853.17146828515;92900.53549732208;97311;100485.99999999927;11222.148345522897;11283.492242849092;11365.261258018203;11434.771304574027;11462.54149834014;15884.444044458389;15888.205589720468;15918.840811591735;15922.363105475883;15932.522024339289;7590.8861367079535;7723.884141737878;7813.804654883674;7912.960435197787;7941.6029198539845;6957.617331046841;6961.164660240804;7015.088038555057;7188.640567971581;7232.421406287484;7074.540154890019;7081.752138675121;7163.31948464895;7175.17485489165;7239.746608868664;2154.9353519394444;2156.2884248198056;2157.6979222908803;2159.427751645815;2261.0164578408117;840.3865178419787;857.3098655582191;859.4671303791564;867.1891781184487;884.1423818895661;17094.145292735564;17213.65572688564;17390;17581.472555823344;17908.104594770208;868.2272777228272;876.8816209811594;880.9955950220336;885.9246964008131;899.6896070855545;9271.747636207776;9583.664571739955;9697.399929011634;9768.21854251658;9864.309498335047;371468;371652;373163;374413;378446;75895;84886.57556712176;86026.56986715026;86999.56500217458;89124;1047.1047254597363;1068.4016950507742;1107.651089906693;1115.3921112993437;1118.765059337532;17624.471265862045;17809.73285400746;18495.167717452478;18562.236587524163;18606.255749769858;38608.80695596504;39579.60420395874;39697.2060558793;40362.798186008884;41201.79399103105;48516.7574162141;49789.75105124596;49990;50014.74992625014;53084.20373694475;8285.585720714062;8311;8330.791730206793;8448.788780280542;8778.824423511367;12727.427265773247;12936.741265174833;12937.676558086123;13341.332933353488;13348.86651133515;10049;10613.522391492555;10701.090407315465;10904.40025798557;11085.334879907232;9810.411375317504;9811.509424528887;9855.260855436014;9874.160696340605;10050.447225402673;11038;11162.888371116185;11303.604373846876;11453.370064646524;11546.787587303212;8378.413511054412;8423.620937057969;8592;8619.353548483763;8965.372423930263;10485.423301718478;10594.788104238027;10618.256722029384;11002.724931876766;11070.667879963614 08:52:08 INFO - PID 30540 | |3;mootools.html;1273.5669872243436;1310.5937159480561;1330.161997941297;1333.7265860498599;1337.3112846883857;9767.755806104842;10248.333858299206;10265.692029239126;10362;10598.576056957732;10355.37867727935;10512.369257844535;10520.000599943012;10543.261971661987;10570.735731606714;2265.6148454762647;2299.0458959531775;2300.033985725999;2304.596695578267;2311.133325003124;2169.425102347879;2216.944576385587;2244.259394399852;2245.045855511409;2255.8533695309834;2213.612617791888;2214.490667146549;2248.786365295294;2262.151693115082;2268.7844654757773;2131.9467013324634;2173.3262688566515;2182.4434769133927;2184.7050648162535;2187.1360812479143;2028.8985550722552;2162.3188695561007;2165.4153378587853;2199.9450013749624;2200.9889950550305;10228.284020118595;10300;10309.793804123876;10315.1747860171;10323.2257580681;5519.641223320471;5758.769649214027;5770.105633626795;5774.566907481955;5809.419058094199;3134.937301253985;3392.5589673342556;3413.6927676509235;3438.793672379665;3457.11843479911;981.9214462843026;1002.7192386131821;1003.4932359158652;1050.1965996013057;1051.7640594953123;15352.155631440379;15374.76937845922;15432.537023889301;15543;15567.610809729847;4670.602998745145;4806;5018.924716129261;5020.673656212334;5097.923531147036;11063.446827658585;11128.276662016942;11129.109671226282;11160;11174.776504470028;5588.692621905753;5658.74535645897;5659.236003139524;5680.147977803363;5687.829365119053;5076.873078173076;5131.897362052738;5165.708572856785;5167.457416971239;5257.106291930381;3893.124047089382;3929.1945151243926;3981.5222173339384;3993.7204395692024;4044.858429954996;1104.2491106047803;1114.9442527873737;1116.849225354583;1128.6839684888243;1128.6839684888243;701.6035939694057;723.5152447859947;728.8141523911369;736.495500582103;744.6053591596462;5614.747336369873;5635.915461268084;5679;5751.741171647286;5818.592698511148;548.0792268988058;567.5402923631872;568.692905830855;570.0650932470751;571.151839518315;3554.20030493137;3760.9247815043545;3914.197589494147;3919.725619206685;3933.449317095609;13125.212487250796;13776.724465510833;13807.51673691416;13829.377678004514;13845.723085538435;13119.672008199872;13290.800637990438;13497.797533037012;13618.86381136176;13694.452221911211;7656.61716914152;7717.65270562826;7882.211778822187;7886.250806173404;7905;6412;6498.545101843015;6524.902126468011;6585.308542603149;6671.099401580725;11967.341796201292;12181.147319687538;12320.568780093012;12422.37888105609;12554.372281386077;12197.207181533173;12415.875841241472;12545.686357841127;12564.37178141071;12688.555900543437;7846.293833555007;7942.12636609984;7948.642311095899;7961.124276329715;7993.6003199838615;9265.907340926504;9319.953400232955;9335.206507446943;9362.485063321583;9420.858687119562;8142.715004974797;8146.389020823581;8155.510669359857;8236.258736713724;8492.363072769444;7931.167227441267;8099.878501822595;8111.148329425561;8135.471194372347;8204.507729536246;7213.458990575623;7295.854082918206;7364.374028207448;7377.409807215303;7395.852082958419;5342.9465705342445;5343.412224655207;5472.480114389126;5525.309336332958;5581;5232.581393488588;5271.599818117216;5449.7275136243825;5502.642328248651;5514.310711161105 08:52:08 INFO - PID 30540 | |4;prototype.html;368.5006815764639;371.6525049079113;374.19921368271883;383.32343413874514;386.89940615439986;5434.809781657643;5475.123980163175;5499.615026948115;5535.813353725282;5618.15727640854;5279.947200527993;5410.834661722897;5415.404305526389;5420.539254163401;5429.239906413105;3981.8606348777653;4069.104796944675;4082.81627326771;4083.3262511685684;4101.302778527657;4080.1431699343175;4085.162541678949;4090.509138903336;4092.4270602115726;4101.651359634419;4056.0468289951837;4059.9594004059877;4066.125782956664;4076.30702780528;4083.12212874232;3912.68698504119;4058.79706014701;4076.408920706496;4076.6331030207275;4090.836366545335;3470.6355832637714;3527.94708079379;3532.452469867175;3539.7345199109914;3558.2705545363137;5292.126799078147;5311.203319502067;5317.2821669074565;5335.519803217729;5339.6262261641705;4728.196206644879;4736;4762.833300834489;4772.665913386064;4799.832005879777;5687.317521897398;5714.171445140431;5745.770169193227;5751;5783.768649254025;3982.3230050891416;3988.68090552758;3991.7804520751347;3994.3009973254566;4005.1589166275116;5909.290885093773;6066.787662431793;6084.30030546484;6153.661548614825;6155.969220153871;4022.35642297231;4025.718199725991;4030.972102113942;4044.2315959967514;4055.6958228133008;4103.5691252418665;4109.301418758818;4113.876583702494;4115.662409716854;4119.217348703737;4714.669973101919;4750.3398097065065;4760.523947605212;4765.928511072337;4778.402699662543;5761.366249712528;5767.769289228468;5786.247787787561;5791.276090488689;5795.8551036224435;1416.7249475471951;1416.886649068072;1424.2451500704642;1431.5633731711719;1437.3962935567088;909.3452714045876;942.5758408716105;953.6566835939195;963.8746962894779;968.864358989742;5029.597632189416;5092.439831618519;5097.64316497849;5105.897882042338;5113.74431278442;5943.881122377615;6035.305939816977;6047.818565443044;6061.605995610271;6070.575059745864;4868.294097355863;5063;5106.617003724736;5109.003744269906;5112.130937740593;3192.138122706856;3196.369851375815;3221.8711251550144;3224.500202468621;3226.757993150476;5434.212039254286;5559.388467268597;5569.192467092249;5593.944060559424;5681.801136960186;6148.631082135086;6182.319944806068;6207.286162091327;6212.968935155295;6230.314665386803;5492.478214569689;5641.689707066069;5657.2928383952;5679.3184817820475;5679.460451257207;6035.698215089315;6036.517078633611;6044.184035155197;6048.818535443944;6064.696765161812;5721.22763426932;5878.882422351615;5909.497692695997;5934.6350339421315;5948.5538584605465;5655.151727240782;5675.716214189357;5677.205191273142;5683.318001839806;5700.486956173964;4036.7577945323374;4039.293123703399;4041.474608300902;4044.2113787811095;4051.372037334218;5927.436893495111;6007.249093863267;6011.218541589566;6036.3058248302;6057.42454466825;5770.567207459373;5812.796552120655;5816.331121920864;5839.168003518205;5841.737121829443;5703.486686198262;5755.510781583613;5799.623024503562;5820.388859169896;5831.79588714393;5704.515116215168;5717.799877004285;5736.483716465538;5749.9712501437225;5758.2514273144225;5770.2498675171955;5865.912011319749;5884.735186916513;5887.1757953885635;5917.437843404869;5614.887702246014;5646.576506761927;5677.659340439422;5681.687507186979;5729.427057294237 08:52:08 INFO - PID 30540 | |5;yui.html;654.2280109470822;663.2207156591002;673.1451057157409;674.1741366825639;683.5181197255934;11330.093592512589;11669.299842009475;11672.47473863676;13169.868301316985;14555.417783288682;13634.795478067812;14366.712665746678;14724.6318842029;14749.188794616319;14769.92615036926;878.4773060029272;893.352319568311;902.702108304258;908.2552307108174;913.0458670689112;868.535333596526;904.6291020681522;905.2803021597813;911.2391153386897;913.0823522360018;942.1473566422399;948.5494390164686;958.108958668438;958.1759686669459;959.5154447004253;942.4439580647451;943.3962264150949;945.7115579748174;947.4836214263174;947.64463326253;690.1511141296234;700.6566782276699;701.0150738212819;701.4493622506308;704.873122837889;12433;12639.052071094613;13027.413766380536;13247.40386682592;13278.66803329915;14993.025453345497;15103.32035058425;15325.46360877375;15358.155301458415;15407.768883466757;10924.071453926346;10946.671599852018;11001.504932278067;11018.669439916735;11056.226064175511;2593.9870300648563;2614.1373346795513;2626.9737302626922;2647.377866201441;2647.6028595710795;69293.30706692969;69565;69946.65026674885;71013.28986710118;71136;11192;11251.662450126509;11280.2667826591;11333.26333788301;11376.715582110513;20528.794712052986;20579.58840823175;21610.89194554017;21624.243151489623;21877.234296799536;5763.135529670499;5788.565857560699;5882.3529411764675;5927.4665280125;5945.494632956161;2870.8564571771744;2903.8548072596286;2920.8831646733893;2934.8972785952387;2936.0898121582377;3247.253131779704;3253.609566851993;3256.5766450361775;3259.7066264036353;3300.9339813204083;688.3116883116883;699.4124935054579;701.2321507948787;701.8385771272635;704.7005022865262;495.0742112250043;510.27540891933546;511.98720031998755;513.9306193663807;520.0197627472166;8417.989841219092;8951.104889510996;9067.138621830916;9341.953290233505;9464.668736594185;518.2537146509015;520.945300743424;522.0889547739143;524.8582882621671;530.4801294731108;4160.084781348099;4242.575742425733;4299.226139294957;4334.43652325202;4433.423654924839;60280;62929;63129.36870631235;63482.68258658677;64599.35400646027;57958.42041579614;58155.70922145447;58526.41473585209;60106.39893601008;60610.69694651587;51737.48262517327;52256.47743522592;52332;52793.7360313196;53072.203916941275;8673.739787806377;8695.21743043104;8726.563671816511;8878.067802880605;8910.465372077437;27312.863435682695;28393.574096388158;28599.42801144007;28740.856295719223;29407;32512.83743581267;32803.17992050218;33045;33064.83467582743;33842.32315353728;10870.728231794268;10946.890531094587;11099.611513596985;11186.496607652838;11204.495797689287;11814.94092529532;11977;11981.76036479248;12127.272363658209;12259.938700306442;11810.822837657613;11869.821952670889;11886.524539018343;11904.76190476203;12066.155369124077;11353.659390218307;11453.942730286295;11587.362695051854;11613.941930290295;11728.70678233051;11480.253783504046;11515;11609.30344179352;11696;11766.58816941403;8777.561121944005;9908.554115064695;9923.801523969336;10107.19142468586;10287.84568231462;10961.123110151328;11064.059554937921;11401.771964560829;11478.253913495597;11556.47995840206 08:52:08 INFO - PID 30540 | __end_tp_report 08:52:08 INFO - PID 30540 | __start_cc_report 08:52:08 INFO - PID 30540 | _x_x_mozilla_cycle_collect,352 08:52:08 INFO - PID 30540 | __end_cc_report 08:52:08 INFO - PID 30540 | __startTimestamp1493999528469__endTimestamp 08:52:08 INFO - PID 30540 | 08:52:08 INFO - PID 30540 | ------- Summary: start ------- 08:52:08 INFO - PID 30540 | Number of tests: 6 08:52:08 INFO - PID 30540 | 08:52:08 INFO - PID 30540 | [#0] dojo.html Cycles:165 Average:5132.91 Median:5315.63 stddev:601.03 (11.3%) stddev-sans-first:572.37 08:52:08 INFO - PID 30540 | Values: 2722.9 2734.4 2743.8 2755.0 2766.2 5105.1 5141.2 5146.2 5240.7 5264.3 5210.4 5226.7 5234.8 5309.4 5310.8 4618.8 4637.7 4651.3 4658.4 4674.7 4660.9 4664.6 4700.1 4712.6 4717.9 4547.7 4607.4 4627.0 4640.5 4678.0 4667.1 4667.1 4668.8 4703.3 4724.5 4577.7 4646.5 4649.4 4650.4 4672.2 5158.1 5167.3 5178.0 5229.6 5232.9 5531.4 5563.8 5672.8 5674.2 5683.0 5593.0 5609.1 5646.7 5655.0 5682.4 5206.8 5212.8 5215.9 5227.2 5227.8 5595.7 5729.5 5735.3 5744.5 5774.2 5481.2 5542.6 5559.6 5599.7 5602.1 5558.6 5573.4 5582.2 5600.4 5619.5 5446.1 5501.3 5504.6 5510.8 5614.4 5460.4 5512.6 5539.9 5546.9 5570.1 4547.5 4549.8 4552.3 4559.6 4599.1 3922.4 3932.9 3951.2 3976.3 3986.0 4691.3 4759.3 4833.6 4889.9 4902.2 5592.3 5641.6 5646.0 5648.7 5688.3 4822.8 4832.4 4834.3 4835.9 4839.3 4886.0 4948.5 4950.6 4951.8 4953.6 5245.2 5267.9 5270.8 5300.4 5306.4 5597.3 5650.8 5650.9 5652.2 5658.5 5295.4 5314.2 5315.6 5338.7 5353.2 5435.8 5536.3 5559.1 5573.2 5573.7 5496.8 5553.9 5655.9 5685.9 5733.7 5423.4 5427.3 5459.0 5469.3 5491.6 5421.8 5447.5 5454.5 5459.3 5466.0 5335.8 5352.9 5390.9 5393.1 5424.9 5466.5 5498.3 5509.2 5511.0 5524.8 5350.4 5388.6 5405.0 5447.5 5454.8 08:52:08 INFO - PID 30540 | 08:52:08 INFO - PID 30540 | [#1] ext.html Cycles:180 Average:30585.16 Median:17191.27 stddev:41264.84 (240.0%) stddev-sans-first:41319.73 08:52:08 INFO - PID 30540 | Values: 734.8 757.7 1056.3 1072.5 1140.3 32309.5 33107.2 33491.5 33578.0 33578.8 30822.8 31128.0 31199.7 31224.2 31251.5 6419.5 6472.7 6589.8 6607.8 7014.1 7024.5 7059.0 7119.9 7122.5 7141.1 7088.9 7168.5 7171.4 7175.1 7189.1 7048.8 7087.0 7103.6 7137.6 7140.5 6961.9 6970.6 7043.7 7058.4 7059.4 32152.7 32267.2 32388.7 32480.0 32501.5 3068.8 3102.3 3111.1 3131.0 3131.2 24882.3 24886.5 24894.0 24912.0 24984.3 2575.4 2602.1 2633.8 2637.3 2644.7 146854.0 147424.0 147573.3 148323.0 148750.0 38247.2 40282.4 40312.6 40934.6 41134.2 41951.0 41991.8 42051.4 42080.2 42099.0 11064.9 11312.9 11313.5 11332.9 11363.4 8904.0 9170.5 9231.9 9233.5 9241.4 12986.2 12989.0 13090.3 13150.8 13209.2 5335.9 5406.6 5440.8 5516.0 5528.9 860.6 893.4 913.0 914.3 947.5 20078.5 21387.9 21757.5 25201.0 26208.7 970.4 973.8 991.6 994.5 998.3 11194.9 11487.8 11536.9 11560.5 11681.4 173235.0 175439.0 175491.1 175728.0 175987.0 39352.6 39359.0 39368.4 39761.8 39810.8 1197.4 1235.9 1237.2 1237.9 1248.2 19725.1 19927.8 20019.0 20970.8 21176.2 29794.6 29985.0 30077.4 30089.8 30093.0 141176.0 158664.0 159009.0 159985.0 160115.0 31353.0 31444.7 31504.7 31541.4 31828.0 36732.4 37400.4 37689.2 37854.0 37989.8 28986.9 29497.6 29593.3 29929.9 30364.5 28224.9 28326.4 29021.3 29457.6 29702.0 31717.8 31815.5 31856.8 31963.0 32043.8 26587.3 27505.6 27903.4 28151.7 28210.9 22319.2 23202.4 23369.2 23466.3 23478.3 08:52:08 INFO - PID 30540 | 08:52:08 INFO - PID 30540 | [#2] jquery.html Cycles:180 Average:25450.88 Median:40782.30 stddev:62444.58 (153.1%) stddev-sans-first:62591.47 08:52:08 INFO - PID 30540 | Values: 418.9 422.9 425.3 438.2 452.0 17000.4 17235.7 17866.1 18492.2 18781.7 18538.5 18754.6 18877.4 18971.9 18983.3 5393.7 5409.3 5625.5 5627.7 5648.8 5466.1 5581.5 5602.0 5606.5 5610.6 5333.0 5476.5 5521.9 5528.2 5547.6 5487.9 5555.0 5610.9 5615.0 5615.8 4975.9 5030.3 5050.0 5060.6 5089.2 21643.1 21740.0 21796.5 21832.8 21933.7 1629.7 1645.5 1657.6 1658.1 1658.9 14445.5 14572.9 15041.5 15041.8 15315.3 1948.3 2008.7 2068.1 2076.0 2089.5 79774.6 82853.2 92900.5 97311.0 100486.0 11222.1 11283.5 11365.3 11434.8 11462.5 15884.4 15888.2 15918.8 15922.4 15932.5 7590.9 7723.9 7813.8 7913.0 7941.6 6957.6 6961.2 7015.1 7188.6 7232.4 7074.5 7081.8 7163.3 7175.2 7239.7 2154.9 2156.3 2157.7 2159.4 2261.0 840.4 857.3 859.5 867.2 884.1 17094.1 17213.7 17390.0 17581.5 17908.1 868.2 876.9 881.0 885.9 899.7 9271.7 9583.7 9697.4 9768.2 9864.3 371468.0 371652.0 373163.0 374413.0 378446.0 75895.0 84886.6 86026.6 86999.6 89124.0 1047.1 1068.4 1107.7 1115.4 1118.8 17624.5 17809.7 18495.2 18562.2 18606.3 38608.8 39579.6 39697.2 40362.8 41201.8 48516.8 49789.8 49990.0 50014.7 53084.2 8285.6 8311.0 8330.8 8448.8 8778.8 12727.4 12936.7 12937.7 13341.3 13348.9 10049.0 10613.5 10701.1 10904.4 11085.3 9810.4 9811.5 9855.3 9874.2 10050.4 11038.0 11162.9 11303.6 11453.4 11546.8 8378.4 8423.6 8592.0 8619.4 8965.4 10485.4 10594.8 10618.3 11002.7 11070.7 08:52:08 INFO - PID 30540 | 08:52:08 INFO - PID 30540 | [#3] mootools.html Cycles:180 Average:6383.52 Median:3903.66 stddev:4132.21 (105.9%) stddev-sans-first:4125.96 08:52:08 INFO - PID 30540 | Values: 1273.6 1310.6 1330.2 1333.7 1337.3 9767.8 10248.3 10265.7 10362.0 10598.6 10355.4 10512.4 10520.0 10543.3 10570.7 2265.6 2299.0 2300.0 2304.6 2311.1 2169.4 2216.9 2244.3 2245.0 2255.9 2213.6 2214.5 2248.8 2262.2 2268.8 2131.9 2173.3 2182.4 2184.7 2187.1 2028.9 2162.3 2165.4 2199.9 2201.0 10228.3 10300.0 10309.8 10315.2 10323.2 5519.6 5758.8 5770.1 5774.6 5809.4 3134.9 3392.6 3413.7 3438.8 3457.1 981.9 1002.7 1003.5 1050.2 1051.8 15352.2 15374.8 15432.5 15543.0 15567.6 4670.6 4806.0 5018.9 5020.7 5097.9 11063.4 11128.3 11129.1 11160.0 11174.8 5588.7 5658.7 5659.2 5680.1 5687.8 5076.9 5131.9 5165.7 5167.5 5257.1 3893.1 3929.2 3981.5 3993.7 4044.9 1104.2 1114.9 1116.8 1128.7 1128.7 701.6 723.5 728.8 736.5 744.6 5614.7 5635.9 5679.0 5751.7 5818.6 548.1 567.5 568.7 570.1 571.2 3554.2 3760.9 3914.2 3919.7 3933.4 13125.2 13776.7 13807.5 13829.4 13845.7 13119.7 13290.8 13497.8 13618.9 13694.5 7656.6 7717.7 7882.2 7886.3 7905.0 6412.0 6498.5 6524.9 6585.3 6671.1 11967.3 12181.1 12320.6 12422.4 12554.4 12197.2 12415.9 12545.7 12564.4 12688.6 7846.3 7942.1 7948.6 7961.1 7993.6 9265.9 9320.0 9335.2 9362.5 9420.9 8142.7 8146.4 8155.5 8236.3 8492.4 7931.2 8099.9 8111.1 8135.5 8204.5 7213.5 7295.9 7364.4 7377.4 7395.9 5342.9 5343.4 5472.5 5525.3 5581.0 5232.6 5271.6 5449.7 5502.6 5514.3 08:52:08 INFO - PID 30540 | 08:52:08 INFO - PID 30540 | [#4] prototype.html Cycles:180 Average:4758.54 Median:5434.51 stddev:1433.52 (26.4%) stddev-sans-first:1399.16 08:52:08 INFO - PID 30540 | Values: 368.5 371.7 374.2 383.3 386.9 5434.8 5475.1 5499.6 5535.8 5618.2 5279.9 5410.8 5415.4 5420.5 5429.2 3981.9 4069.1 4082.8 4083.3 4101.3 4080.1 4085.2 4090.5 4092.4 4101.7 4056.0 4060.0 4066.1 4076.3 4083.1 3912.7 4058.8 4076.4 4076.6 4090.8 3470.6 3527.9 3532.5 3539.7 3558.3 5292.1 5311.2 5317.3 5335.5 5339.6 4728.2 4736.0 4762.8 4772.7 4799.8 5687.3 5714.2 5745.8 5751.0 5783.8 3982.3 3988.7 3991.8 3994.3 4005.2 5909.3 6066.8 6084.3 6153.7 6156.0 4022.4 4025.7 4031.0 4044.2 4055.7 4103.6 4109.3 4113.9 4115.7 4119.2 4714.7 4750.3 4760.5 4765.9 4778.4 5761.4 5767.8 5786.2 5791.3 5795.9 1416.7 1416.9 1424.2 1431.6 1437.4 909.3 942.6 953.7 963.9 968.9 5029.6 5092.4 5097.6 5105.9 5113.7 5943.9 6035.3 6047.8 6061.6 6070.6 4868.3 5063.0 5106.6 5109.0 5112.1 3192.1 3196.4 3221.9 3224.5 3226.8 5434.2 5559.4 5569.2 5593.9 5681.8 6148.6 6182.3 6207.3 6213.0 6230.3 5492.5 5641.7 5657.3 5679.3 5679.5 6035.7 6036.5 6044.2 6048.8 6064.7 5721.2 5878.9 5909.5 5934.6 5948.6 5655.2 5675.7 5677.2 5683.3 5700.5 4036.8 4039.3 4041.5 4044.2 4051.4 5927.4 6007.2 6011.2 6036.3 6057.4 5770.6 5812.8 5816.3 5839.2 5841.7 5703.5 5755.5 5799.6 5820.4 5831.8 5704.5 5717.8 5736.5 5750.0 5758.3 5770.2 5865.9 5884.7 5887.2 5917.4 5614.9 5646.6 5677.7 5681.7 5729.4 08:52:08 INFO - PID 30540 | 08:52:08 INFO - PID 30540 | [#5] yui.html Cycles:180 Average:14655.01 Median:33453.58 stddev:18237.54 (54.5%) stddev-sans-first:18258.40 08:52:08 INFO - PID 30540 | Values: 654.2 663.2 673.1 674.2 683.5 11330.1 11669.3 11672.5 13169.9 14555.4 13634.8 14366.7 14724.6 14749.2 14769.9 878.5 893.4 902.7 908.3 913.0 868.5 904.6 905.3 911.2 913.1 942.1 948.5 958.1 958.2 959.5 942.4 943.4 945.7 947.5 947.6 690.2 700.7 701.0 701.4 704.9 12433.0 12639.1 13027.4 13247.4 13278.7 14993.0 15103.3 15325.5 15358.2 15407.8 10924.1 10946.7 11001.5 11018.7 11056.2 2594.0 2614.1 2627.0 2647.4 2647.6 69293.3 69565.0 69946.7 71013.3 71136.0 11192.0 11251.7 11280.3 11333.3 11376.7 20528.8 20579.6 21610.9 21624.2 21877.2 5763.1 5788.6 5882.4 5927.5 5945.5 2870.9 2903.9 2920.9 2934.9 2936.1 3247.3 3253.6 3256.6 3259.7 3300.9 688.3 699.4 701.2 701.8 704.7 495.1 510.3 512.0 513.9 520.0 8418.0 8951.1 9067.1 9342.0 9464.7 518.3 520.9 522.1 524.9 530.5 4160.1 4242.6 4299.2 4334.4 4433.4 60280.0 62929.0 63129.4 63482.7 64599.4 57958.4 58155.7 58526.4 60106.4 60610.7 51737.5 52256.5 52332.0 52793.7 53072.2 8673.7 8695.2 8726.6 8878.1 8910.5 27312.9 28393.6 28599.4 28740.9 29407.0 32512.8 32803.2 33045.0 33064.8 33842.3 10870.7 10946.9 11099.6 11186.5 11204.5 11814.9 11977.0 11981.8 12127.3 12259.9 11810.8 11869.8 11886.5 11904.8 12066.2 11353.7 11453.9 11587.4 11613.9 11728.7 11480.3 11515.0 11609.3 11696.0 11766.6 8777.6 9908.6 9923.8 10107.2 10287.8 10961.1 11064.1 11401.8 11478.3 11556.5 08:52:08 INFO - PID 30540 | -------- Summary: end -------- 08:52:08 INFO - PID 30540 | 08:52:09 INFO - TEST-INFO | 30540: exit 0 08:52:09 INFO - TEST-OK | dromaeo_css | took 1119687ms 08:52:09 INFO - TEST-START | kraken 08:52:09 INFO - operating with platform_type : linux_ 08:52:09 INFO - Initialising browser for kraken test... 08:52:09 INFO - TEST-INFO | started process 30965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLKuX5j/profile http://localhost:56228/getInfo.html) 08:52:13 INFO - PID 30965 | __metrics Screen width/height:1600/1200 08:52:13 INFO - PID 30965 | colorDepth:24 08:52:13 INFO - PID 30965 | Browser inner width/height: 1024/695 08:52:13 INFO - PID 30965 | __metrics 08:52:15 INFO - TEST-INFO | 30965: exit 0 08:52:15 INFO - Browser initialized. 08:52:15 INFO - Running cycle 1/1 for kraken test... 08:52:15 INFO - TEST-INFO | started process 31134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLKuX5j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:27 INFO - PID 31134 | RSS: Main: 159903744 08:52:27 INFO - PID 31134 | 08:52:30 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:31 INFO - PID 31134 | RSS: Main: 166821888 08:52:31 INFO - PID 31134 | 08:52:34 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-dft) 08:52:34 INFO - PID 31134 | RSS: Main: 164507648 08:52:34 INFO - PID 31134 | 08:52:37 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-fft) 08:52:38 INFO - PID 31134 | RSS: Main: 160595968 08:52:38 INFO - PID 31134 | 08:52:40 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-oscillator) 08:52:41 INFO - PID 31134 | RSS: Main: 161865728 08:52:41 INFO - PID 31134 | 08:52:43 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:43 INFO - PID 31134 | RSS: Main: 161869824 08:52:43 INFO - PID 31134 | 08:52:46 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56228/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:47 INFO - PID 31134 | RSS: Main: 167260160 08:52:47 INFO - PID 31134 | 08:52:51 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56228/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:51 INFO - PID 31134 | RSS: Main: 165371904 08:52:51 INFO - PID 31134 | 08:52:54 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56228/tests/kraken/driver.html?testName=json-parse-financial) 08:52:55 INFO - PID 31134 | RSS: Main: 166223872 08:52:55 INFO - PID 31134 | 08:52:56 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:57 INFO - PID 31134 | RSS: Main: 166744064 08:52:57 INFO - PID 31134 | 08:52:59 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:59 INFO - PID 31134 | RSS: Main: 166752256 08:52:59 INFO - PID 31134 | 08:53:01 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:53:02 INFO - PID 31134 | RSS: Main: 166686720 08:53:02 INFO - PID 31134 | 08:53:05 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:53:06 INFO - PID 31134 | RSS: Main: 166719488 08:53:06 INFO - PID 31134 | 08:53:09 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:09 INFO - PID 31134 | RSS: Main: 166711296 08:53:09 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56228/tests/kraken/driver.html?testName=ai-astar) 08:53:11 INFO - PID 31134 | RSS: Main: 168460288 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | __start_tp_report 08:53:11 INFO - PID 31134 | _x_x_mozilla_page_load 08:53:11 INFO - PID 31134 | _x_x_mozilla_page_load_details 08:53:11 INFO - PID 31134 | |i|pagename|runs| 08:53:11 INFO - PID 31134 | |0;ai-astar;105;111;113;110;112;111;111;112;111;112 08:53:11 INFO - PID 31134 | |1;audio-beat-detection;151;124;125;182;128;125;123;124;144;131 08:53:11 INFO - PID 31134 | |2;audio-dft;165;167;163;167;167;170;176;165;165;166 08:53:11 INFO - PID 31134 | |3;audio-fft;75;75;77;109;76;76;75;74;101;76 08:53:11 INFO - PID 31134 | |4;audio-oscillator;83;83;104;84;85;85;97;83;84;103 08:53:11 INFO - PID 31134 | |5;imaging-gaussian-blur;115;114;115;114;114;115;114;115;114;114 08:53:11 INFO - PID 31134 | |6;imaging-darkroom;151;149;150;157;150;151;150;150;149;151 08:53:11 INFO - PID 31134 | |7;imaging-desaturate;95;95;95;95;95;94;94;94;94;94 08:53:11 INFO - PID 31134 | |8;json-parse-financial;59;56;55;55;56;57;58;55;57;56 08:53:11 INFO - PID 31134 | |9;json-stringify-tinderbox;55;57;56;55;56;56;55;55;54;55 08:53:11 INFO - PID 31134 | |10;stanford-crypto-aes;83;83;83;83;84;84;83;82;83;81 08:53:11 INFO - PID 31134 | |11;stanford-crypto-ccm;134;133;129;132;132;134;137;131;182;138 08:53:11 INFO - PID 31134 | |12;stanford-crypto-pbkdf2;183;205;191;196;188;193;188;195;196;188 08:53:11 INFO - PID 31134 | |13;stanford-crypto-sha256-iterative;78;72;77;73;71;72;71;71;72;76 08:53:11 INFO - PID 31134 | __end_tp_report 08:53:11 INFO - PID 31134 | __start_cc_report 08:53:11 INFO - PID 31134 | _x_x_mozilla_cycle_collect,858 08:53:11 INFO - PID 31134 | __end_cc_report 08:53:11 INFO - PID 31134 | __startTimestamp1493999591955__endTimestamp 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | ------- Summary: start ------- 08:53:11 INFO - PID 31134 | Number of tests: 14 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.20 (2.0%) stddev-sans-first:0.88 08:53:11 INFO - PID 31134 | Values: 105.0 111.0 113.0 110.0 112.0 111.0 111.0 112.0 111.0 112.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:129.50 stddev:18.83 (14.5%) stddev-sans-first:19.14 08:53:11 INFO - PID 31134 | Values: 151.0 124.0 125.0 182.0 128.0 125.0 123.0 124.0 144.0 131.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#2] audio-dft Cycles:10 Average:167.10 Median:167.00 stddev:3.63 (2.2%) stddev-sans-first:3.77 08:53:11 INFO - PID 31134 | Values: 165.0 167.0 163.0 167.0 167.0 170.0 176.0 165.0 165.0 166.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:12.61 (16.7%) stddev-sans-first:13.16 08:53:11 INFO - PID 31134 | Values: 75.0 75.0 77.0 109.0 76.0 76.0 75.0 74.0 101.0 76.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:84.00 stddev:8.66 (10.3%) stddev-sans-first:8.90 08:53:11 INFO - PID 31134 | Values: 83.0 83.0 104.0 84.0 85.0 85.0 97.0 83.0 84.0 103.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:53:11 INFO - PID 31134 | Values: 115.0 114.0 115.0 114.0 114.0 115.0 114.0 115.0 114.0 114.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.50 stddev:2.30 (1.5%) stddev-sans-first:2.44 08:53:11 INFO - PID 31134 | Values: 151.0 149.0 150.0 157.0 150.0 151.0 150.0 150.0 149.0 151.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 08:53:11 INFO - PID 31134 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.35 (2.4%) stddev-sans-first:1.05 08:53:11 INFO - PID 31134 | Values: 59.0 56.0 55.0 55.0 56.0 57.0 58.0 55.0 57.0 56.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.84 (1.5%) stddev-sans-first:0.88 08:53:11 INFO - PID 31134 | Values: 55.0 57.0 56.0 55.0 56.0 56.0 55.0 55.0 54.0 55.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 08:53:11 INFO - PID 31134 | Values: 83.0 83.0 83.0 83.0 84.0 84.0 83.0 82.0 83.0 81.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:134.00 stddev:15.62 (11.7%) stddev-sans-first:16.49 08:53:11 INFO - PID 31134 | Values: 134.0 133.0 129.0 132.0 132.0 134.0 137.0 131.0 182.0 138.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.30 Median:194.00 stddev:6.15 (3.2%) stddev-sans-first:5.52 08:53:11 INFO - PID 31134 | Values: 183.0 205.0 191.0 196.0 188.0 193.0 188.0 195.0 196.0 188.0 08:53:11 INFO - PID 31134 | 08:53:11 INFO - PID 31134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:72.50 stddev:2.67 (3.7%) stddev-sans-first:2.22 08:53:11 INFO - PID 31134 | Values: 78.0 72.0 77.0 73.0 71.0 72.0 71.0 71.0 72.0 76.0 08:53:11 INFO - PID 31134 | -------- Summary: end -------- 08:53:11 INFO - PID 31134 | 08:53:13 INFO - TEST-INFO | 31134: exit 0 08:53:13 INFO - TEST-OK | kraken | took 63957ms 08:53:13 INFO - SUITE-END | took 1183s 08:53:13 INFO - Completed test suite (00:19:43) 08:53:13 INFO - javascript benchmark 08:53:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6657.6621345107205, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2722.904698335559, 2734.38476342823, 2743.7804975601953, 2755.0, 2766.225456872076, 5105.106606343894, 5141.22881567765, 5146.176611742122, 5240.737963101848, 5264.341957255343, 5210.400803907552, 5226.686398816074, 5234.79060837567, 5309.442508536606, 5310.840674779763, 4618.815247390117, 4637.65217608679, 4651.279051746985, 4658.371119898804, 4674.672772905898, 4660.906781864361, 4664.626829853603, 4700.130475861959, 4712.552307530779, 4717.882052948687, 4547.727136371828, 4607.401037865089, 4626.958934239803, 4640.466346370177, 4677.976610116962, 4667.066586682677, 4667.113248482778, 4668.813247470097, 4703.270992996091, 4724.480307166244, 4577.725336479822, 4646.465656449518, 4649.372334734835, 4650.441946966352, 4672.182368085571, 5158.148905430599, 5167.302414174076, 5177.974110129463, 5229.633925625208, 5232.92150617741, 5531.3915469298345, 5563.833085007456, 5672.773089076473, 5674.233978412903, 5683.0338842396895, 5593.049181639131, 5609.1305847593685, 5646.6894320812335, 5655.0386434306265, 5682.40334764852, 5206.791728330824, 5212.843614691566, 5215.942395524918, 5227.2420499028185, 5227.817026404057, 5595.7481913313995, 5729.455701708331, 5735.311762588432, 5744.540436765133, 5774.249347584787, 5481.232627432163, 5542.584306177053, 5559.610827242135, 5599.720013999366, 5602.1036634138345, 5558.638688485235, 5573.359063707644, 5582.218489411485, 5600.355959064678, 5619.494245517842, 5446.128619420873, 5501.257330260363, 5504.6421982571, 5510.779568817283, 5614.354349249807, 5460.372057213392, 5512.586556008316, 5539.861503462445, 5546.889062218733, 5570.053090974544, 4547.47704014036, 4549.839790853312, 4552.271636538138, 4559.635229181657, 4599.08018396322, 3922.4116382542848, 3932.9213415731524, 3951.209758048344, 3976.324024915771, 3986.0, 4691.296305554194, 4759.309900064472, 4833.637477189154, 4889.926651100236, 4902.166631672624, 5592.273004509388, 5641.576881733887, 5646.011947909182, 5648.6893220872425, 5688.260526131659, 4822.7829747661435, 4832.44426890912, 4834.250691142878, 4835.903281934412, 4839.322494850724, 4886.047220791983, 4948.455669876239, 4950.554450099508, 4951.752412379366, 4953.6037117030555, 5245.160774276097, 5267.89464210706, 5270.78916843322, 5300.443453437333, 5306.442823503477, 5597.3003374578175, 5650.773969041356, 5650.943490565206, 5652.180433837153, 5658.490735833795, 5295.364556253275, 5314.22943673173, 5315.6279060465395, 5338.733063346895, 5353.170258609922, 5435.809746658848, 5536.280283563111, 5559.0827513461445, 5573.164025396223, 5573.665580065209, 5496.780128794803, 5553.888922221614, 5655.915161272502, 5685.857853553694, 5733.684647344436, 5423.430539793265, 5427.267318911896, 5459.044667183148, 5469.2616496772425, 5491.560675146058, 5421.7560209791445, 5447.455254474521, 5454.481824226692, 5459.317585301837, 5466.0, 5335.813246536508, 5352.919706204488, 5390.946090539202, 5393.110136827379, 5424.864378390572, 5466.535344495763, 5498.340199176125, 5509.173623956439, 5510.980468613319, 5524.8342549723575, 5350.357957045179, 5388.622796404214, 5405.027095122916, 5447.455254474521, 5454.836354909359], "value": 5089.511016124262, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.8126227811908, 757.651480319053, 1056.2553399853105, 1072.5280876414377, 1140.3215087023218, 32309.515357269658, 33107.17232069199, 33491.49762753557, 33578.0, 33578.8321058395, 30822.84588577054, 31128.0, 31199.68800311996, 31224.21939451515, 31251.531227031614, 6419.518536109787, 6472.741090356392, 6589.769358072468, 6607.834804129911, 7014.123234595676, 7024.473164512657, 7058.964705176492, 7119.9288007119785, 7122.465815063865, 7141.071660684104, 7088.85822283554, 7168.462365322622, 7171.390431813302, 7175.067241258629, 7189.137303523585, 7048.788536343918, 7087.0, 7103.573785572857, 7137.643117844113, 7140.5358651687475, 6961.930380696179, 6970.571032938286, 7043.68303426347, 7058.435325173974, 7059.364657180879, 32152.6784732152, 32267.193320167185, 32388.676113238802, 32480.0, 32501.51247731286, 3068.8312142832137, 3102.348506813572, 3111.1444352802932, 3131.01373067483, 3131.18589166816, 24882.253532394057, 24886.5022699545, 24894.0, 24912.0, 24984.250472485855, 2575.3947822261753, 2602.10227471522, 2633.7629613334893, 2637.31429828246, 2644.7090820009785, 146854.0, 147424.0, 147573.2621336897, 148323.0, 148750.0, 38247.23505529874, 40282.39576406356, 40312.59687403088, 40934.59065409308, 41134.177316453504, 41951.0, 41991.79004105021, 42051.36922946158, 42080.158396831896, 42099.0, 11064.889351106547, 11312.94343528277, 11313.547458101748, 11332.943335283435, 11363.431828408711, 8904.0, 9170.495622740813, 9231.861522077174, 9233.492157931378, 9241.445513269226, 12986.220826750425, 12989.0, 13090.280034598189, 13150.802737958938, 13209.207447553177, 5335.919961200585, 5406.6215364924865, 5440.755166017539, 5516.0, 5528.889422211614, 860.6428332242175, 893.3746377535621, 913.0230653201011, 914.337105598449, 947.545178314413, 20078.498037548885, 21387.8930605346, 21757.456063598536, 25201.0, 26208.73791262101, 970.3547141151056, 973.8149751547184, 991.613270824379, 994.4530508220449, 998.276249718948, 11194.944025279821, 11487.827682584768, 11536.884631153749, 11560.479778409992, 11681.415929203677, 173235.0, 175439.0, 175491.12254438645, 175728.0, 175987.0, 39352.60647393547, 39359.0, 39368.409473857915, 39761.80119099444, 39810.800945995084, 1197.4192516629428, 1235.8949489293511, 1237.2205510528308, 1237.8824011718873, 1248.219862585884, 19725.112369943676, 19927.800721993175, 20019.0, 20970.790292097496, 21176.152953882287, 29794.553081704224, 29985.0, 30077.3984520304, 30089.796408144306, 30093.0, 141176.0, 158664.0, 159009.0, 159985.0, 160115.0, 31353.0, 31444.685553144176, 31504.684953150176, 31541.36917261688, 31828.0, 36732.44901326429, 37400.43899341457, 37689.24621507609, 37854.0, 37989.81005095068, 28986.855065724536, 29497.557536637396, 29593.26016849596, 29929.850350748107, 30364.544531831598, 28224.85887570549, 28326.43347133087, 29021.274468138465, 29457.558136628395, 29702.0, 31717.841410792797, 31815.522767158975, 31856.840715796272, 31963.0, 32043.839780801878, 26587.33531661724, 27505.587416189173, 27903.441931160858, 28151.71848281573, 28210.85894570514, 22319.218827340967, 23202.41993950097, 23369.182078627848, 23466.296011119695, 23478.29565112981], "value": 14583.407375774153, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.92249933762236, 422.93947688564464, 425.26004751731983, 438.2221556736792, 451.952544982777, 17000.4049858255, 17235.74146387805, 17866.106694665265, 18492.167852446637, 18781.718274225863, 18538.53653658656, 18754.624907501875, 18877.433676989676, 18971.90514047431, 18983.33558325459, 5393.6763794172275, 5409.29679141711, 5625.46558076982, 5627.7467513961765, 5648.802291919784, 5466.070767969435, 5581.525570326507, 5602.0, 5606.523445507137, 5610.607257491977, 5332.973335133319, 5476.452354764531, 5521.861953451155, 5528.226048353234, 5547.583931205156, 5487.890242195133, 5555.0, 5610.943890561083, 5615.0, 5615.803446879339, 4975.925361119586, 5030.270610761419, 5049.974750126263, 5060.645754797166, 5089.185730283174, 21643.134274628996, 21740.0, 21796.45508862275, 21832.78167218339, 21933.670994935088, 1629.722947098996, 1645.539249010267, 1657.5773177839694, 1658.071479971208, 1658.8672906167599, 14445.49440769568, 14572.854271457361, 15041.473548425862, 15041.849581504155, 15315.31081101353, 1948.259661328686, 2008.7489063867017, 2068.1210485543734, 2076.045019291128, 2089.4671858676093, 79774.60112699399, 82853.17146828515, 92900.53549732208, 97311.0, 100485.99999999927, 11222.148345522897, 11283.492242849092, 11365.261258018203, 11434.771304574027, 11462.54149834014, 15884.444044458389, 15888.205589720468, 15918.840811591735, 15922.363105475883, 15932.522024339289, 7590.8861367079535, 7723.884141737878, 7813.804654883674, 7912.960435197787, 7941.6029198539845, 6957.617331046841, 6961.164660240804, 7015.088038555057, 7188.640567971581, 7232.421406287484, 7074.540154890019, 7081.752138675121, 7163.31948464895, 7175.17485489165, 7239.746608868664, 2154.9353519394444, 2156.2884248198056, 2157.6979222908803, 2159.427751645815, 2261.0164578408117, 840.3865178419787, 857.3098655582191, 859.4671303791564, 867.1891781184487, 884.1423818895661, 17094.145292735564, 17213.65572688564, 17390.0, 17581.472555823344, 17908.104594770208, 868.2272777228272, 876.8816209811594, 880.9955950220336, 885.9246964008131, 899.6896070855545, 9271.747636207776, 9583.664571739955, 9697.399929011634, 9768.21854251658, 9864.309498335047, 371468.0, 371652.0, 373163.0, 374413.0, 378446.0, 75895.0, 84886.57556712176, 86026.56986715026, 86999.56500217458, 89124.0, 1047.1047254597363, 1068.4016950507742, 1107.651089906693, 1115.3921112993437, 1118.765059337532, 17624.471265862045, 17809.73285400746, 18495.167717452478, 18562.236587524163, 18606.255749769858, 38608.80695596504, 39579.60420395874, 39697.2060558793, 40362.798186008884, 41201.79399103105, 48516.7574162141, 49789.75105124596, 49990.0, 50014.74992625014, 53084.20373694475, 8285.585720714062, 8311.0, 8330.791730206793, 8448.788780280542, 8778.824423511367, 12727.427265773247, 12936.741265174833, 12937.676558086123, 13341.332933353488, 13348.86651133515, 10049.0, 10613.522391492555, 10701.090407315465, 10904.40025798557, 11085.334879907232, 9810.411375317504, 9811.509424528887, 9855.260855436014, 9874.160696340605, 10050.447225402673, 11038.0, 11162.888371116185, 11303.604373846876, 11453.370064646524, 11546.787587303212, 8378.413511054412, 8423.620937057969, 8592.0, 8619.353548483763, 8965.372423930263, 10485.423301718478, 10594.788104238027, 10618.256722029384, 11002.724931876766, 11070.667879963614], "value": 8980.186551846951, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.5669872243436, 1310.5937159480561, 1330.161997941297, 1333.7265860498599, 1337.3112846883857, 9767.755806104842, 10248.333858299206, 10265.692029239126, 10362.0, 10598.576056957732, 10355.37867727935, 10512.369257844535, 10520.000599943012, 10543.261971661987, 10570.735731606714, 2265.6148454762647, 2299.0458959531775, 2300.033985725999, 2304.596695578267, 2311.133325003124, 2169.425102347879, 2216.944576385587, 2244.259394399852, 2245.045855511409, 2255.8533695309834, 2213.612617791888, 2214.490667146549, 2248.786365295294, 2262.151693115082, 2268.7844654757773, 2131.9467013324634, 2173.3262688566515, 2182.4434769133927, 2184.7050648162535, 2187.1360812479143, 2028.8985550722552, 2162.3188695561007, 2165.4153378587853, 2199.9450013749624, 2200.9889950550305, 10228.284020118595, 10300.0, 10309.793804123876, 10315.1747860171, 10323.2257580681, 5519.641223320471, 5758.769649214027, 5770.105633626795, 5774.566907481955, 5809.419058094199, 3134.937301253985, 3392.5589673342556, 3413.6927676509235, 3438.793672379665, 3457.11843479911, 981.9214462843026, 1002.7192386131821, 1003.4932359158652, 1050.1965996013057, 1051.7640594953123, 15352.155631440379, 15374.76937845922, 15432.537023889301, 15543.0, 15567.610809729847, 4670.602998745145, 4806.0, 5018.924716129261, 5020.673656212334, 5097.923531147036, 11063.446827658585, 11128.276662016942, 11129.109671226282, 11160.0, 11174.776504470028, 5588.692621905753, 5658.74535645897, 5659.236003139524, 5680.147977803363, 5687.829365119053, 5076.873078173076, 5131.897362052738, 5165.708572856785, 5167.457416971239, 5257.106291930381, 3893.124047089382, 3929.1945151243926, 3981.5222173339384, 3993.7204395692024, 4044.858429954996, 1104.2491106047803, 1114.9442527873737, 1116.849225354583, 1128.6839684888243, 1128.6839684888243, 701.6035939694057, 723.5152447859947, 728.8141523911369, 736.495500582103, 744.6053591596462, 5614.747336369873, 5635.915461268084, 5679.0, 5751.741171647286, 5818.592698511148, 548.0792268988058, 567.5402923631872, 568.692905830855, 570.0650932470751, 571.151839518315, 3554.20030493137, 3760.9247815043545, 3914.197589494147, 3919.725619206685, 3933.449317095609, 13125.212487250796, 13776.724465510833, 13807.51673691416, 13829.377678004514, 13845.723085538435, 13119.672008199872, 13290.800637990438, 13497.797533037012, 13618.86381136176, 13694.452221911211, 7656.61716914152, 7717.65270562826, 7882.211778822187, 7886.250806173404, 7905.0, 6412.0, 6498.545101843015, 6524.902126468011, 6585.308542603149, 6671.099401580725, 11967.341796201292, 12181.147319687538, 12320.568780093012, 12422.37888105609, 12554.372281386077, 12197.207181533173, 12415.875841241472, 12545.686357841127, 12564.37178141071, 12688.555900543437, 7846.293833555007, 7942.12636609984, 7948.642311095899, 7961.124276329715, 7993.6003199838615, 9265.907340926504, 9319.953400232955, 9335.206507446943, 9362.485063321583, 9420.858687119562, 8142.715004974797, 8146.389020823581, 8155.510669359857, 8236.258736713724, 8492.363072769444, 7931.167227441267, 8099.878501822595, 8111.148329425561, 8135.471194372347, 8204.507729536246, 7213.458990575623, 7295.854082918206, 7364.374028207448, 7377.409807215303, 7395.852082958419, 5342.9465705342445, 5343.412224655207, 5472.480114389126, 5525.309336332958, 5581.0, 5232.581393488588, 5271.599818117216, 5449.7275136243825, 5502.642328248651, 5514.310711161105], "value": 4751.25949224733, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.5006815764639, 371.6525049079113, 374.19921368271883, 383.32343413874514, 386.89940615439986, 5434.809781657643, 5475.123980163175, 5499.615026948115, 5535.813353725282, 5618.15727640854, 5279.947200527993, 5410.834661722897, 5415.404305526389, 5420.539254163401, 5429.239906413105, 3981.8606348777653, 4069.104796944675, 4082.81627326771, 4083.3262511685684, 4101.302778527657, 4080.1431699343175, 4085.162541678949, 4090.509138903336, 4092.4270602115726, 4101.651359634419, 4056.0468289951837, 4059.9594004059877, 4066.125782956664, 4076.30702780528, 4083.12212874232, 3912.68698504119, 4058.79706014701, 4076.408920706496, 4076.6331030207275, 4090.836366545335, 3470.6355832637714, 3527.94708079379, 3532.452469867175, 3539.7345199109914, 3558.2705545363137, 5292.126799078147, 5311.203319502067, 5317.2821669074565, 5335.519803217729, 5339.6262261641705, 4728.196206644879, 4736.0, 4762.833300834489, 4772.665913386064, 4799.832005879777, 5687.317521897398, 5714.171445140431, 5745.770169193227, 5751.0, 5783.768649254025, 3982.3230050891416, 3988.68090552758, 3991.7804520751347, 3994.3009973254566, 4005.1589166275116, 5909.290885093773, 6066.787662431793, 6084.30030546484, 6153.661548614825, 6155.969220153871, 4022.35642297231, 4025.718199725991, 4030.972102113942, 4044.2315959967514, 4055.6958228133008, 4103.5691252418665, 4109.301418758818, 4113.876583702494, 4115.662409716854, 4119.217348703737, 4714.669973101919, 4750.3398097065065, 4760.523947605212, 4765.928511072337, 4778.402699662543, 5761.366249712528, 5767.769289228468, 5786.247787787561, 5791.276090488689, 5795.8551036224435, 1416.7249475471951, 1416.886649068072, 1424.2451500704642, 1431.5633731711719, 1437.3962935567088, 909.3452714045876, 942.5758408716105, 953.6566835939195, 963.8746962894779, 968.864358989742, 5029.597632189416, 5092.439831618519, 5097.64316497849, 5105.897882042338, 5113.74431278442, 5943.881122377615, 6035.305939816977, 6047.818565443044, 6061.605995610271, 6070.575059745864, 4868.294097355863, 5063.0, 5106.617003724736, 5109.003744269906, 5112.130937740593, 3192.138122706856, 3196.369851375815, 3221.8711251550144, 3224.500202468621, 3226.757993150476, 5434.212039254286, 5559.388467268597, 5569.192467092249, 5593.944060559424, 5681.801136960186, 6148.631082135086, 6182.319944806068, 6207.286162091327, 6212.968935155295, 6230.314665386803, 5492.478214569689, 5641.689707066069, 5657.2928383952, 5679.3184817820475, 5679.460451257207, 6035.698215089315, 6036.517078633611, 6044.184035155197, 6048.818535443944, 6064.696765161812, 5721.22763426932, 5878.882422351615, 5909.497692695997, 5934.6350339421315, 5948.5538584605465, 5655.151727240782, 5675.716214189357, 5677.205191273142, 5683.318001839806, 5700.486956173964, 4036.7577945323374, 4039.293123703399, 4041.474608300902, 4044.2113787811095, 4051.372037334218, 5927.436893495111, 6007.249093863267, 6011.218541589566, 6036.3058248302, 6057.42454466825, 5770.567207459373, 5812.796552120655, 5816.331121920864, 5839.168003518205, 5841.737121829443, 5703.486686198262, 5755.510781583613, 5799.623024503562, 5820.388859169896, 5831.79588714393, 5704.515116215168, 5717.799877004285, 5736.483716465538, 5749.9712501437225, 5758.2514273144225, 5770.2498675171955, 5865.912011319749, 5884.735186916513, 5887.1757953885635, 5917.437843404869, 5614.887702246014, 5646.576506761927, 5677.659340439422, 5681.687507186979, 5729.427057294237], "value": 4313.491452388456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.2280109470822, 663.2207156591002, 673.1451057157409, 674.1741366825639, 683.5181197255934, 11330.093592512589, 11669.299842009475, 11672.47473863676, 13169.868301316985, 14555.417783288682, 13634.795478067812, 14366.712665746678, 14724.6318842029, 14749.188794616319, 14769.92615036926, 878.4773060029272, 893.352319568311, 902.702108304258, 908.2552307108174, 913.0458670689112, 868.535333596526, 904.6291020681522, 905.2803021597813, 911.2391153386897, 913.0823522360018, 942.1473566422399, 948.5494390164686, 958.108958668438, 958.1759686669459, 959.5154447004253, 942.4439580647451, 943.3962264150949, 945.7115579748174, 947.4836214263174, 947.64463326253, 690.1511141296234, 700.6566782276699, 701.0150738212819, 701.4493622506308, 704.873122837889, 12433.0, 12639.052071094613, 13027.413766380536, 13247.40386682592, 13278.66803329915, 14993.025453345497, 15103.32035058425, 15325.46360877375, 15358.155301458415, 15407.768883466757, 10924.071453926346, 10946.671599852018, 11001.504932278067, 11018.669439916735, 11056.226064175511, 2593.9870300648563, 2614.1373346795513, 2626.9737302626922, 2647.377866201441, 2647.6028595710795, 69293.30706692969, 69565.0, 69946.65026674885, 71013.28986710118, 71136.0, 11192.0, 11251.662450126509, 11280.2667826591, 11333.26333788301, 11376.715582110513, 20528.794712052986, 20579.58840823175, 21610.89194554017, 21624.243151489623, 21877.234296799536, 5763.135529670499, 5788.565857560699, 5882.3529411764675, 5927.4665280125, 5945.494632956161, 2870.8564571771744, 2903.8548072596286, 2920.8831646733893, 2934.8972785952387, 2936.0898121582377, 3247.253131779704, 3253.609566851993, 3256.5766450361775, 3259.7066264036353, 3300.9339813204083, 688.3116883116883, 699.4124935054579, 701.2321507948787, 701.8385771272635, 704.7005022865262, 495.0742112250043, 510.27540891933546, 511.98720031998755, 513.9306193663807, 520.0197627472166, 8417.989841219092, 8951.104889510996, 9067.138621830916, 9341.953290233505, 9464.668736594185, 518.2537146509015, 520.945300743424, 522.0889547739143, 524.8582882621671, 530.4801294731108, 4160.084781348099, 4242.575742425733, 4299.226139294957, 4334.43652325202, 4433.423654924839, 60280.0, 62929.0, 63129.36870631235, 63482.68258658677, 64599.35400646027, 57958.42041579614, 58155.70922145447, 58526.41473585209, 60106.39893601008, 60610.69694651587, 51737.48262517327, 52256.47743522592, 52332.0, 52793.7360313196, 53072.203916941275, 8673.739787806377, 8695.21743043104, 8726.563671816511, 8878.067802880605, 8910.465372077437, 27312.863435682695, 28393.574096388158, 28599.42801144007, 28740.856295719223, 29407.0, 32512.83743581267, 32803.17992050218, 33045.0, 33064.83467582743, 33842.32315353728, 10870.728231794268, 10946.890531094587, 11099.611513596985, 11186.496607652838, 11204.495797689287, 11814.94092529532, 11977.0, 11981.76036479248, 12127.272363658209, 12259.938700306442, 11810.822837657613, 11869.821952670889, 11886.524539018343, 11904.76190476203, 12066.155369124077, 11353.659390218307, 11453.942730286295, 11587.362695051854, 11613.941930290295, 11728.70678233051, 11480.253783504046, 11515.0, 11609.30344179352, 11696.0, 11766.58816941403, 8777.561121944005, 9908.554115064695, 9923.801523969336, 10107.19142468586, 10287.84568231462, 10961.123110151328, 11064.059554937921, 11401.771964560829, 11478.253913495597, 11556.47995840206], "value": 6374.411606512878, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 113.0, 110.0, 112.0, 111.0, 111.0, 112.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 125.0, 182.0, 128.0, 125.0, 123.0, 124.0, 144.0, 131.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 163.0, 167.0, 167.0, 170.0, 176.0, 165.0, 165.0, 166.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 109.0, 76.0, 76.0, 75.0, 74.0, 101.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 104.0, 84.0, 85.0, 85.0, 97.0, 83.0, 84.0, 103.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 150.0, 157.0, 150.0, 151.0, 150.0, 150.0, 149.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 55.0, 55.0, 56.0, 57.0, 58.0, 55.0, 57.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 55.0, 56.0, 56.0, 55.0, 55.0, 54.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 84.0, 84.0, 83.0, 82.0, 83.0, 81.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 129.0, 132.0, 132.0, 134.0, 137.0, 131.0, 182.0, 138.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 205.0, 191.0, 196.0, 188.0, 193.0, 188.0, 195.0, 196.0, 188.0], "value": 192.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 72.0, 77.0, 73.0, 71.0, 72.0, 71.0, 71.0, 72.0, 76.0], "value": 73.3, "unit": "score"}]}]} 08:53:13 INFO - Return code: 0 08:53:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:53:13 INFO - # TBPL SUCCESS # 08:53:13 INFO - Running post-action listener: _resource_record_post_action 08:53:13 INFO - [mozharness: 2017-05-05 15:53:13.738581Z] Finished run-tests step (success) 08:53:13 INFO - Running post-run listener: _resource_record_post_run 08:53:13 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 348372992; Read time: 200; Write time: 213228 08:53:13 INFO - TinderboxPrint: CPU usage
13.3% 08:53:13 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 200 08:53:13 INFO - TinderboxPrint: I/O write bytes / time
348,372,992 / 213,228 08:53:13 INFO - TinderboxPrint: CPU idle
8,298.6 (86.7%) 08:53:13 INFO - TinderboxPrint: CPU user
1,214.4 (12.7%) 08:53:13 INFO - TinderboxPrint: Swap in / out
0 / 0 08:53:13 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 97390592; Read time: 0; Write time: 99432 08:53:13 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250372096; Read time: 188; Write time: 113764 08:53:14 INFO - Running post-run listener: _upload_blobber_files 08:53:14 INFO - Blob upload gear active. 08:53:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:53:14 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 08:53:14 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'] 08:53:14 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 08:53:14 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:53:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:16 INFO - (blobuploader) - INFO - Done attempting. 08:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:16 INFO - (blobuploader) - INFO - Done attempting. 08:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:19 INFO - (blobuploader) - INFO - Done attempting. 08:53:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:53:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:53:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:20 INFO - (blobuploader) - INFO - Done attempting. 08:53:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:20 INFO - Return code: 0 08:53:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c24f9bee08ca29ad6de7948662af26a469efbd5c41289cbb50c3952e3ce9a4ce087b06cf9d7d3ed318451f6291e271a416aa93b33ffd2754ba574ed704cb1a6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b5b3c6bd004896f8c78c219bf65e27ac5ea3afa6ecfae1c894e4bedd4a197cdd692df871d322662cd83a2fd0c50b5893d9f518b557b96e55b78316a9cc70540", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb87d19c1007355c11e02d7854d8d5de6a4f81945b39fc62c327e659a87ac7a7872d94b560e8598f8b546dab386566ca5e8d31fec7bffa3ccb0403c4410e3958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2cb26ed10ff52bf8666f9b70a78bf338ec5a261d4b3d581e0a71efc372ac484a4409270c2448df30dcd76c58c2cb60c942e1f6a00a09f78b42ffdbb3d63f2fa4"} 08:53:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:20 INFO - Contents: 08:53:20 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c24f9bee08ca29ad6de7948662af26a469efbd5c41289cbb50c3952e3ce9a4ce087b06cf9d7d3ed318451f6291e271a416aa93b33ffd2754ba574ed704cb1a6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b5b3c6bd004896f8c78c219bf65e27ac5ea3afa6ecfae1c894e4bedd4a197cdd692df871d322662cd83a2fd0c50b5893d9f518b557b96e55b78316a9cc70540", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb87d19c1007355c11e02d7854d8d5de6a4f81945b39fc62c327e659a87ac7a7872d94b560e8598f8b546dab386566ca5e8d31fec7bffa3ccb0403c4410e3958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2cb26ed10ff52bf8666f9b70a78bf338ec5a261d4b3d581e0a71efc372ac484a4409270c2448df30dcd76c58c2cb60c942e1f6a00a09f78b42ffdbb3d63f2fa4"} 08:53:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:20 INFO - Copying logs to upload dir... 08:53:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.627849 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-05 08:53:20.304985) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 08:53:20.308919) ========= 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=d2a8c569965ab8367867b893000001a1-1493996357.873603-963067919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c24f9bee08ca29ad6de7948662af26a469efbd5c41289cbb50c3952e3ce9a4ce087b06cf9d7d3ed318451f6291e271a416aa93b33ffd2754ba574ed704cb1a6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b5b3c6bd004896f8c78c219bf65e27ac5ea3afa6ecfae1c894e4bedd4a197cdd692df871d322662cd83a2fd0c50b5893d9f518b557b96e55b78316a9cc70540", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb87d19c1007355c11e02d7854d8d5de6a4f81945b39fc62c327e659a87ac7a7872d94b560e8598f8b546dab386566ca5e8d31fec7bffa3ccb0403c4410e3958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2cb26ed10ff52bf8666f9b70a78bf338ec5a261d4b3d581e0a71efc372ac484a4409270c2448df30dcd76c58c2cb60c942e1f6a00a09f78b42ffdbb3d63f2fa4"} build_url:https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/d4JL1crRRLCMzVyKyrpSZA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c24f9bee08ca29ad6de7948662af26a469efbd5c41289cbb50c3952e3ce9a4ce087b06cf9d7d3ed318451f6291e271a416aa93b33ffd2754ba574ed704cb1a6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b5b3c6bd004896f8c78c219bf65e27ac5ea3afa6ecfae1c894e4bedd4a197cdd692df871d322662cd83a2fd0c50b5893d9f518b557b96e55b78316a9cc70540", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb87d19c1007355c11e02d7854d8d5de6a4f81945b39fc62c327e659a87ac7a7872d94b560e8598f8b546dab386566ca5e8d31fec7bffa3ccb0403c4410e3958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2cb26ed10ff52bf8666f9b70a78bf338ec5a261d4b3d581e0a71efc372ac484a4409270c2448df30dcd76c58c2cb60c942e1f6a00a09f78b42ffdbb3d63f2fa4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 08:53:20.334606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 08:53:20.334976) ========= 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=d2a8c569965ab8367867b893000001a1-1493996357.873603-963067919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 08:53:20.419599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 08:53:20.419988) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 08:53:20.420299) ========= ========= Total master_lag: 0.17 =========