builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1493804791.25 results: success (0) revision: 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:31.251108) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:31.251508) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:31.251788) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:31.266437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:31.266703) ========= 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=41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-03 02:46:31-- 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% 15.8M=0.001s 2017-05-03 02:46:31 (15.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180599 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:31.461688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:31.462007) ========= 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=41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020227 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:31.515519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:31.515859) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 --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 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 --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=41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-03 02:46:31,821 truncating revision to first 12 chars 2017-05-03 02:46:31,821 Setting DEBUG logging. 2017-05-03 02:46:31,821 attempt 1/10 2017-05-03 02:46:31,821 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/82c2d17e74ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 02:46:32,126 unpacking tar archive at: mozilla-central-82c2d17e74ef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632616 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:32.170295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:32.170614) ========= script_repo_revision: 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:32.171008) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:32.171269) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:32.185574) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-03 02:46:32.185895) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:46:32 INFO - MultiFileLogger online at 20170503 02:46:32 in /builds/slave/test 02:46:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:46:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:46:32 INFO - {'append_to_log': False, 02:46:32 INFO - 'base_work_dir': '/builds/slave/test', 02:46:32 INFO - 'blob_upload_branch': 'Firefox', 02:46:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:46:32 INFO - 'branch': 'Firefox', 02:46:32 INFO - 'buildbot_json_path': 'buildprops.json', 02:46:32 INFO - 'config_files': ('talos/linux_config.py',), 02:46:32 INFO - 'default_actions': ('clobber', 02:46:32 INFO - 'read-buildbot-config', 02:46:32 INFO - 'download-and-extract', 02:46:32 INFO - 'populate-webroot', 02:46:32 INFO - 'create-virtualenv', 02:46:32 INFO - 'install', 02:46:32 INFO - 'run-tests'), 02:46:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:46:32 INFO - 'download_minidump_stackwalk': True, 02:46:32 INFO - 'download_symbols': 'ondemand', 02:46:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:46:32 INFO - 'tooltool.py': '/tools/tooltool.py', 02:46:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:46:32 INFO - '/tools/misc-python/virtualenv.py')}, 02:46:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:46:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:46:32 INFO - 'gecko_profile': False, 02:46:32 INFO - 'gecko_profile_interval': 0, 02:46:32 INFO - 'installer_path': 'installer.exe', 02:46:32 INFO - 'log_level': 'info', 02:46:32 INFO - 'log_name': 'talos', 02:46:32 INFO - 'log_to_console': True, 02:46:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:46:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:46:32 INFO - 'opt_config_files': (), 02:46:32 INFO - 'pip_index': False, 02:46:32 INFO - 'suite': 'dromaeojs-e10s', 02:46:32 INFO - 'system_bits': '32', 02:46:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:46:32 INFO - 'title': 'talos-linux64-ix-026', 02:46:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:46:32 INFO - 'use_talos_json': True, 02:46:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:46:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:46:32 INFO - 'work_dir': 'build'} 02:46:32 INFO - [mozharness: 2017-05-03 09:46:32.595237Z] Running clobber step. 02:46:32 INFO - Running pre-action listener: _resource_record_pre_action 02:46:32 INFO - Running main action method: clobber 02:46:32 INFO - rmtree: /builds/slave/test/build 02:46:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:46:34 INFO - Running post-action listener: _resource_record_post_action 02:46:34 INFO - [mozharness: 2017-05-03 09:46:34.180616Z] Finished clobber step (success) 02:46:34 INFO - [mozharness: 2017-05-03 09:46:34.180714Z] Running read-buildbot-config step. 02:46:34 INFO - Running pre-action listener: _resource_record_pre_action 02:46:34 INFO - Running main action method: read_buildbot_config 02:46:34 INFO - Using buildbot properties: 02:46:34 INFO - { 02:46:34 INFO - "project": "", 02:46:34 INFO - "product": "firefox", 02:46:34 INFO - "who": "cbook@mozilla.com", 02:46:34 INFO - "installer_path": "public/build/target.tar.bz2", 02:46:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:46:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:46:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 02:46:34 INFO - "stage_platform": "linux64-pgo", 02:46:34 INFO - "basedir": "/builds/slave/test", 02:46:34 INFO - "buildnumber": 190, 02:46:34 INFO - "platform": "ubuntu64_hw", 02:46:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:46:34 INFO - "slavebuilddir": "test", 02:46:34 INFO - "taskId": "LWQ02oLzTa-dzWwr0jJo-g", 02:46:34 INFO - "branch": "mozilla-central", 02:46:34 INFO - "script_repo_revision": "production", 02:46:34 INFO - "revision": "82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4", 02:46:34 INFO - "slavename": "talos-linux64-ix-026", 02:46:34 INFO - "repo_path": "mozilla-central" 02:46:34 INFO - } 02:46:34 INFO - Finding installer, test and symbols from parent task. 02:46:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LWQ02oLzTa-dzWwr0jJo-g'}, attempt #1 02:46:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LWQ02oLzTa-dzWwr0jJo-g'}, attempt #1 02:46:35 INFO - Task dependencies: EMWhUU_JRCK9aut9Z14sEg 02:46:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg'}, attempt #1 02:46:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.tar.bz2 02:46:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/test_packages.json 02:46:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.crashreporter-symbols.zip 02:46:35 INFO - Running post-action listener: _resource_record_post_action 02:46:35 INFO - [mozharness: 2017-05-03 09:46:35.565143Z] Finished read-buildbot-config step (success) 02:46:35 INFO - [mozharness: 2017-05-03 09:46:35.565396Z] Running download-and-extract step. 02:46:35 INFO - Running pre-action listener: _resource_record_pre_action 02:46:35 INFO - Running main action method: download_and_extract 02:46:35 INFO - mkdir: /builds/slave/test/build/tests 02:46:35 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')]} 02:46:35 INFO - trying https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.test_packages.json 02:46:35 INFO - Downloading https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:46:36 INFO - Downloaded 986 bytes. 02:46:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:46:36 INFO - Using the following test package requirements: 02:46:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:46:36 INFO - u'common': [u'target.common.tests.zip'], 02:46:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:46:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:46:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:46:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:46:36 INFO - u'mozbase': [u'target.common.tests.zip'], 02:46:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:46:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:46:36 INFO - u'web-platform': [u'target.common.tests.zip', 02:46:36 INFO - u'target.web-platform.tests.zip'], 02:46:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:46:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:46:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.common.tests.zip 02:46:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:46:36 INFO - Fetch https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.common.tests.zip into memory 02:46:37 INFO - Content-Length response header: 60559436 02:46:37 INFO - Bytes received: 60559436 02:46:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:46:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.common.tests.zip 02:46:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:46:47 INFO - Fetch https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.common.tests.zip into memory 02:46:48 INFO - Content-Length response header: 60559436 02:46:48 INFO - Bytes received: 60559436 02:46:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.talos.tests.zip 02:46:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:46:59 INFO - Fetch https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.talos.tests.zip into memory 02:46:59 INFO - Content-Length response header: 14408811 02:46:59 INFO - Bytes received: 14408811 02:47:00 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')]} 02:47:00 INFO - trying https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.tar.bz2 02:47:00 INFO - Downloading https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:47:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:47:01 INFO - Downloaded 64070352 bytes. 02:47:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.tar.bz2 02:47:01 INFO - mkdir: /builds/slave/test/properties 02:47:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:47:01 INFO - Writing to file /builds/slave/test/properties/build_url 02:47:01 INFO - Contents: 02:47:01 INFO - build_url:https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.tar.bz2 02:47:01 INFO - Running post-action listener: _resource_record_post_action 02:47:01 INFO - Running post-action listener: set_extra_try_arguments 02:47:01 INFO - [mozharness: 2017-05-03 09:47:01.233065Z] Finished download-and-extract step (success) 02:47:01 INFO - [mozharness: 2017-05-03 09:47:01.233162Z] Running populate-webroot step. 02:47:01 INFO - Running pre-action listener: _resource_record_pre_action 02:47:01 INFO - Running main action method: populate_webroot 02:47:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:47:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:47:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:47:01 INFO - '--tppagecycles', 02:47:01 INFO - '7'], 02:47:01 INFO - 'tests': ['tsvgm']}}, 02:47:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:47:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:47:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:47:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:47:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:47:01 INFO - 'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:47:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:47:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:47:01 INFO - 'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['damp', 'tps']}, 02:47:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:47:01 INFO - 'tests': ['damp', 'tps']}, 02:47:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['dromaeo_dom']}, 02:47:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:47:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:47:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:47:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['a11yr', 02:47:01 INFO - 'ts_paint', 02:47:01 INFO - 'tpaint', 02:47:01 INFO - 'sessionrestore', 02:47:01 INFO - 'sessionrestore_no_auto_restore', 02:47:01 INFO - 'tabpaint']}, 02:47:01 INFO - 'other-e10s': {'tests': ['a11yr', 02:47:01 INFO - 'ts_paint', 02:47:01 INFO - 'tpaint', 02:47:01 INFO - 'sessionrestore', 02:47:01 INFO - 'sessionrestore_no_auto_restore', 02:47:01 INFO - 'tabpaint']}, 02:47:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:47:01 INFO - 'ts_paint', 02:47:01 INFO - 'tpaint', 02:47:01 INFO - 'sessionrestore', 02:47:01 INFO - 'sessionrestore_no_auto_restore', 02:47:01 INFO - 'tabpaint']}, 02:47:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:47:01 INFO - 'ts_paint', 02:47:01 INFO - 'tpaint', 02:47:01 INFO - 'sessionrestore', 02:47:01 INFO - 'sessionrestore_no_auto_restore', 02:47:01 INFO - 'tabpaint']}, 02:47:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['a11yr', 02:47:01 INFO - 'ts_paint', 02:47:01 INFO - 'tpaint', 02:47:01 INFO - 'sessionrestore', 02:47:01 INFO - 'sessionrestore_no_auto_restore', 02:47:01 INFO - 'tabpaint']}, 02:47:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['a11yr', 02:47:01 INFO - 'ts_paint', 02:47:01 INFO - 'tpaint', 02:47:01 INFO - 'sessionrestore', 02:47:01 INFO - 'sessionrestore_no_auto_restore', 02:47:01 INFO - 'tabpaint']}, 02:47:01 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:47:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:47:01 INFO - 'bloom_basic_ref']}, 02:47:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['tsvgx', 02:47:01 INFO - 'tsvgr_opacity', 02:47:01 INFO - 'tart', 02:47:01 INFO - 'tscrollx', 02:47:01 INFO - 'cart', 02:47:01 INFO - 'tsvg_static']}, 02:47:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:47:01 INFO - 'tsvgr_opacity', 02:47:01 INFO - 'tart', 02:47:01 INFO - 'tscrollx', 02:47:01 INFO - 'cart', 02:47:01 INFO - 'tsvg_static']}, 02:47:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:47:01 INFO - 'talos_options': ['--disable-e10s'], 02:47:01 INFO - 'tests': ['tp5o']}, 02:47:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:47:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:47:01 INFO - 'talos_options': ['--disable-e10s', 02:47:01 INFO - '--xperf_path', 02:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:47:01 INFO - 'tests': ['tp5n']}, 02:47:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:47:01 INFO - 'talos_options': ['--xperf_path', 02:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:47:01 INFO - 'tests': ['tp5n']}}, 02:47:01 INFO - 'talos.zip': {'path': '', 02:47:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:47:01 INFO - Running post-action listener: _resource_record_post_action 02:47:01 INFO - [mozharness: 2017-05-03 09:47:01.246837Z] Finished populate-webroot step (success) 02:47:01 INFO - [mozharness: 2017-05-03 09:47:01.246926Z] Running create-virtualenv step. 02:47:01 INFO - Running pre-action listener: _resource_record_pre_action 02:47:01 INFO - Running main action method: create_virtualenv 02:47:01 INFO - Creating virtualenv /builds/slave/test/build/venv 02:47:01 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 02:47:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:47:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:47:01 INFO - Using real prefix '/usr' 02:47:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:47:01 INFO - Installing distribute.............................................................................................................................................................................................done. 02:47:03 INFO - Installing pip.................done. 02:47:03 INFO - Return code: 0 02:47:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:47:04 INFO - Reading from file tmpfile_stdout 02:47:04 INFO - Output received: 02:47:04 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) 02:47:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:47: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')]} 02:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47: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')]} 02:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, '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': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', '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 02:47: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', 'pip>=1.5'] in /builds/slave/test/build 02:47: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 pip>=1.5 02:47:04 INFO - Using env: {'DISPLAY': ':0', 02:47:04 INFO - 'HOME': '/home/cltbld', 02:47:04 INFO - 'LANG': 'en_US.UTF-8', 02:47:04 INFO - 'LANGUAGE': 'en_US:en', 02:47:04 INFO - 'LOGNAME': 'cltbld', 02:47:04 INFO - 'MAIL': '/var/mail/cltbld', 02:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:04 INFO - 'MOZ_NO_REMOTE': '1', 02:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:04 INFO - 'NO_EM_RESTART': '1', 02:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:04 INFO - 'PWD': '/builds/slave/test', 02:47:04 INFO - 'SHELL': '/bin/bash', 02:47:04 INFO - 'SHLVL': '1', 02:47:04 INFO - 'TERM': 'linux', 02:47:04 INFO - 'TMOUT': '86400', 02:47:04 INFO - 'USER': 'cltbld', 02:47:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:04 INFO - '_': '/tools/buildbot/bin/python'} 02:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:04 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 02:47:04 INFO - Cleaning up... 02:47:04 INFO - Return code: 0 02:47:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:47: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')]} 02:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47: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')]} 02:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47: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', '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 0x190e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, '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': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', '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 02:47: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:47: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 psutil>=3.1.1 02:47:04 INFO - Using env: {'DISPLAY': ':0', 02:47:04 INFO - 'HOME': '/home/cltbld', 02:47:04 INFO - 'LANG': 'en_US.UTF-8', 02:47:04 INFO - 'LANGUAGE': 'en_US:en', 02:47:04 INFO - 'LOGNAME': 'cltbld', 02:47:04 INFO - 'MAIL': '/var/mail/cltbld', 02:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:04 INFO - 'MOZ_NO_REMOTE': '1', 02:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:04 INFO - 'NO_EM_RESTART': '1', 02:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:04 INFO - 'PWD': '/builds/slave/test', 02:47:04 INFO - 'SHELL': '/bin/bash', 02:47:04 INFO - 'SHLVL': '1', 02:47:04 INFO - 'TERM': 'linux', 02:47:04 INFO - 'TMOUT': '86400', 02:47:04 INFO - 'USER': 'cltbld', 02:47:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:04 INFO - '_': '/tools/buildbot/bin/python'} 02:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:04 INFO - Downloading/unpacking psutil>=3.1.1 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:05 INFO - Installing collected packages: psutil 02:47:05 INFO - Running setup.py install for psutil 02:47:05 INFO - building 'psutil._psutil_linux' extension 02:47:05 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 02:47:05 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 02:47:05 INFO - building 'psutil._psutil_posix' extension 02:47:05 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 02:47:06 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 02:47:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:06 INFO - Successfully installed psutil 02:47:06 INFO - Cleaning up... 02:47:06 INFO - Return code: 0 02:47:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:47:06 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')]} 02:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:06 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')]} 02:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:06 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 0x190e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, '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': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', '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 02:47:06 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 02:47:06 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 02:47:06 INFO - Using env: {'DISPLAY': ':0', 02:47:06 INFO - 'HOME': '/home/cltbld', 02:47:06 INFO - 'LANG': 'en_US.UTF-8', 02:47:06 INFO - 'LANGUAGE': 'en_US:en', 02:47:06 INFO - 'LOGNAME': 'cltbld', 02:47:06 INFO - 'MAIL': '/var/mail/cltbld', 02:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:06 INFO - 'MOZ_NO_REMOTE': '1', 02:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:06 INFO - 'NO_EM_RESTART': '1', 02:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:06 INFO - 'PWD': '/builds/slave/test', 02:47:06 INFO - 'SHELL': '/bin/bash', 02:47:06 INFO - 'SHLVL': '1', 02:47:06 INFO - 'TERM': 'linux', 02:47:06 INFO - 'TMOUT': '86400', 02:47:06 INFO - 'USER': 'cltbld', 02:47:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:06 INFO - '_': '/tools/buildbot/bin/python'} 02:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:47:07 INFO - Installing collected packages: mozsystemmonitor 02:47:07 INFO - Running setup.py install for mozsystemmonitor 02:47:07 INFO - Successfully installed mozsystemmonitor 02:47:07 INFO - Cleaning up... 02:47:07 INFO - Return code: 0 02:47:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:47: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')]} 02:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47: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')]} 02:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:07 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 0x190e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, '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': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', '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 02:47:07 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 02:47:07 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 02:47:07 INFO - Using env: {'DISPLAY': ':0', 02:47:07 INFO - 'HOME': '/home/cltbld', 02:47:07 INFO - 'LANG': 'en_US.UTF-8', 02:47:07 INFO - 'LANGUAGE': 'en_US:en', 02:47:07 INFO - 'LOGNAME': 'cltbld', 02:47:07 INFO - 'MAIL': '/var/mail/cltbld', 02:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:07 INFO - 'MOZ_NO_REMOTE': '1', 02:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:07 INFO - 'NO_EM_RESTART': '1', 02:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:07 INFO - 'PWD': '/builds/slave/test', 02:47:07 INFO - 'SHELL': '/bin/bash', 02:47:07 INFO - 'SHLVL': '1', 02:47:07 INFO - 'TERM': 'linux', 02:47:07 INFO - 'TMOUT': '86400', 02:47:07 INFO - 'USER': 'cltbld', 02:47:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:07 INFO - '_': '/tools/buildbot/bin/python'} 02:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:07 INFO - Downloading/unpacking jsonschema==2.5.1 02:47:07 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 02:47:07 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 02:47:07 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 02:47:07 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 02:47:07 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 02:47:07 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 02:47:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:47:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:47:08 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 02:47:08 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 02:47:08 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 02:47:08 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 02:47:08 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 02:47:08 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 02:47:09 INFO - Downloading functools32-3.2.3-2.tar.gz 02:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:47:09 INFO - warning: no files found matching '*.txt' 02:47:09 INFO - no previously-included directories found matching 'build' 02:47:09 INFO - no previously-included directories found matching 'dist' 02:47:09 INFO - no previously-included directories found matching '.git*' 02:47:09 INFO - Installing collected packages: jsonschema, functools32 02:47:09 INFO - Running setup.py install for functools32 02:47:09 INFO - warning: no files found matching '*.txt' 02:47:09 INFO - no previously-included directories found matching 'build' 02:47:09 INFO - no previously-included directories found matching 'dist' 02:47:09 INFO - no previously-included directories found matching '.git*' 02:47:09 INFO - Successfully installed jsonschema functools32 02:47:09 INFO - Cleaning up... 02:47:09 INFO - Return code: 0 02:47:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:47:09 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')]} 02:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:09 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')]} 02:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:09 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 0x190e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, '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': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', '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 02:47:09 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 02:47:09 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 02:47:09 INFO - Using env: {'DISPLAY': ':0', 02:47:09 INFO - 'HOME': '/home/cltbld', 02:47:09 INFO - 'LANG': 'en_US.UTF-8', 02:47:09 INFO - 'LANGUAGE': 'en_US:en', 02:47:09 INFO - 'LOGNAME': 'cltbld', 02:47:09 INFO - 'MAIL': '/var/mail/cltbld', 02:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:09 INFO - 'MOZ_NO_REMOTE': '1', 02:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:09 INFO - 'NO_EM_RESTART': '1', 02:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:09 INFO - 'PWD': '/builds/slave/test', 02:47:09 INFO - 'SHELL': '/bin/bash', 02:47:09 INFO - 'SHLVL': '1', 02:47:09 INFO - 'TERM': 'linux', 02:47:09 INFO - 'TMOUT': '86400', 02:47:09 INFO - 'USER': 'cltbld', 02:47:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:09 INFO - '_': '/tools/buildbot/bin/python'} 02:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:47:09 INFO - Cleaning up... 02:47:09 INFO - Return code: 0 02:47:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:47:09 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')]} 02:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:09 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')]} 02:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:09 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 0x190e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, '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': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', '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 02:47:09 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 02:47:09 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 02:47:09 INFO - Using env: {'DISPLAY': ':0', 02:47:09 INFO - 'HOME': '/home/cltbld', 02:47:09 INFO - 'LANG': 'en_US.UTF-8', 02:47:09 INFO - 'LANGUAGE': 'en_US:en', 02:47:09 INFO - 'LOGNAME': 'cltbld', 02:47:09 INFO - 'MAIL': '/var/mail/cltbld', 02:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:09 INFO - 'MOZ_NO_REMOTE': '1', 02:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:09 INFO - 'NO_EM_RESTART': '1', 02:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:09 INFO - 'PWD': '/builds/slave/test', 02:47:09 INFO - 'SHELL': '/bin/bash', 02:47:09 INFO - 'SHLVL': '1', 02:47:09 INFO - 'TERM': 'linux', 02:47:09 INFO - 'TMOUT': '86400', 02:47:09 INFO - 'USER': 'cltbld', 02:47:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:09 INFO - '_': '/tools/buildbot/bin/python'} 02:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:09 INFO - Downloading/unpacking blobuploader==1.2.4 02:47:09 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 02:47:09 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 02:47:09 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 02:47:09 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 02:47:09 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 02:47:09 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 02:47:10 INFO - Downloading blobuploader-1.2.4.tar.gz 02:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:47:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:47:10 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 02:47:10 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 02:47:10 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 02:47:10 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 02:47:10 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 02:47:10 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 02:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:47:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:47:11 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 02:47:11 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 02:47:11 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 02:47:11 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 02:47:11 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 02:47:11 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 02:47:11 INFO - Downloading docopt-0.6.1.tar.gz 02:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:47:11 INFO - Installing collected packages: blobuploader, requests, docopt 02:47:11 INFO - Running setup.py install for blobuploader 02:47:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:47:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:47:11 INFO - Running setup.py install for requests 02:47:11 INFO - Running setup.py install for docopt 02:47:11 INFO - Successfully installed blobuploader requests docopt 02:47:11 INFO - Cleaning up... 02:47:12 INFO - Return code: 0 02:47:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:12 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')]} 02:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:12 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')]} 02:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:12 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 0x190e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, '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': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', '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 02:47:12 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 02:47:12 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 02:47:12 INFO - Using env: {'DISPLAY': ':0', 02:47:12 INFO - 'HOME': '/home/cltbld', 02:47:12 INFO - 'LANG': 'en_US.UTF-8', 02:47:12 INFO - 'LANGUAGE': 'en_US:en', 02:47:12 INFO - 'LOGNAME': 'cltbld', 02:47:12 INFO - 'MAIL': '/var/mail/cltbld', 02:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:12 INFO - 'MOZ_NO_REMOTE': '1', 02:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:12 INFO - 'NO_EM_RESTART': '1', 02:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:12 INFO - 'PWD': '/builds/slave/test', 02:47:12 INFO - 'SHELL': '/bin/bash', 02:47:12 INFO - 'SHLVL': '1', 02:47:12 INFO - 'TERM': 'linux', 02:47:12 INFO - 'TMOUT': '86400', 02:47:12 INFO - 'USER': 'cltbld', 02:47:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:12 INFO - '_': '/tools/buildbot/bin/python'} 02:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:47:12 INFO - Running setup.py (path:/tmp/pip-tttHFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:47:12 INFO - Running setup.py (path:/tmp/pip-ZMd23o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:47:12 INFO - Running setup.py (path:/tmp/pip-rm3SAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:47:12 INFO - Running setup.py (path:/tmp/pip-0yDc51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:47:12 INFO - Running setup.py (path:/tmp/pip-FzzNH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:47:12 INFO - Running setup.py (path:/tmp/pip-4v_1go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:47:12 INFO - Running setup.py (path:/tmp/pip-qXIpVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:47:12 INFO - Running setup.py (path:/tmp/pip-XAvpKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:47:12 INFO - Running setup.py (path:/tmp/pip-TfZDW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:47:12 INFO - Running setup.py (path:/tmp/pip-n75Ffn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:47:12 INFO - Running setup.py (path:/tmp/pip-Pmt7CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:47:13 INFO - Running setup.py (path:/tmp/pip-zBv0Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:47:13 INFO - Running setup.py (path:/tmp/pip-1WJYuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:47:13 INFO - Running setup.py (path:/tmp/pip-0j6Asz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:13 INFO - Running setup.py (path:/tmp/pip-XeL6gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:47:13 INFO - Running setup.py (path:/tmp/pip-y74VpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:47:13 INFO - Running setup.py (path:/tmp/pip-xqY3M7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:47:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:47:13 INFO - Running setup.py install for manifestparser 02:47:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Running setup.py install for mozcrash 02:47:13 INFO - Running setup.py install for mozdebug 02:47:13 INFO - Running setup.py install for mozdevice 02:47:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Running setup.py install for mozfile 02:47:13 INFO - Running setup.py install for mozhttpd 02:47:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Running setup.py install for mozinfo 02:47:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Running setup.py install for mozInstall 02:47:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Running setup.py install for mozleak 02:47:14 INFO - Running setup.py install for mozlog 02:47:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Running setup.py install for moznetwork 02:47:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Running setup.py install for mozprocess 02:47:14 INFO - Running setup.py install for mozprofile 02:47:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Running setup.py install for mozrunner 02:47:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Running setup.py install for mozscreenshot 02:47:15 INFO - Running setup.py install for moztest 02:47:15 INFO - Running setup.py install for mozversion 02:47:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:47:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:47:15 INFO - Cleaning up... 02:47:15 INFO - Return code: 0 02:47:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:15 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')]} 02:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:15 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')]} 02:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:15 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 0x190e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, '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': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', '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 02:47:15 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 02:47:15 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 02:47:15 INFO - Using env: {'DISPLAY': ':0', 02:47:15 INFO - 'HOME': '/home/cltbld', 02:47:15 INFO - 'LANG': 'en_US.UTF-8', 02:47:15 INFO - 'LANGUAGE': 'en_US:en', 02:47:15 INFO - 'LOGNAME': 'cltbld', 02:47:15 INFO - 'MAIL': '/var/mail/cltbld', 02:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:15 INFO - 'MOZ_NO_REMOTE': '1', 02:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:15 INFO - 'NO_EM_RESTART': '1', 02:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:15 INFO - 'PWD': '/builds/slave/test', 02:47:15 INFO - 'SHELL': '/bin/bash', 02:47:15 INFO - 'SHLVL': '1', 02:47:15 INFO - 'TERM': 'linux', 02:47:15 INFO - 'TMOUT': '86400', 02:47:15 INFO - 'USER': 'cltbld', 02:47:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:15 INFO - '_': '/tools/buildbot/bin/python'} 02:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:47:15 INFO - Running setup.py (path:/tmp/pip-iXt3TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:47:15 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)) 02:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:47:15 INFO - Running setup.py (path:/tmp/pip-DgRfPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:47:15 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)) 02:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:47:15 INFO - Running setup.py (path:/tmp/pip-pQ7CnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:47:15 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)) 02:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:47:15 INFO - Running setup.py (path:/tmp/pip-sFUPtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:47:15 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)) 02:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:47:15 INFO - Running setup.py (path:/tmp/pip-0bgs6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:47:15 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)) 02:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:47:15 INFO - Running setup.py (path:/tmp/pip-2bDWPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:47:15 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)) 02:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:47:15 INFO - Running setup.py (path:/tmp/pip-UPzhj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:47:15 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)) 02:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:47:15 INFO - Running setup.py (path:/tmp/pip-umrmnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:47:16 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)) 02:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:47:16 INFO - Running setup.py (path:/tmp/pip-4wr_Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:47:16 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)) 02:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:47:16 INFO - Running setup.py (path:/tmp/pip-fpkslu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:47:16 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)) 02:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:47:16 INFO - Running setup.py (path:/tmp/pip-B4eIVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:47:16 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)) 02:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:47:16 INFO - Running setup.py (path:/tmp/pip-Heuz3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:47:16 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)) 02:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:47:16 INFO - Running setup.py (path:/tmp/pip-Bd42n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:47:16 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)) 02:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:47:16 INFO - Running setup.py (path:/tmp/pip-P2ND9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:47:16 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)) 02:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:16 INFO - Running setup.py (path:/tmp/pip-MpprL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:16 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)) 02:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:47:16 INFO - Running setup.py (path:/tmp/pip-acYAlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:47:16 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)) 02:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:47:16 INFO - Running setup.py (path:/tmp/pip-OHksHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:47:16 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)) 02:47:16 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)) 02:47:16 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)) 02:47:16 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)) 02:47:16 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)) 02:47:16 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)) 02:47:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:47:16 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 02:47:16 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 02:47:16 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 02:47:16 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 02:47:16 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 02:47:16 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 02:47:17 INFO - Downloading blessings-1.6.tar.gz 02:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:47:17 INFO - Installing collected packages: blessings 02:47:17 INFO - Running setup.py install for blessings 02:47:17 INFO - Successfully installed blessings 02:47:17 INFO - Cleaning up... 02:47:17 INFO - Return code: 0 02:47:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:18 INFO - Reading from file tmpfile_stdout 02:47:18 INFO - Current package versions: 02:47:18 INFO - argparse == 1.2.1 02:47:18 INFO - blessings == 1.6 02:47:18 INFO - blobuploader == 1.2.4 02:47:18 INFO - docopt == 0.6.1 02:47:18 INFO - functools32 == 3.2.3-2 02:47:18 INFO - jsonschema == 2.5.1 02:47:18 INFO - manifestparser == 1.1 02:47:18 INFO - mozInstall == 1.12 02:47:18 INFO - mozcrash == 1.0 02:47:18 INFO - mozdebug == 0.1 02:47:18 INFO - mozdevice == 0.50 02:47:18 INFO - mozfile == 1.2 02:47:18 INFO - mozhttpd == 0.7 02:47:18 INFO - mozinfo == 0.9 02:47:18 INFO - mozleak == 0.1 02:47:18 INFO - mozlog == 3.4 02:47:18 INFO - moznetwork == 0.27 02:47:18 INFO - mozprocess == 0.25 02:47:18 INFO - mozprofile == 0.28 02:47:18 INFO - mozrunner == 6.13 02:47:18 INFO - mozscreenshot == 0.1 02:47:18 INFO - mozsystemmonitor == 0.3 02:47:18 INFO - moztest == 0.8 02:47:18 INFO - mozversion == 1.4 02:47:18 INFO - psutil == 3.1.1 02:47:18 INFO - requests == 1.2.3 02:47:18 INFO - wsgiref == 0.1.2 02:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:18 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')]} 02:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:18 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')]} 02:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:18 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 0x190e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, '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': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', '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 02:47:18 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 02:47:18 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 02:47:18 INFO - Using env: {'DISPLAY': ':0', 02:47:18 INFO - 'HOME': '/home/cltbld', 02:47:18 INFO - 'LANG': 'en_US.UTF-8', 02:47:18 INFO - 'LANGUAGE': 'en_US:en', 02:47:18 INFO - 'LOGNAME': 'cltbld', 02:47:18 INFO - 'MAIL': '/var/mail/cltbld', 02:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:18 INFO - 'MOZ_NO_REMOTE': '1', 02:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:18 INFO - 'NO_EM_RESTART': '1', 02:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:18 INFO - 'PWD': '/builds/slave/test', 02:47:18 INFO - 'SHELL': '/bin/bash', 02:47:18 INFO - 'SHLVL': '1', 02:47:18 INFO - 'TERM': 'linux', 02:47:18 INFO - 'TMOUT': '86400', 02:47:18 INFO - 'USER': 'cltbld', 02:47:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:18 INFO - '_': '/tools/buildbot/bin/python'} 02:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:18 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)) 02:47:18 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)) 02:47:18 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)) 02:47:18 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)) 02:47:18 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)) 02:47:18 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)) 02:47:18 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)) 02:47:18 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)) 02:47:18 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)) 02:47:18 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)) 02:47:18 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)) 02:47:18 INFO - Cleaning up... 02:47:18 INFO - Return code: 0 02:47:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:47:18 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')]} 02:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:18 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')]} 02:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x190e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, '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': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', '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 02:47:18 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 02:47:18 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 02:47:18 INFO - Using env: {'DISPLAY': ':0', 02:47:18 INFO - 'HOME': '/home/cltbld', 02:47:18 INFO - 'LANG': 'en_US.UTF-8', 02:47:18 INFO - 'LANGUAGE': 'en_US:en', 02:47:18 INFO - 'LOGNAME': 'cltbld', 02:47:18 INFO - 'MAIL': '/var/mail/cltbld', 02:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:18 INFO - 'MOZ_NO_REMOTE': '1', 02:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:18 INFO - 'NO_EM_RESTART': '1', 02:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:18 INFO - 'PWD': '/builds/slave/test', 02:47:18 INFO - 'SHELL': '/bin/bash', 02:47:18 INFO - 'SHLVL': '1', 02:47:18 INFO - 'TERM': 'linux', 02:47:18 INFO - 'TMOUT': '86400', 02:47:18 INFO - 'USER': 'cltbld', 02:47:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:18 INFO - '_': '/tools/buildbot/bin/python'} 02:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:47:18 INFO - Cleaning up... 02:47:18 INFO - Return code: 0 02:47:18 INFO - Running post-action listener: _resource_record_post_action 02:47:18 INFO - Running post-action listener: _start_resource_monitoring 02:47:18 INFO - Starting resource monitoring. 02:47:18 INFO - [mozharness: 2017-05-03 09:47:18.665720Z] Finished create-virtualenv step (success) 02:47:18 INFO - [mozharness: 2017-05-03 09:47:18.666228Z] Running install step. 02:47:18 INFO - Running pre-action listener: _resource_record_pre_action 02:47:18 INFO - Running main action method: install 02:47:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:18 INFO - Reading from file tmpfile_stdout 02:47:18 INFO - Detecting whether we're running mozinstall >=1.0... 02:47:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:47:18 INFO - Reading from file tmpfile_stdout 02:47:18 INFO - Output received: 02:47:18 INFO - Usage: mozinstall [options] installer 02:47:18 INFO - Options: 02:47:18 INFO - -h, --help show this help message and exit 02:47:18 INFO - -d DEST, --destination=DEST 02:47:18 INFO - Directory to install application into. [default: 02:47:18 INFO - "/builds/slave/test"] 02:47:18 INFO - --app=APP Application being installed. [default: firefox] 02:47:18 INFO - mkdir: /builds/slave/test/build/application 02:47:18 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'] 02:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:47:35 INFO - Reading from file tmpfile_stdout 02:47:35 INFO - Output received: 02:47:35 INFO - /builds/slave/test/build/application/firefox/firefox 02:47:35 INFO - Running post-action listener: _resource_record_post_action 02:47:35 INFO - [mozharness: 2017-05-03 09:47:35.119335Z] Finished install step (success) 02:47:35 INFO - [mozharness: 2017-05-03 09:47:35.119581Z] Running run-tests step. 02:47:35 INFO - Running pre-action listener: _resource_record_pre_action 02:47:35 INFO - Running main action method: run_tests 02:47:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:47:35 INFO - Python 2.7.3 02:47:35 INFO - Return code: 0 02:47:35 INFO - grabbing minidump binary from tooltool 02:47:35 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')]} 02:47:35 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 0x1ba9290>, '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 0x1ba9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:47:35 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 02:47:35 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 02:47:35 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 02:47:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:47:35 INFO - Return code: 0 02:47:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:47:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:47:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:47:35 INFO - ENV: RUST_BACKTRACE is now 1 02:47:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:47:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:47:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 02:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 02:47:35 INFO - Using env: {'DISPLAY': ':0', 02:47:35 INFO - 'HOME': '/home/cltbld', 02:47:35 INFO - 'LANG': 'en_US.UTF-8', 02:47:35 INFO - 'LANGUAGE': 'en_US:en', 02:47:35 INFO - 'LOGNAME': 'cltbld', 02:47:35 INFO - 'MAIL': '/var/mail/cltbld', 02:47:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:47:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:35 INFO - 'MOZ_NO_REMOTE': '1', 02:47:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:35 INFO - 'NO_EM_RESTART': '1', 02:47:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:35 INFO - 'PWD': '/builds/slave/test', 02:47:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:47:35 INFO - 'RUST_BACKTRACE': '1', 02:47:35 INFO - 'SHELL': '/bin/bash', 02:47:35 INFO - 'SHLVL': '1', 02:47:35 INFO - 'TERM': 'linux', 02:47:35 INFO - 'TMOUT': '86400', 02:47:35 INFO - 'USER': 'cltbld', 02:47:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645', 02:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:35 INFO - '_': '/tools/buildbot/bin/python'} 02:47:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 02:47:35 INFO - mozversion application_buildid: 20170503082957 02:47:35 INFO - mozversion application_changeset: 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 02:47:35 INFO - mozversion application_display_name: Nightly 02:47:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:47:35 INFO - mozversion application_name: Firefox 02:47:35 INFO - mozversion application_remotingname: firefox 02:47:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:47:35 INFO - mozversion application_vendor: Mozilla 02:47:35 INFO - mozversion application_version: 55.0a1 02:47:35 INFO - mozversion platform_buildid: 20170503082957 02:47:35 INFO - mozversion platform_changeset: 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 02:47:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:47:35 INFO - mozversion platform_version: 55.0a1 02:47:35 INFO - using testdate: 1493804855 02:47:35 INFO - actual date: 1493804855 02:47:35 INFO - starting webserver on 'localhost:43029' 02:47:35 INFO - SUITE-START | Running 2 tests 02:47:35 INFO - TEST-START | dromaeo_css 02:47:35 INFO - operating with platform_type : linux_ 02:47:35 INFO - Initialising browser for dromaeo_css test... 02:47:35 INFO - TEST-INFO | started process 1520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKiu3Hr/profile http://localhost:43029/getInfo.html) 02:47:39 INFO - PID 1520 | __metrics Screen width/height:1600/1200 02:47:39 INFO - PID 1520 | colorDepth:24 02:47:39 INFO - PID 1520 | Browser inner width/height: 1024/695 02:47:39 INFO - PID 1520 | __metrics 02:47:41 INFO - TEST-INFO | 1520: exit 0 02:47:41 INFO - Browser initialized. 02:47:41 INFO - Running cycle 1/1 for dromaeo_css test... 02:47:41 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKiu3Hr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:53 INFO - PID 1655 | RSS: Main: 157282304 02:47:53 INFO - PID 1655 | 02:50:54 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:43029/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43029/tests/dromaeo/cssquery-ext.html) 02:50:56 INFO - PID 1655 | RSS: Main: 163512320 02:50:56 INFO - PID 1655 | 02:53:58 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:43029/tests/dromaeo/cssquery-ext.html (next: http://localhost:43029/tests/dromaeo/cssquery-jquery.html) 02:53:58 INFO - PID 1655 | RSS: Main: 156717056 02:53:58 INFO - PID 1655 | 02:57:00 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:43029/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43029/tests/dromaeo/cssquery-mootools.html) 02:57:01 INFO - PID 1655 | RSS: Main: 164839424 02:57:01 INFO - PID 1655 | 03:00:02 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:43029/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43029/tests/dromaeo/cssquery-prototype.html) 03:00:03 INFO - PID 1655 | RSS: Main: 156852224 03:00:03 INFO - PID 1655 | 03:03:05 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:43029/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43029/tests/dromaeo/cssquery-yui.html) 03:03:06 INFO - PID 1655 | RSS: Main: 160514048 03:03:06 INFO - PID 1655 | 03:06:07 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:43029/tests/dromaeo/cssquery-yui.html (next: http://localhost:43029/tests/dromaeo/cssquery-dojo.html) 03:06:08 INFO - PID 1655 | RSS: Main: 162504704 03:06:08 INFO - PID 1655 | 03:06:08 INFO - PID 1655 | __start_tp_report 03:06:08 INFO - PID 1655 | _x_x_mozilla_page_load 03:06:08 INFO - PID 1655 | _x_x_mozilla_page_load_details 03:06:08 INFO - PID 1655 | |i|pagename|runs| 03:06:08 INFO - PID 1655 | |0;dojo.html;3430.485427185922;3431.828408579572;3451.326991236709;3462.7229821614274;3465.0297916583336;5841.299044114701;5990.910136347953;5992.310884248307;6035.879282414349;6047.5766696331275;5970.79102231422;5982.79060232892;6029.366916473762;6075.301340345862;6105.481034112106;5217.973910130463;5310.309659744228;5317.202419637066;5329.173978033392;5383.4616538346045;5369.812056578021;5433.836984890439;5439.129739241722;5446.210299506589;5450.672959622435;5196.8960620787375;5256.579473642099;5320.973395133;5376.193570964367;5410.08028635129;5378.650387724824;5398.379186393576;5405.378381486101;5410.161424979135;5423.430539793304;5295.443978382253;5348.438413966555;5364.088105022156;5369.140937450028;5370.650907690988;5827.271591051119;5978.342382337939;6031.065184896348;6039.5772295939305;6051.878962420771;6314.147590075327;6426.325235850215;6478.805635830886;6498;6528.575642583217;6603.7688680895935;6615.4046135848;6628.93371066288;6641.402273795382;6643.103181070542;6063.18147050147;6077.817665470043;6086.634801911855;6147.66187859663;6166.414190651881;6450.645214513153;6547.410733034049;6595.406413422719;6655.900161497581;6717.56335838169;6182.505399568024;6255.093011513305;6326.145970294044;6429;6467.935320646733;6488.448481879093;6512.641804700787;6553.180852393451;6563.704633291513;6579.276279609239;6497.415232628991;6505.772297969548;6514.511411644051;6544.803655890331;6554.442872355808;6277.529185311028;6353.841153971188;6433.613983161025;6517.934820651828;6549.705263263165;4996.325496058058;4999.550040496373;5000.74996250186;5008.248762685626;5023.321851549994;4388.100439409914;4394.736315821061;4396.07682386696;4398.64810815134;4444.488883778342;5957.255343082114;6026;6171.043488259327;6174.598651087755;6177.382261773877;6390.84022899422;6442.516811239082;6476.125723027425;6540.149780528501;6560.048792924999;6204.751809927642;6220.626762394271;6224.06639004153;6234.657093859882;6235.438810507076;5693.772249109989;5705.942940570541;5709.115087161496;5714.371419143891;5750.942490575041;6527.836804079841;6702.061711360413;6786.1856577210065;6867.244603093755;6868;6549.508786840911;6552.049952756728;6586.341365863375;6607.5044371673275;6613.867722645617;6759.5606285591275;6844.486663500357;6860.759873404407;6883.690233939585;6901.413379862567;6221.377862213742;6270.874582508415;6383.234011918599;6445.2587952386075;6448.806535803933;6515.641639709862;6578.210614726264;6618.90071648916;6621.073049772939;6639.738449694542;6133.793750436688;6149.815505534841;6399.296077431386;6405.51958603116;6427.839304017437;6277.623342599459;6279.466245369194;6359.173307470184;6383.202099737533;6384.648844313608;6160.13758073861;6332.746690132343;6337.176167098248;6386.93613063882;6401.8719625608155;6170.444659980623;6430.614163150226;6433.356664333529;6440.935590644033;6458.741650333934;6109.541784366102;6124.655575319917;6126.754929802758;6159.106929495288;6165.907511387243 03:06:08 INFO - PID 1655 | |1;ext.html;684.5892464521288;725.7097161135545;742.6323969635032;1059.5602824827697;1066.0405634928568;37410.43884341734;38563.22873542528;38573.80713096434;38693.03267418316;38896.80551597238;39287.80356098215;39916.800415997954;39975.60024399755;40014.59985400145;40089.198216035664;7173.569585824867;7237.89143162853;7285.708571657127;7369.4841361104745;7375.631218439084;7300.269973002683;7439.7396091136825;7465.8506829863645;7489;7504.737334193304;7487.925120748777;7564.697412103509;7574.583397913113;7576.242375762407;7594.73418430355;7468.850622987564;7491.925080749204;7510.3616192623695;7510.924890751132;7523.210062943394;7387.519811212254;7389.66746496409;7439.776806695808;7479.177290498041;7492.812679682997;36887.63112368869;37276.25447491035;37340.06649833749;37348.43977340342;37383.626163738285;3646.106703857572;3685.1339935115225;3694.501242332278;3695.279420512974;3702.38910579754;30413.847930760425;30485.695143048728;30634.387312253853;30658.69341306603;30719.385612287853;3769.679577235911;3790.56408513019;3793.8103094845146;3818.84724611018;3839.6352346527315;202475;203767;204261;216622;222310.99999999837;47140;47452.288215676796;47460.5253947463;47554.28668569905;47670.28494572584;49149.754251228514;49418.75290623524;57342.13986790201;57757.42242577604;57767.711161444764;14387.352569134415;14700.264986750619;14710.19093949843;14716.484923027643;14730.92634536842;11612.709682258012;11622.244554103956;11645;11666.066714662807;11679.532818687327;14943;14983.925080374529;15053.096814191184;15152.545423637308;15257.08457492554;6146.569740118149;6173.765246950627;6196.380361963767;6201.596896201732;6396.968015159894;1066.7439814444479;1093.557109370706;1098.340995402752;1107.7119948813368;1109.2346281066039;26345.736542634328;26427.735722642527;26676.73323266781;26842.865785670947;26962.865185674338;1181.5746331320718;1188.9524419023314;1189.0784641902594;1190.6844686158174;1223.663492539541;13937.512187073606;13988.72022559543;14090.85909140916;14104.506342277971;14144.151350918977;287281;287863;287942;288926;290710;54369.456305437234;54795.726021369635;54926.45073549293;54967.45032549623;55044.724776375864;1490.9850901490847;1502.9624259393383;1540.376147660177;1546.4741987724228;1553.324303927795;24614.630780537947;25677.87161064183;25951.091711789995;25961.221163365128;26182.476350473265;39927.2014559713;40226.79886600548;40238;40290.798546007085;40295.194096117324;222531;222923;224026;224141;224798;35342;36179.095522612144;36223.27553448969;36320;36390.27219455543;42719.57280427156;44940;45243;45321.77339113283;45424.77287613673;31908.680913190572;32601.67398326081;32607.18482037968;33067.503987439726;33805.386490406825;33091.83454082714;33369.66630333666;33729.494057588665;33743.4938475928;34760.82619586886;38140.809295953346;39408.80295598504;39747;39865.80067099646;41147.7942610285;32239.516407253443;32403.675963240064;33176;33460;33996.3200735979;25328;27579;27600.171994840188;27611.171664849284;27632.585511216945 03:06:08 INFO - PID 1655 | |2;jquery.html;436.3476602479293;439.8504508467121;447.65754198038525;450.6214779585148;460.12346479955676;20239.291624793135;20963.790362096395;21063.47341316468;21600.459988500294;21747;21171.047302871368;21247.57504849902;21368;21450.785492145074;23248.76751232487;5340.412554618989;5391.919121213185;5576.776928922838;5592.832215033535;5603;4250.957490425102;5487.6158668892995;5500.339959204881;5521.420250873661;5523.530499907512;5474.343078830546;5487.75305111269;5498.037843377413;5501.504864562188;5516.7517461714115;5316.76074576645;5473.06957817172;5491.505764481176;5529.778808847682;5540.307461567304;4985.277134815467;5016.3227964224725;5023.874403139914;5028.84913452597;5034.848954531333;25739.742602573922;26104.477910441874;26142.215733527835;26322.473550529074;26746.19761407161;2078.95842083159;2144.088762276042;2166.19850655257;2171.7176767020346;2199.6590528468114;17712.822871771245;17959.371422000168;18158.364457244064;18244.17901194436;18280.725789113174;2145;2231.2190733243397;2246.84272100953;2268.3081660093667;2277.8633282003134;104917.47541262321;109446.3351045839;111554.88445115526;114080;115513;11902.821457678141;12018.819717704242;12300.630981070582;12317.753644927052;12685.175463594836;17255.91372043132;17276.740848887275;17389;17407.56481087983;17435.302587896596;8305;8518.57407129641;8626.956865215634;8677.956610216908;8692.434991725517;7697.960040589248;7775.922240777633;7791.454598178073;7900.525968441912;7979.68081276754;7801.294385167113;8048.758537243892;8070.878936815952;8129.959350203211;8149.959250203711;2242.943926401853;2256.266713318178;2264.66030095487;2282.167009041688;2387.7855584892677;980.161961522902;1003.9659151074259;1010.4543546484816;1010.9595616175418;1047.544318221576;18870.339538116375;18889.433317000512;19238;19418.12618432174;19707;1026.0812281034514;1036.657902892044;1037.304007947012;1052.1740433759462;1061.1298735037349;10594.894051059391;10699.94650026745;10876.510557024953;10898.291611045257;10899.400532970603;490970;538698;540795;541422;550894.4552772345;96575;99033;99832.50083749535;101032;101803;1219.1039585904352;1227.643983244849;1272.6500212441654;1281.5706738242607;1283.794592865137;20394.490137746674;20472.69290960607;21229.256976006385;21262.574748504634;21317.36047918565;45120.77439612781;46764.7661761689;46892.7655361721;46984;47034;60776.392236077074;61098.69450652718;61564.38435615587;62141.68929155325;62511;9074.228690561113;9178;9262;9262.53687315645;9317.254619630277;13846.307684615931;14267;14626.780598290821;14817.777733333793;15464.84535154679;12204.389780511117;12586.496540138292;12778.424970876518;12806.48774049065;13035.608931732064;11211.215214934877;12169.513219471477;12197.268163910194;12812.231266124063;13051.477940882258;13122.08145429849;13199.472021119433;13309.800352994907;13364.866351336363;13670.043096983514;9144.3598948073;9148.817023659356;9460.858087128561;9529.475878826732;9607.375520591138;12765.61703148907;12824.807627885402;12868.22790632565;12908.41912113976;13016.674583135497 03:06:08 INFO - PID 1655 | |3;mootools.html;1358.422670365095;1398.0702832616312;1414.335262426659;1419.822522184727;1420.7300612883557;10874.347539147648;11383.146264030189;11387.089032877371;11497.022753065978;11762.647120586375;11382.690990536092;11575.247608905414;11694.824577631342;11700.707482312946;11740.882591174086;2262.8642281463126;2295.8622482651012;2297.161536039342;2300.056976639578;2300.470891694911;2089.707440958267;2161.6541353383464;2170.7829217078247;2173.7500187478404;2174.706414634028;2053.055594426558;2082.302428686392;2085.3118470904565;2096.350131459245;2096.716943212662;2052.4971382011354;2109.8945052747376;2119.9682004769943;2122.9150833966623;2123.108294516307;2113.8731676099483;2192.2655910270078;2199.681046248285;2205.7022301989346;2243.8653680779207;11145.108391328675;11149.275297105662;11181.049610783093;11241.494132764044;11272.887271127265;6197.907031394488;6315.936840631581;6345.238571371418;6403.87192256157;6412.422881940648;3792.563855156665;3833.9041523961846;3926.0773718176206;3938.330483817758;3987.8404863805413;1282.2626989481087;1339.564641491519;1353.4789106194087;1390.5387464188432;1395.1977612872538;17160;17372.65254694899;17446.214920328617;17451.5637109072;17522.123893805387;4810.182269014276;4840.951590484121;5047.4447810740785;5089.898202035939;5098.872528186751;11986;12068.939655301843;12075.3358565278;12093;12113.273203607812;6147.262328520516;6151.6924153793025;6162.476189523941;6183.319834818167;6192.256929168529;5740.311162660424;5844.649321040752;5872.207252021008;5936.5250779937505;5971.223740913741;3879.728419010642;3993.980030099831;4000.2599519089063;4024.4969378827645;4084.6528045116497;1090.3022065877844;1102.3354734351028;1109.3233127792041;1119.1103073056938;1121.7532142928542;813.4915677701437;831.5551180118607;843.5318398288886;855.6919508976763;876.8597024476181;6104.511639068953;6119.265688117454;6200.100985357189;6215.813525594149;6303.653299068504;606.3330336629672;621.0559948877681;623.8066199478176;628.3245511075521;630.9116723658691;4116.814743336557;4345.478542574911;4466.821327146878;4470.798814053311;4483.618892394183;14916.925415372854;15332.156731379659;15434.845651543565;15448.150351730537;15476.690466190837;14707.705845883022;14963.326650300764;15151.772723409158;15378.615534611725;15423.768643470357;9593.28050396223;9763.755906102404;9768.07203315684;9774.218062554979;9776.853347199798;6463.095166676763;6634.436072933855;6710.228323742636;6773.864522709419;6864.176298844171;12960.35198240103;13334.599962001155;13559;13838.65403364924;13884.305784710523;13505.459781608626;13877.959153063359;13883;14097.436102556194;14104.294785260901;8617.353698472765;8633.525156116473;8661.220490155916;8704.434211776213;8752.737417877473;10978.780424391307;11035.724106897393;11048.337099774039;11061.170412219277;11095.833562496407;9286.814263714552;9352.438853668802;9453;9470.810583788149;9762.755931101496;9294.442333460014;9427;9427.528623568931;9440.48077355752;9457.574409151466;7405.44459165554;7501;7524.05949256343;7564.659590318339;7564.962175189309;5875.882482350415;6191.504679625709;6212.099245609271;6287;6320.968395158179;6051.848703782441;6128.509719222362;6187.504999600112;6282.591631543935;6296.118543403835 03:06:08 INFO - PID 1655 | |4;prototype.html;403.8404830092112;418.9664826813855;428.87562606844006;439.86364227089587;441.27410409875745;6006.45941865232;6150.7539698412065;6174.981128113855;6210.7515699372025;6230.043922109459;5982.79060232892;6017.217761690985;6041.275046994367;6051.515878729702;6055.909161362583;4508.391367165424;4509.0530988492455;4520.434945631796;4534.2971839364955;4540.387047748562;4476.888077798065;4482.282834746441;4487.46150461945;4511.323301504768;4513.729176249419;4476.6418686505;4477.552244775513;4477.820887164509;4484.349769283468;4495.730256184623;4475.955240447603;4492.303692927585;4493.842715504974;4509.301058335963;4538.205813982539;3844.9807750961068;3898.1813819098024;3922.3135951208424;3927.8232479538487;3928.7839168845703;5923;5926.377730338296;5927.525797936198;5936.111846740392;5937.643741375531;5299.761510731988;5301.787928482856;5316.229146773735;5321.175217841241;5322.973385133088;6267.185265915402;6354.5551811373225;6402.839929001766;6414.8717025659225;6420.775272865428;4370;4381.255186618282;4382.9619227059575;4387.298032314814;4395.494518130424;6543.985682219263;6733.6432248713045;6766.966165169192;6777.525573209878;6786.253512113663;4482.46210454741;4493.483249426293;4502;4504.932426013613;4513.661475389359;4554.111948170142;4559.90562265054;4564.863054108382;4565.680402371869;4571.588557029883;5223.190405487156;5294.100002999499;5312.1766126250495;5335.413104558495;5363.249145119687;6323.7786677466065;6478.902816457757;6480.837979050467;6481.935180648227;6488.545801793924;1552.79037329959;1563.9061656300657;1568.3726509396104;1569.0272031340414;1573.8111426628877;989.747614358334;1037.5019990404649;1037.823569993103;1048.9318194317345;1053.7471006958428;6191.288001879751;6221.720022598994;6229.314775374705;6236.158118653923;6289.150964619809;6689.76585819494;6709.630970296583;6711.832204194837;6720.22717387497;6731.495137864582;6057.394260573908;6264.937350626436;6275.207532648019;6276.6547839868335;6291.465225455888;3507.9123021924147;3551.8756843510355;3561.8397172127316;3605.3330133925306;3618.4391419330045;6837.145356830396;6941.375276225164;7022.297770222936;7027.332403421667;7063.752768653072;6828.795136145924;6837.555558888656;6854.588724676535;6895.896561551581;6916.481263905227;6822.556533825285;6988.231294557595;7087.149542054986;7092.148942126874;7110.502264841515;6703.765368212089;6735.966320168368;6747.696353664195;6752.561083529555;6778.728850846108;6472.708728107153;6552.541322107598;6627.668616569056;6669.199696036507;6674.599524028574;7018.75434359795;7034.613096279753;7059.399951004017;7066.823329416806;7078.610676412641;4412.646988240997;4463.665225108195;4471;4490.977545112253;4525.230710779109;6504.15445992018;6703.597784132968;6713.295104014203;6727.764528241488;6796.422304104207;6507.609543427409;6527.249366322933;6531.706073226621;6534;6543.70553325092;6360.7992180483;6422.807315780534;6505.462869480812;6519.282878883224;6546.24718157418;6500.382463665944;6527.771527996498;6549.312322206099;6560.3111673273615;6567.9671601641685;6471.158749362553;6565.212174539086;6566.2120545532935;6574.638394888327;6588.374104460068;6352.36476352361;6368.5860419072615;6376.52176086786;6382.20222472191;6384.680765961591 03:06:08 INFO - PID 1655 | |5;yui.html;854.7733155130884;882.841088604051;884.3234925282159;894.2309613732193;903.859901715234;16464.753028704563;16991.660166796657;17050.488485345442;17612.295508179657;17820.465386038406;16938.576535586617;17001.2349444275;17061.317547298095;17392.391266305684;17425.651486970284;978.7259567321144;990.5344488090586;998.610541888664;999.075854834279;1002.5438425516409;1024.4519182237505;1024.8206563851334;1025.9894004405655;1027.234710140946;1028.1312291114034;1081.9242653014292;1089.4443833644818;1091.8198497247945;1097.1113398147527;1098.6045023791428;1082.41008650285;1085.2294870641854;1090.939998300093;1093.3276035238312;1094.1137678480416;735.301463609573;751.9586422746747;779.2519181585684;782.81212508998;786.7836345005112;16150.192490375552;16225.83774162255;16256.105914174716;16257.756133658004;16341;17929.641407171785;18744.625107497774;18757.34349297768;18799.81200187994;19004;14421.206833624146;14595.927020364936;14713.852861471356;14783.55649330511;14989.625259368495;3365.1082463147286;3412.2151905061974;3414.5219669246326;3415.8804441844663;3420.0594836419937;88705.55647221787;89183.55408222918;90426.5478672609;98261;100145.99999999927;14000.929995349958;14250.572482825532;14341.426342946374;14451.92774036123;14555.854441455662;25851.22446326613;27524.58713119305;27995.440091198063;28378.85810570934;28507.429851402856;8265.504069755834;8439.95780021096;8463.830723385498;8494;8499.702510412106;3989.3617021276455;4018.2566225248424;4043.8786836394956;4054;4068.572799856032;4257.744535327828;4393.51671316155;4422.823087076546;4438.289873620205;4441.333799929972;856.1224744636797;896.4800415758845;898.2185498616116;905.9139381758722;907.0974380491454;682.3722175598461;683.702589373624;698.4272896225149;729.7154109897144;739.9408047356198;11535;11990;12077.57728479499;12277.74043368931;12589.24464532131;672.1967249137234;690.6374153569416;693.5942473652868;701.123595505618;730.9451791115688;5480.7533660985355;5543.808081262548;5723.456271654186;5731.742071606787;5748.913766293509;81815;81836.59081704673;83240.16759832445;83647.5817620908;85226;53896.46103538915;74073;74411.62794185994;77576.2242377569;81359.5932020336;58894.41105588975;59445.40554594485;59615.40384596185;60005.399946000856;60649.69675151684;11945.223560468541;12575.245485270547;12580.182288151242;12778.23330600167;12843.871561284268;32848.83575582107;33049.33901322008;33720;34208.315833683686;34629.30741385208;38805.6119438802;54458.72770636121;56621.71689141528;57045;58671.70664146652;15430.305636246172;15658;15709.293081811118;15746.370145194063;15916.204189790697;17545.56136096608;17626.206820693355;17776.733349000035;17823;17895.642087158445;15192;15398.46105386306;15842.287097080429;15847.366105355657;16026.439074632799;15763;16416.507504774876;16780.993140411614;17062.914685426495;17832.55418614545;16409.17954102314;17368.91315543414;17576.296948122443;17634.030128343064;18026.549336266697;11895.46470408851;12004.099692522921;12004.75990480203;12651.620451386472;12675.556355527513;14113.788293175816;14624.41502339937;14626.926865365605;14656.267186640413;14676.853231467976 03:06:08 INFO - PID 1655 | __end_tp_report 03:06:08 INFO - PID 1655 | __start_cc_report 03:06:08 INFO - PID 1655 | _x_x_mozilla_cycle_collect,331 03:06:08 INFO - PID 1655 | __end_cc_report 03:06:08 INFO - PID 1655 | __startTimestamp1493805968235__endTimestamp 03:06:08 INFO - PID 1655 | 03:06:08 INFO - PID 1655 | ------- Summary: start ------- 03:06:08 INFO - PID 1655 | Number of tests: 6 03:06:08 INFO - PID 1655 | 03:06:08 INFO - PID 1655 | [#0] dojo.html Cycles:165 Average:6012.19 Median:6221.38 stddev:720.24 (11.6%) stddev-sans-first:693.39 03:06:08 INFO - PID 1655 | Values: 3430.5 3431.8 3451.3 3462.7 3465.0 5841.3 5990.9 5992.3 6035.9 6047.6 5970.8 5982.8 6029.4 6075.3 6105.5 5218.0 5310.3 5317.2 5329.2 5383.5 5369.8 5433.8 5439.1 5446.2 5450.7 5196.9 5256.6 5321.0 5376.2 5410.1 5378.7 5398.4 5405.4 5410.2 5423.4 5295.4 5348.4 5364.1 5369.1 5370.7 5827.3 5978.3 6031.1 6039.6 6051.9 6314.1 6426.3 6478.8 6498.0 6528.6 6603.8 6615.4 6628.9 6641.4 6643.1 6063.2 6077.8 6086.6 6147.7 6166.4 6450.6 6547.4 6595.4 6655.9 6717.6 6182.5 6255.1 6326.1 6429.0 6467.9 6488.4 6512.6 6553.2 6563.7 6579.3 6497.4 6505.8 6514.5 6544.8 6554.4 6277.5 6353.8 6433.6 6517.9 6549.7 4996.3 4999.6 5000.7 5008.2 5023.3 4388.1 4394.7 4396.1 4398.6 4444.5 5957.3 6026.0 6171.0 6174.6 6177.4 6390.8 6442.5 6476.1 6540.1 6560.0 6204.8 6220.6 6224.1 6234.7 6235.4 5693.8 5705.9 5709.1 5714.4 5750.9 6527.8 6702.1 6786.2 6867.2 6868.0 6549.5 6552.0 6586.3 6607.5 6613.9 6759.6 6844.5 6860.8 6883.7 6901.4 6221.4 6270.9 6383.2 6445.3 6448.8 6515.6 6578.2 6618.9 6621.1 6639.7 6133.8 6149.8 6399.3 6405.5 6427.8 6277.6 6279.5 6359.2 6383.2 6384.6 6160.1 6332.7 6337.2 6386.9 6401.9 6170.4 6430.6 6433.4 6440.9 6458.7 6109.5 6124.7 6126.8 6159.1 6165.9 03:06:08 INFO - PID 1655 | 03:06:08 INFO - PID 1655 | [#1] ext.html Cycles:180 Average:40988.25 Median:36355.14 stddev:63328.27 (174.2%) stddev-sans-first:63433.62 03:06:08 INFO - PID 1655 | Values: 684.6 725.7 742.6 1059.6 1066.0 37410.4 38563.2 38573.8 38693.0 38896.8 39287.8 39916.8 39975.6 40014.6 40089.2 7173.6 7237.9 7285.7 7369.5 7375.6 7300.3 7439.7 7465.9 7489.0 7504.7 7487.9 7564.7 7574.6 7576.2 7594.7 7468.9 7491.9 7510.4 7510.9 7523.2 7387.5 7389.7 7439.8 7479.2 7492.8 36887.6 37276.3 37340.1 37348.4 37383.6 3646.1 3685.1 3694.5 3695.3 3702.4 30413.8 30485.7 30634.4 30658.7 30719.4 3769.7 3790.6 3793.8 3818.8 3839.6 202475.0 203767.0 204261.0 216622.0 222311.0 47140.0 47452.3 47460.5 47554.3 47670.3 49149.8 49418.8 57342.1 57757.4 57767.7 14387.4 14700.3 14710.2 14716.5 14730.9 11612.7 11622.2 11645.0 11666.1 11679.5 14943.0 14983.9 15053.1 15152.5 15257.1 6146.6 6173.8 6196.4 6201.6 6397.0 1066.7 1093.6 1098.3 1107.7 1109.2 26345.7 26427.7 26676.7 26842.9 26962.9 1181.6 1189.0 1189.1 1190.7 1223.7 13937.5 13988.7 14090.9 14104.5 14144.2 287281.0 287863.0 287942.0 288926.0 290710.0 54369.5 54795.7 54926.5 54967.5 55044.7 1491.0 1503.0 1540.4 1546.5 1553.3 24614.6 25677.9 25951.1 25961.2 26182.5 39927.2 40226.8 40238.0 40290.8 40295.2 222531.0 222923.0 224026.0 224141.0 224798.0 35342.0 36179.1 36223.3 36320.0 36390.3 42719.6 44940.0 45243.0 45321.8 45424.8 31908.7 32601.7 32607.2 33067.5 33805.4 33091.8 33369.7 33729.5 33743.5 34760.8 38140.8 39408.8 39747.0 39865.8 41147.8 32239.5 32403.7 33176.0 33460.0 33996.3 25328.0 27579.0 27600.2 27611.2 27632.6 03:06:08 INFO - PID 1655 | 03:06:08 INFO - PID 1655 | [#2] jquery.html Cycles:180 Average:32364.77 Median:2215.44 stddev:88331.14 (3987.1%) stddev-sans-first:88546.40 03:06:08 INFO - PID 1655 | Values: 436.3 439.9 447.7 450.6 460.1 20239.3 20963.8 21063.5 21600.5 21747.0 21171.0 21247.6 21368.0 21450.8 23248.8 5340.4 5391.9 5576.8 5592.8 5603.0 4251.0 5487.6 5500.3 5521.4 5523.5 5474.3 5487.8 5498.0 5501.5 5516.8 5316.8 5473.1 5491.5 5529.8 5540.3 4985.3 5016.3 5023.9 5028.8 5034.8 25739.7 26104.5 26142.2 26322.5 26746.2 2079.0 2144.1 2166.2 2171.7 2199.7 17712.8 17959.4 18158.4 18244.2 18280.7 2145.0 2231.2 2246.8 2268.3 2277.9 104917.5 109446.3 111554.9 114080.0 115513.0 11902.8 12018.8 12300.6 12317.8 12685.2 17255.9 17276.7 17389.0 17407.6 17435.3 8305.0 8518.6 8627.0 8678.0 8692.4 7698.0 7775.9 7791.5 7900.5 7979.7 7801.3 8048.8 8070.9 8130.0 8150.0 2242.9 2256.3 2264.7 2282.2 2387.8 980.2 1004.0 1010.5 1011.0 1047.5 18870.3 18889.4 19238.0 19418.1 19707.0 1026.1 1036.7 1037.3 1052.2 1061.1 10594.9 10699.9 10876.5 10898.3 10899.4 490970.0 538698.0 540795.0 541422.0 550894.5 96575.0 99033.0 99832.5 101032.0 101803.0 1219.1 1227.6 1272.7 1281.6 1283.8 20394.5 20472.7 21229.3 21262.6 21317.4 45120.8 46764.8 46892.8 46984.0 47034.0 60776.4 61098.7 61564.4 62141.7 62511.0 9074.2 9178.0 9262.0 9262.5 9317.3 13846.3 14267.0 14626.8 14817.8 15464.8 12204.4 12586.5 12778.4 12806.5 13035.6 11211.2 12169.5 12197.3 12812.2 13051.5 13122.1 13199.5 13309.8 13364.9 13670.0 9144.4 9148.8 9460.9 9529.5 9607.4 12765.6 12824.8 12868.2 12908.4 13016.7 03:06:08 INFO - PID 1655 | 03:06:08 INFO - PID 1655 | [#3] mootools.html Cycles:180 Average:7065.89 Median:3813.23 stddev:4678.99 (122.7%) stddev-sans-first:4672.46 03:06:08 INFO - PID 1655 | Values: 1358.4 1398.1 1414.3 1419.8 1420.7 10874.3 11383.1 11387.1 11497.0 11762.6 11382.7 11575.2 11694.8 11700.7 11740.9 2262.9 2295.9 2297.2 2300.1 2300.5 2089.7 2161.7 2170.8 2173.8 2174.7 2053.1 2082.3 2085.3 2096.4 2096.7 2052.5 2109.9 2120.0 2122.9 2123.1 2113.9 2192.3 2199.7 2205.7 2243.9 11145.1 11149.3 11181.0 11241.5 11272.9 6197.9 6315.9 6345.2 6403.9 6412.4 3792.6 3833.9 3926.1 3938.3 3987.8 1282.3 1339.6 1353.5 1390.5 1395.2 17160.0 17372.7 17446.2 17451.6 17522.1 4810.2 4841.0 5047.4 5089.9 5098.9 11986.0 12068.9 12075.3 12093.0 12113.3 6147.3 6151.7 6162.5 6183.3 6192.3 5740.3 5844.6 5872.2 5936.5 5971.2 3879.7 3994.0 4000.3 4024.5 4084.7 1090.3 1102.3 1109.3 1119.1 1121.8 813.5 831.6 843.5 855.7 876.9 6104.5 6119.3 6200.1 6215.8 6303.7 606.3 621.1 623.8 628.3 630.9 4116.8 4345.5 4466.8 4470.8 4483.6 14916.9 15332.2 15434.8 15448.2 15476.7 14707.7 14963.3 15151.8 15378.6 15423.8 9593.3 9763.8 9768.1 9774.2 9776.9 6463.1 6634.4 6710.2 6773.9 6864.2 12960.4 13334.6 13559.0 13838.7 13884.3 13505.5 13878.0 13883.0 14097.4 14104.3 8617.4 8633.5 8661.2 8704.4 8752.7 10978.8 11035.7 11048.3 11061.2 11095.8 9286.8 9352.4 9453.0 9470.8 9762.8 9294.4 9427.0 9427.5 9440.5 9457.6 7405.4 7501.0 7524.1 7564.7 7565.0 5875.9 6191.5 6212.1 6287.0 6321.0 6051.8 6128.5 6187.5 6282.6 6296.1 03:06:08 INFO - PID 1655 | 03:06:08 INFO - PID 1655 | [#4] prototype.html Cycles:180 Average:5396.98 Median:6225.52 stddev:1670.40 (26.8%) stddev-sans-first:1632.50 03:06:08 INFO - PID 1655 | Values: 403.8 419.0 428.9 439.9 441.3 6006.5 6150.8 6175.0 6210.8 6230.0 5982.8 6017.2 6041.3 6051.5 6055.9 4508.4 4509.1 4520.4 4534.3 4540.4 4476.9 4482.3 4487.5 4511.3 4513.7 4476.6 4477.6 4477.8 4484.3 4495.7 4476.0 4492.3 4493.8 4509.3 4538.2 3845.0 3898.2 3922.3 3927.8 3928.8 5923.0 5926.4 5927.5 5936.1 5937.6 5299.8 5301.8 5316.2 5321.2 5323.0 6267.2 6354.6 6402.8 6414.9 6420.8 4370.0 4381.3 4383.0 4387.3 4395.5 6544.0 6733.6 6767.0 6777.5 6786.3 4482.5 4493.5 4502.0 4504.9 4513.7 4554.1 4559.9 4564.9 4565.7 4571.6 5223.2 5294.1 5312.2 5335.4 5363.2 6323.8 6478.9 6480.8 6481.9 6488.5 1552.8 1563.9 1568.4 1569.0 1573.8 989.7 1037.5 1037.8 1048.9 1053.7 6191.3 6221.7 6229.3 6236.2 6289.2 6689.8 6709.6 6711.8 6720.2 6731.5 6057.4 6264.9 6275.2 6276.7 6291.5 3507.9 3551.9 3561.8 3605.3 3618.4 6837.1 6941.4 7022.3 7027.3 7063.8 6828.8 6837.6 6854.6 6895.9 6916.5 6822.6 6988.2 7087.1 7092.1 7110.5 6703.8 6736.0 6747.7 6752.6 6778.7 6472.7 6552.5 6627.7 6669.2 6674.6 7018.8 7034.6 7059.4 7066.8 7078.6 4412.6 4463.7 4471.0 4491.0 4525.2 6504.2 6703.6 6713.3 6727.8 6796.4 6507.6 6527.2 6531.7 6534.0 6543.7 6360.8 6422.8 6505.5 6519.3 6546.2 6500.4 6527.8 6549.3 6560.3 6568.0 6471.2 6565.2 6566.2 6574.6 6588.4 6352.4 6368.6 6376.5 6382.2 6384.7 03:06:08 INFO - PID 1655 | 03:06:08 INFO - PID 1655 | [#5] yui.html Cycles:180 Average:19165.46 Median:18901.91 stddev:23590.54 (124.8%) stddev-sans-first:23616.64 03:06:08 INFO - PID 1655 | Values: 854.8 882.8 884.3 894.2 903.9 16464.8 16991.7 17050.5 17612.3 17820.5 16938.6 17001.2 17061.3 17392.4 17425.7 978.7 990.5 998.6 999.1 1002.5 1024.5 1024.8 1026.0 1027.2 1028.1 1081.9 1089.4 1091.8 1097.1 1098.6 1082.4 1085.2 1090.9 1093.3 1094.1 735.3 752.0 779.3 782.8 786.8 16150.2 16225.8 16256.1 16257.8 16341.0 17929.6 18744.6 18757.3 18799.8 19004.0 14421.2 14595.9 14713.9 14783.6 14989.6 3365.1 3412.2 3414.5 3415.9 3420.1 88705.6 89183.6 90426.5 98261.0 100146.0 14000.9 14250.6 14341.4 14451.9 14555.9 25851.2 27524.6 27995.4 28378.9 28507.4 8265.5 8440.0 8463.8 8494.0 8499.7 3989.4 4018.3 4043.9 4054.0 4068.6 4257.7 4393.5 4422.8 4438.3 4441.3 856.1 896.5 898.2 905.9 907.1 682.4 683.7 698.4 729.7 739.9 11535.0 11990.0 12077.6 12277.7 12589.2 672.2 690.6 693.6 701.1 730.9 5480.8 5543.8 5723.5 5731.7 5748.9 81815.0 81836.6 83240.2 83647.6 85226.0 53896.5 74073.0 74411.6 77576.2 81359.6 58894.4 59445.4 59615.4 60005.4 60649.7 11945.2 12575.2 12580.2 12778.2 12843.9 32848.8 33049.3 33720.0 34208.3 34629.3 38805.6 54458.7 56621.7 57045.0 58671.7 15430.3 15658.0 15709.3 15746.4 15916.2 17545.6 17626.2 17776.7 17823.0 17895.6 15192.0 15398.5 15842.3 15847.4 16026.4 15763.0 16416.5 16781.0 17062.9 17832.6 16409.2 17368.9 17576.3 17634.0 18026.5 11895.5 12004.1 12004.8 12651.6 12675.6 14113.8 14624.4 14626.9 14656.3 14676.9 03:06:08 INFO - PID 1655 | -------- Summary: end -------- 03:06:08 INFO - PID 1655 | 03:06:08 INFO - TEST-INFO | 1655: exit 0 03:06:08 INFO - TEST-OK | dromaeo_css | took 1113573ms 03:06:08 INFO - TEST-START | kraken 03:06:08 INFO - operating with platform_type : linux_ 03:06:08 INFO - Initialising browser for kraken test... 03:06:08 INFO - TEST-INFO | started process 2035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFizWTh/profile http://localhost:43029/getInfo.html) 03:06:12 INFO - PID 2035 | __metrics Screen width/height:1600/1200 03:06:12 INFO - PID 2035 | colorDepth:24 03:06:12 INFO - PID 2035 | Browser inner width/height: 1024/695 03:06:12 INFO - PID 2035 | __metrics 03:06:14 INFO - TEST-INFO | 2035: exit 0 03:06:14 INFO - Browser initialized. 03:06:14 INFO - Running cycle 1/1 for kraken test... 03:06:14 INFO - TEST-INFO | started process 2169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFizWTh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:06:26 INFO - PID 2169 | RSS: Main: 156999680 03:06:26 INFO - PID 2169 | 03:06:29 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43029/tests/kraken/driver.html?testName=audio-beat-detection) 03:06:30 INFO - PID 2169 | RSS: Main: 163012608 03:06:30 INFO - PID 2169 | 03:06:32 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43029/tests/kraken/driver.html?testName=audio-dft) 03:06:33 INFO - PID 2169 | RSS: Main: 161226752 03:06:33 INFO - PID 2169 | 03:06:36 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43029/tests/kraken/driver.html?testName=audio-fft) 03:06:36 INFO - PID 2169 | RSS: Main: 157315072 03:06:36 INFO - PID 2169 | 03:06:38 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43029/tests/kraken/driver.html?testName=audio-oscillator) 03:06:39 INFO - PID 2169 | RSS: Main: 158846976 03:06:39 INFO - PID 2169 | 03:06:41 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43029/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:06:41 INFO - PID 2169 | RSS: Main: 158527488 03:06:41 INFO - PID 2169 | 03:06:44 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43029/tests/kraken/driver.html?testName=imaging-darkroom) 03:06:45 INFO - PID 2169 | RSS: Main: 163946496 03:06:45 INFO - PID 2169 | 03:06:49 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43029/tests/kraken/driver.html?testName=imaging-desaturate) 03:06:49 INFO - PID 2169 | RSS: Main: 165322752 03:06:49 INFO - PID 2169 | 03:06:52 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43029/tests/kraken/driver.html?testName=json-parse-financial) 03:06:53 INFO - PID 2169 | RSS: Main: 165064704 03:06:53 INFO - PID 2169 | 03:06:54 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43029/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:55 INFO - PID 2169 | RSS: Main: 164646912 03:06:55 INFO - PID 2169 | 03:06:56 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43029/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:57 INFO - PID 2169 | RSS: Main: 164556800 03:06:57 INFO - PID 2169 | 03:06:59 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43029/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:07:00 INFO - PID 2169 | RSS: Main: 164790272 03:07:00 INFO - PID 2169 | 03:07:02 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43029/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:07:03 INFO - PID 2169 | RSS: Main: 164524032 03:07:03 INFO - PID 2169 | 03:07:06 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43029/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:07:07 INFO - PID 2169 | RSS: Main: 164818944 03:07:07 INFO - PID 2169 | 03:07:08 INFO - PID 2169 | Cycle 1(1): loaded http://localhost:43029/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43029/tests/kraken/driver.html?testName=ai-astar) 03:07:09 INFO - PID 2169 | RSS: Main: 166932480 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | __start_tp_report 03:07:09 INFO - PID 2169 | _x_x_mozilla_page_load 03:07:09 INFO - PID 2169 | _x_x_mozilla_page_load_details 03:07:09 INFO - PID 2169 | |i|pagename|runs| 03:07:09 INFO - PID 2169 | |0;ai-astar;108;111;113;110;110;111;110;111;113;110 03:07:09 INFO - PID 2169 | |1;audio-beat-detection;156;117;118;182;115;117;116;119;140;118 03:07:09 INFO - PID 2169 | |2;audio-dft;163;164;162;163;164;166;166;171;174;163 03:07:09 INFO - PID 2169 | |3;audio-fft;74;76;75;95;84;74;76;75;97;73 03:07:09 INFO - PID 2169 | |4;audio-oscillator;82;81;102;82;82;82;110;83;83;104 03:07:09 INFO - PID 2169 | |5;imaging-gaussian-blur;114;114;115;114;113;114;114;114;114;114 03:07:09 INFO - PID 2169 | |6;imaging-darkroom;149;149;149;150;151;148;149;151;148;148 03:07:09 INFO - PID 2169 | |7;imaging-desaturate;94;100;95;94;94;95;94;95;95;94 03:07:09 INFO - PID 2169 | |8;json-parse-financial;45;45;52;46;46;50;46;46;47;47 03:07:09 INFO - PID 2169 | |9;json-stringify-tinderbox;57;56;56;55;57;55;56;55;56;56 03:07:09 INFO - PID 2169 | |10;stanford-crypto-aes;82;82;89;84;82;82;82;92;82;82 03:07:09 INFO - PID 2169 | |11;stanford-crypto-ccm;127;132;128;126;132;131;127;126;210;126 03:07:09 INFO - PID 2169 | |12;stanford-crypto-pbkdf2;176;184;183;182;188;185;184;176;183;182 03:07:09 INFO - PID 2169 | |13;stanford-crypto-sha256-iterative;67;67;65;69;66;68;66;70;69;73 03:07:09 INFO - PID 2169 | __end_tp_report 03:07:09 INFO - PID 2169 | __start_cc_report 03:07:09 INFO - PID 2169 | _x_x_mozilla_cycle_collect,752 03:07:09 INFO - PID 2169 | __end_cc_report 03:07:09 INFO - PID 2169 | __startTimestamp1493806029034__endTimestamp 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | ------- Summary: start ------- 03:07:09 INFO - PID 2169 | Number of tests: 14 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.49 (1.3%) stddev-sans-first:1.22 03:07:09 INFO - PID 2169 | Values: 108.0 111.0 113.0 110.0 110.0 111.0 110.0 111.0 113.0 110.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:118.50 stddev:22.72 (19.2%) stddev-sans-first:22.04 03:07:09 INFO - PID 2169 | Values: 156.0 117.0 118.0 182.0 115.0 117.0 116.0 119.0 140.0 118.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:3.92 (2.4%) stddev-sans-first:4.04 03:07:09 INFO - PID 2169 | Values: 163.0 164.0 162.0 163.0 164.0 166.0 166.0 171.0 174.0 163.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#3] audio-fft Cycles:10 Average:79.90 Median:76.00 stddev:9.02 (11.9%) stddev-sans-first:9.32 03:07:09 INFO - PID 2169 | Values: 74.0 76.0 75.0 95.0 84.0 74.0 76.0 75.0 97.0 73.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:82.00 stddev:11.39 (13.9%) stddev-sans-first:11.78 03:07:09 INFO - PID 2169 | Values: 82.0 81.0 102.0 82.0 82.0 82.0 110.0 83.0 83.0 104.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 03:07:09 INFO - PID 2169 | Values: 114.0 114.0 115.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 03:07:09 INFO - PID 2169 | Values: 149.0 149.0 149.0 150.0 151.0 148.0 149.0 151.0 148.0 148.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.50 stddev:1.83 (1.9%) stddev-sans-first:1.90 03:07:09 INFO - PID 2169 | Values: 94.0 100.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#8] json-parse-financial Cycles:10 Average:47.00 Median:46.50 stddev:2.26 (4.9%) stddev-sans-first:2.28 03:07:09 INFO - PID 2169 | Values: 45.0 45.0 52.0 46.0 46.0 50.0 46.0 46.0 47.0 47.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 03:07:09 INFO - PID 2169 | Values: 57.0 56.0 56.0 55.0 57.0 55.0 56.0 55.0 56.0 56.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:82.00 stddev:3.60 (4.4%) stddev-sans-first:3.76 03:07:09 INFO - PID 2169 | Values: 82.0 82.0 89.0 84.0 82.0 82.0 82.0 92.0 82.0 82.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:129.50 stddev:25.94 (20.0%) stddev-sans-first:27.29 03:07:09 INFO - PID 2169 | Values: 127.0 132.0 128.0 126.0 132.0 131.0 127.0 126.0 210.0 126.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:183.50 stddev:3.74 (2.0%) stddev-sans-first:3.20 03:07:09 INFO - PID 2169 | Values: 176.0 184.0 183.0 182.0 188.0 185.0 184.0 176.0 183.0 182.0 03:07:09 INFO - PID 2169 | 03:07:09 INFO - PID 2169 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:2.36 (3.4%) stddev-sans-first:2.47 03:07:09 INFO - PID 2169 | Values: 67.0 67.0 65.0 69.0 66.0 68.0 66.0 70.0 69.0 73.0 03:07:09 INFO - PID 2169 | -------- Summary: end -------- 03:07:09 INFO - PID 2169 | 03:07:10 INFO - TEST-INFO | 2169: exit 0 03:07:10 INFO - TEST-OK | kraken | took 61233ms 03:07:10 INFO - SUITE-END | took 1174s 03:07:10 INFO - Completed test suite (00:19:35) 03:07:10 INFO - javascript benchmark 03:07:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7789.784209299362, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3430.485427185922, 3431.828408579572, 3451.326991236709, 3462.7229821614274, 3465.0297916583336, 5841.299044114701, 5990.910136347953, 5992.310884248307, 6035.879282414349, 6047.5766696331275, 5970.79102231422, 5982.79060232892, 6029.366916473762, 6075.301340345862, 6105.481034112106, 5217.973910130463, 5310.309659744228, 5317.202419637066, 5329.173978033392, 5383.4616538346045, 5369.812056578021, 5433.836984890439, 5439.129739241722, 5446.210299506589, 5450.672959622435, 5196.8960620787375, 5256.579473642099, 5320.973395133, 5376.193570964367, 5410.08028635129, 5378.650387724824, 5398.379186393576, 5405.378381486101, 5410.161424979135, 5423.430539793304, 5295.443978382253, 5348.438413966555, 5364.088105022156, 5369.140937450028, 5370.650907690988, 5827.271591051119, 5978.342382337939, 6031.065184896348, 6039.5772295939305, 6051.878962420771, 6314.147590075327, 6426.325235850215, 6478.805635830886, 6498.0, 6528.575642583217, 6603.7688680895935, 6615.4046135848, 6628.93371066288, 6641.402273795382, 6643.103181070542, 6063.18147050147, 6077.817665470043, 6086.634801911855, 6147.66187859663, 6166.414190651881, 6450.645214513153, 6547.410733034049, 6595.406413422719, 6655.900161497581, 6717.56335838169, 6182.505399568024, 6255.093011513305, 6326.145970294044, 6429.0, 6467.935320646733, 6488.448481879093, 6512.641804700787, 6553.180852393451, 6563.704633291513, 6579.276279609239, 6497.415232628991, 6505.772297969548, 6514.511411644051, 6544.803655890331, 6554.442872355808, 6277.529185311028, 6353.841153971188, 6433.613983161025, 6517.934820651828, 6549.705263263165, 4996.325496058058, 4999.550040496373, 5000.74996250186, 5008.248762685626, 5023.321851549994, 4388.100439409914, 4394.736315821061, 4396.07682386696, 4398.64810815134, 4444.488883778342, 5957.255343082114, 6026.0, 6171.043488259327, 6174.598651087755, 6177.382261773877, 6390.84022899422, 6442.516811239082, 6476.125723027425, 6540.149780528501, 6560.048792924999, 6204.751809927642, 6220.626762394271, 6224.06639004153, 6234.657093859882, 6235.438810507076, 5693.772249109989, 5705.942940570541, 5709.115087161496, 5714.371419143891, 5750.942490575041, 6527.836804079841, 6702.061711360413, 6786.1856577210065, 6867.244603093755, 6868.0, 6549.508786840911, 6552.049952756728, 6586.341365863375, 6607.5044371673275, 6613.867722645617, 6759.5606285591275, 6844.486663500357, 6860.759873404407, 6883.690233939585, 6901.413379862567, 6221.377862213742, 6270.874582508415, 6383.234011918599, 6445.2587952386075, 6448.806535803933, 6515.641639709862, 6578.210614726264, 6618.90071648916, 6621.073049772939, 6639.738449694542, 6133.793750436688, 6149.815505534841, 6399.296077431386, 6405.51958603116, 6427.839304017437, 6277.623342599459, 6279.466245369194, 6359.173307470184, 6383.202099737533, 6384.648844313608, 6160.13758073861, 6332.746690132343, 6337.176167098248, 6386.93613063882, 6401.8719625608155, 6170.444659980623, 6430.614163150226, 6433.356664333529, 6440.935590644033, 6458.741650333934, 6109.541784366102, 6124.655575319917, 6126.754929802758, 6159.106929495288, 6165.907511387243], "value": 5961.333160263084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.5892464521288, 725.7097161135545, 742.6323969635032, 1059.5602824827697, 1066.0405634928568, 37410.43884341734, 38563.22873542528, 38573.80713096434, 38693.03267418316, 38896.80551597238, 39287.80356098215, 39916.800415997954, 39975.60024399755, 40014.59985400145, 40089.198216035664, 7173.569585824867, 7237.89143162853, 7285.708571657127, 7369.4841361104745, 7375.631218439084, 7300.269973002683, 7439.7396091136825, 7465.8506829863645, 7489.0, 7504.737334193304, 7487.925120748777, 7564.697412103509, 7574.583397913113, 7576.242375762407, 7594.73418430355, 7468.850622987564, 7491.925080749204, 7510.3616192623695, 7510.924890751132, 7523.210062943394, 7387.519811212254, 7389.66746496409, 7439.776806695808, 7479.177290498041, 7492.812679682997, 36887.63112368869, 37276.25447491035, 37340.06649833749, 37348.43977340342, 37383.626163738285, 3646.106703857572, 3685.1339935115225, 3694.501242332278, 3695.279420512974, 3702.38910579754, 30413.847930760425, 30485.695143048728, 30634.387312253853, 30658.69341306603, 30719.385612287853, 3769.679577235911, 3790.56408513019, 3793.8103094845146, 3818.84724611018, 3839.6352346527315, 202475.0, 203767.0, 204261.0, 216622.0, 222310.99999999837, 47140.0, 47452.288215676796, 47460.5253947463, 47554.28668569905, 47670.28494572584, 49149.754251228514, 49418.75290623524, 57342.13986790201, 57757.42242577604, 57767.711161444764, 14387.352569134415, 14700.264986750619, 14710.19093949843, 14716.484923027643, 14730.92634536842, 11612.709682258012, 11622.244554103956, 11645.0, 11666.066714662807, 11679.532818687327, 14943.0, 14983.925080374529, 15053.096814191184, 15152.545423637308, 15257.08457492554, 6146.569740118149, 6173.765246950627, 6196.380361963767, 6201.596896201732, 6396.968015159894, 1066.7439814444479, 1093.557109370706, 1098.340995402752, 1107.7119948813368, 1109.2346281066039, 26345.736542634328, 26427.735722642527, 26676.73323266781, 26842.865785670947, 26962.865185674338, 1181.5746331320718, 1188.9524419023314, 1189.0784641902594, 1190.6844686158174, 1223.663492539541, 13937.512187073606, 13988.72022559543, 14090.85909140916, 14104.506342277971, 14144.151350918977, 287281.0, 287863.0, 287942.0, 288926.0, 290710.0, 54369.456305437234, 54795.726021369635, 54926.45073549293, 54967.45032549623, 55044.724776375864, 1490.9850901490847, 1502.9624259393383, 1540.376147660177, 1546.4741987724228, 1553.324303927795, 24614.630780537947, 25677.87161064183, 25951.091711789995, 25961.221163365128, 26182.476350473265, 39927.2014559713, 40226.79886600548, 40238.0, 40290.798546007085, 40295.194096117324, 222531.0, 222923.0, 224026.0, 224141.0, 224798.0, 35342.0, 36179.095522612144, 36223.27553448969, 36320.0, 36390.27219455543, 42719.57280427156, 44940.0, 45243.0, 45321.77339113283, 45424.77287613673, 31908.680913190572, 32601.67398326081, 32607.18482037968, 33067.503987439726, 33805.386490406825, 33091.83454082714, 33369.66630333666, 33729.494057588665, 33743.4938475928, 34760.82619586886, 38140.809295953346, 39408.80295598504, 39747.0, 39865.80067099646, 41147.7942610285, 32239.516407253443, 32403.675963240064, 33176.0, 33460.0, 33996.3200735979, 25328.0, 27579.0, 27600.171994840188, 27611.171664849284, 27632.585511216945], "value": 17622.641078127253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.3476602479293, 439.8504508467121, 447.65754198038525, 450.6214779585148, 460.12346479955676, 20239.291624793135, 20963.790362096395, 21063.47341316468, 21600.459988500294, 21747.0, 21171.047302871368, 21247.57504849902, 21368.0, 21450.785492145074, 23248.76751232487, 5340.412554618989, 5391.919121213185, 5576.776928922838, 5592.832215033535, 5603.0, 4250.957490425102, 5487.6158668892995, 5500.339959204881, 5521.420250873661, 5523.530499907512, 5474.343078830546, 5487.75305111269, 5498.037843377413, 5501.504864562188, 5516.7517461714115, 5316.76074576645, 5473.06957817172, 5491.505764481176, 5529.778808847682, 5540.307461567304, 4985.277134815467, 5016.3227964224725, 5023.874403139914, 5028.84913452597, 5034.848954531333, 25739.742602573922, 26104.477910441874, 26142.215733527835, 26322.473550529074, 26746.19761407161, 2078.95842083159, 2144.088762276042, 2166.19850655257, 2171.7176767020346, 2199.6590528468114, 17712.822871771245, 17959.371422000168, 18158.364457244064, 18244.17901194436, 18280.725789113174, 2145.0, 2231.2190733243397, 2246.84272100953, 2268.3081660093667, 2277.8633282003134, 104917.47541262321, 109446.3351045839, 111554.88445115526, 114080.0, 115513.0, 11902.821457678141, 12018.819717704242, 12300.630981070582, 12317.753644927052, 12685.175463594836, 17255.91372043132, 17276.740848887275, 17389.0, 17407.56481087983, 17435.302587896596, 8305.0, 8518.57407129641, 8626.956865215634, 8677.956610216908, 8692.434991725517, 7697.960040589248, 7775.922240777633, 7791.454598178073, 7900.525968441912, 7979.68081276754, 7801.294385167113, 8048.758537243892, 8070.878936815952, 8129.959350203211, 8149.959250203711, 2242.943926401853, 2256.266713318178, 2264.66030095487, 2282.167009041688, 2387.7855584892677, 980.161961522902, 1003.9659151074259, 1010.4543546484816, 1010.9595616175418, 1047.544318221576, 18870.339538116375, 18889.433317000512, 19238.0, 19418.12618432174, 19707.0, 1026.0812281034514, 1036.657902892044, 1037.304007947012, 1052.1740433759462, 1061.1298735037349, 10594.894051059391, 10699.94650026745, 10876.510557024953, 10898.291611045257, 10899.400532970603, 490970.0, 538698.0, 540795.0, 541422.0, 550894.4552772345, 96575.0, 99033.0, 99832.50083749535, 101032.0, 101803.0, 1219.1039585904352, 1227.643983244849, 1272.6500212441654, 1281.5706738242607, 1283.794592865137, 20394.490137746674, 20472.69290960607, 21229.256976006385, 21262.574748504634, 21317.36047918565, 45120.77439612781, 46764.7661761689, 46892.7655361721, 46984.0, 47034.0, 60776.392236077074, 61098.69450652718, 61564.38435615587, 62141.68929155325, 62511.0, 9074.228690561113, 9178.0, 9262.0, 9262.53687315645, 9317.254619630277, 13846.307684615931, 14267.0, 14626.780598290821, 14817.777733333793, 15464.84535154679, 12204.389780511117, 12586.496540138292, 12778.424970876518, 12806.48774049065, 13035.608931732064, 11211.215214934877, 12169.513219471477, 12197.268163910194, 12812.231266124063, 13051.477940882258, 13122.08145429849, 13199.472021119433, 13309.800352994907, 13364.866351336363, 13670.043096983514, 9144.3598948073, 9148.817023659356, 9460.858087128561, 9529.475878826732, 9607.375520591138, 12765.61703148907, 12824.807627885402, 12868.22790632565, 12908.41912113976, 13016.674583135497], "value": 10158.565759768573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.422670365095, 1398.0702832616312, 1414.335262426659, 1419.822522184727, 1420.7300612883557, 10874.347539147648, 11383.146264030189, 11387.089032877371, 11497.022753065978, 11762.647120586375, 11382.690990536092, 11575.247608905414, 11694.824577631342, 11700.707482312946, 11740.882591174086, 2262.8642281463126, 2295.8622482651012, 2297.161536039342, 2300.056976639578, 2300.470891694911, 2089.707440958267, 2161.6541353383464, 2170.7829217078247, 2173.7500187478404, 2174.706414634028, 2053.055594426558, 2082.302428686392, 2085.3118470904565, 2096.350131459245, 2096.716943212662, 2052.4971382011354, 2109.8945052747376, 2119.9682004769943, 2122.9150833966623, 2123.108294516307, 2113.8731676099483, 2192.2655910270078, 2199.681046248285, 2205.7022301989346, 2243.8653680779207, 11145.108391328675, 11149.275297105662, 11181.049610783093, 11241.494132764044, 11272.887271127265, 6197.907031394488, 6315.936840631581, 6345.238571371418, 6403.87192256157, 6412.422881940648, 3792.563855156665, 3833.9041523961846, 3926.0773718176206, 3938.330483817758, 3987.8404863805413, 1282.2626989481087, 1339.564641491519, 1353.4789106194087, 1390.5387464188432, 1395.1977612872538, 17160.0, 17372.65254694899, 17446.214920328617, 17451.5637109072, 17522.123893805387, 4810.182269014276, 4840.951590484121, 5047.4447810740785, 5089.898202035939, 5098.872528186751, 11986.0, 12068.939655301843, 12075.3358565278, 12093.0, 12113.273203607812, 6147.262328520516, 6151.6924153793025, 6162.476189523941, 6183.319834818167, 6192.256929168529, 5740.311162660424, 5844.649321040752, 5872.207252021008, 5936.5250779937505, 5971.223740913741, 3879.728419010642, 3993.980030099831, 4000.2599519089063, 4024.4969378827645, 4084.6528045116497, 1090.3022065877844, 1102.3354734351028, 1109.3233127792041, 1119.1103073056938, 1121.7532142928542, 813.4915677701437, 831.5551180118607, 843.5318398288886, 855.6919508976763, 876.8597024476181, 6104.511639068953, 6119.265688117454, 6200.100985357189, 6215.813525594149, 6303.653299068504, 606.3330336629672, 621.0559948877681, 623.8066199478176, 628.3245511075521, 630.9116723658691, 4116.814743336557, 4345.478542574911, 4466.821327146878, 4470.798814053311, 4483.618892394183, 14916.925415372854, 15332.156731379659, 15434.845651543565, 15448.150351730537, 15476.690466190837, 14707.705845883022, 14963.326650300764, 15151.772723409158, 15378.615534611725, 15423.768643470357, 9593.28050396223, 9763.755906102404, 9768.07203315684, 9774.218062554979, 9776.853347199798, 6463.095166676763, 6634.436072933855, 6710.228323742636, 6773.864522709419, 6864.176298844171, 12960.35198240103, 13334.599962001155, 13559.0, 13838.65403364924, 13884.305784710523, 13505.459781608626, 13877.959153063359, 13883.0, 14097.436102556194, 14104.294785260901, 8617.353698472765, 8633.525156116473, 8661.220490155916, 8704.434211776213, 8752.737417877473, 10978.780424391307, 11035.724106897393, 11048.337099774039, 11061.170412219277, 11095.833562496407, 9286.814263714552, 9352.438853668802, 9453.0, 9470.810583788149, 9762.755931101496, 9294.442333460014, 9427.0, 9427.528623568931, 9440.48077355752, 9457.574409151466, 7405.44459165554, 7501.0, 7524.05949256343, 7564.659590318339, 7564.962175189309, 5875.882482350415, 6191.504679625709, 6212.099245609271, 6287.0, 6320.968395158179, 6051.848703782441, 6128.509719222362, 6187.504999600112, 6282.591631543935, 6296.118543403835], "value": 5187.150206249011, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.8404830092112, 418.9664826813855, 428.87562606844006, 439.86364227089587, 441.27410409875745, 6006.45941865232, 6150.7539698412065, 6174.981128113855, 6210.7515699372025, 6230.043922109459, 5982.79060232892, 6017.217761690985, 6041.275046994367, 6051.515878729702, 6055.909161362583, 4508.391367165424, 4509.0530988492455, 4520.434945631796, 4534.2971839364955, 4540.387047748562, 4476.888077798065, 4482.282834746441, 4487.46150461945, 4511.323301504768, 4513.729176249419, 4476.6418686505, 4477.552244775513, 4477.820887164509, 4484.349769283468, 4495.730256184623, 4475.955240447603, 4492.303692927585, 4493.842715504974, 4509.301058335963, 4538.205813982539, 3844.9807750961068, 3898.1813819098024, 3922.3135951208424, 3927.8232479538487, 3928.7839168845703, 5923.0, 5926.377730338296, 5927.525797936198, 5936.111846740392, 5937.643741375531, 5299.761510731988, 5301.787928482856, 5316.229146773735, 5321.175217841241, 5322.973385133088, 6267.185265915402, 6354.5551811373225, 6402.839929001766, 6414.8717025659225, 6420.775272865428, 4370.0, 4381.255186618282, 4382.9619227059575, 4387.298032314814, 4395.494518130424, 6543.985682219263, 6733.6432248713045, 6766.966165169192, 6777.525573209878, 6786.253512113663, 4482.46210454741, 4493.483249426293, 4502.0, 4504.932426013613, 4513.661475389359, 4554.111948170142, 4559.90562265054, 4564.863054108382, 4565.680402371869, 4571.588557029883, 5223.190405487156, 5294.100002999499, 5312.1766126250495, 5335.413104558495, 5363.249145119687, 6323.7786677466065, 6478.902816457757, 6480.837979050467, 6481.935180648227, 6488.545801793924, 1552.79037329959, 1563.9061656300657, 1568.3726509396104, 1569.0272031340414, 1573.8111426628877, 989.747614358334, 1037.5019990404649, 1037.823569993103, 1048.9318194317345, 1053.7471006958428, 6191.288001879751, 6221.720022598994, 6229.314775374705, 6236.158118653923, 6289.150964619809, 6689.76585819494, 6709.630970296583, 6711.832204194837, 6720.22717387497, 6731.495137864582, 6057.394260573908, 6264.937350626436, 6275.207532648019, 6276.6547839868335, 6291.465225455888, 3507.9123021924147, 3551.8756843510355, 3561.8397172127316, 3605.3330133925306, 3618.4391419330045, 6837.145356830396, 6941.375276225164, 7022.297770222936, 7027.332403421667, 7063.752768653072, 6828.795136145924, 6837.555558888656, 6854.588724676535, 6895.896561551581, 6916.481263905227, 6822.556533825285, 6988.231294557595, 7087.149542054986, 7092.148942126874, 7110.502264841515, 6703.765368212089, 6735.966320168368, 6747.696353664195, 6752.561083529555, 6778.728850846108, 6472.708728107153, 6552.541322107598, 6627.668616569056, 6669.199696036507, 6674.599524028574, 7018.75434359795, 7034.613096279753, 7059.399951004017, 7066.823329416806, 7078.610676412641, 4412.646988240997, 4463.665225108195, 4471.0, 4490.977545112253, 4525.230710779109, 6504.15445992018, 6703.597784132968, 6713.295104014203, 6727.764528241488, 6796.422304104207, 6507.609543427409, 6527.249366322933, 6531.706073226621, 6534.0, 6543.70553325092, 6360.7992180483, 6422.807315780534, 6505.462869480812, 6519.282878883224, 6546.24718157418, 6500.382463665944, 6527.771527996498, 6549.312322206099, 6560.3111673273615, 6567.9671601641685, 6471.158749362553, 6565.212174539086, 6566.2120545532935, 6574.638394888327, 6588.374104460068, 6352.36476352361, 6368.5860419072615, 6376.52176086786, 6382.20222472191, 6384.680765961591], "value": 4873.839830394094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.7733155130884, 882.841088604051, 884.3234925282159, 894.2309613732193, 903.859901715234, 16464.753028704563, 16991.660166796657, 17050.488485345442, 17612.295508179657, 17820.465386038406, 16938.576535586617, 17001.2349444275, 17061.317547298095, 17392.391266305684, 17425.651486970284, 978.7259567321144, 990.5344488090586, 998.610541888664, 999.075854834279, 1002.5438425516409, 1024.4519182237505, 1024.8206563851334, 1025.9894004405655, 1027.234710140946, 1028.1312291114034, 1081.9242653014292, 1089.4443833644818, 1091.8198497247945, 1097.1113398147527, 1098.6045023791428, 1082.41008650285, 1085.2294870641854, 1090.939998300093, 1093.3276035238312, 1094.1137678480416, 735.301463609573, 751.9586422746747, 779.2519181585684, 782.81212508998, 786.7836345005112, 16150.192490375552, 16225.83774162255, 16256.105914174716, 16257.756133658004, 16341.0, 17929.641407171785, 18744.625107497774, 18757.34349297768, 18799.81200187994, 19004.0, 14421.206833624146, 14595.927020364936, 14713.852861471356, 14783.55649330511, 14989.625259368495, 3365.1082463147286, 3412.2151905061974, 3414.5219669246326, 3415.8804441844663, 3420.0594836419937, 88705.55647221787, 89183.55408222918, 90426.5478672609, 98261.0, 100145.99999999927, 14000.929995349958, 14250.572482825532, 14341.426342946374, 14451.92774036123, 14555.854441455662, 25851.22446326613, 27524.58713119305, 27995.440091198063, 28378.85810570934, 28507.429851402856, 8265.504069755834, 8439.95780021096, 8463.830723385498, 8494.0, 8499.702510412106, 3989.3617021276455, 4018.2566225248424, 4043.8786836394956, 4054.0, 4068.572799856032, 4257.744535327828, 4393.51671316155, 4422.823087076546, 4438.289873620205, 4441.333799929972, 856.1224744636797, 896.4800415758845, 898.2185498616116, 905.9139381758722, 907.0974380491454, 682.3722175598461, 683.702589373624, 698.4272896225149, 729.7154109897144, 739.9408047356198, 11535.0, 11990.0, 12077.57728479499, 12277.74043368931, 12589.24464532131, 672.1967249137234, 690.6374153569416, 693.5942473652868, 701.123595505618, 730.9451791115688, 5480.7533660985355, 5543.808081262548, 5723.456271654186, 5731.742071606787, 5748.913766293509, 81815.0, 81836.59081704673, 83240.16759832445, 83647.5817620908, 85226.0, 53896.46103538915, 74073.0, 74411.62794185994, 77576.2242377569, 81359.5932020336, 58894.41105588975, 59445.40554594485, 59615.40384596185, 60005.399946000856, 60649.69675151684, 11945.223560468541, 12575.245485270547, 12580.182288151242, 12778.23330600167, 12843.871561284268, 32848.83575582107, 33049.33901322008, 33720.0, 34208.315833683686, 34629.30741385208, 38805.6119438802, 54458.72770636121, 56621.71689141528, 57045.0, 58671.70664146652, 15430.305636246172, 15658.0, 15709.293081811118, 15746.370145194063, 15916.204189790697, 17545.56136096608, 17626.206820693355, 17776.733349000035, 17823.0, 17895.642087158445, 15192.0, 15398.46105386306, 15842.287097080429, 15847.366105355657, 16026.439074632799, 15763.0, 16416.507504774876, 16780.993140411614, 17062.914685426495, 17832.55418614545, 16409.17954102314, 17368.91315543414, 17576.296948122443, 17634.030128343064, 18026.549336266697, 11895.46470408851, 12004.099692522921, 12004.75990480203, 12651.620451386472, 12675.556355527513, 14113.788293175816, 14624.41502339937, 14626.926865365605, 14656.267186640413, 14676.853231467976], "value": 8280.84570487116, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 113.0, 110.0, 110.0, 111.0, 110.0, 111.0, 113.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 117.0, 118.0, 182.0, 115.0, 117.0, 116.0, 119.0, 140.0, 118.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 163.0, 164.0, 166.0, 166.0, 171.0, 174.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 95.0, 84.0, 74.0, 76.0, 75.0, 97.0, 73.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 102.0, 82.0, 82.0, 82.0, 110.0, 83.0, 83.0, 104.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 150.0, 151.0, 148.0, 149.0, 151.0, 148.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 100.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 52.0, 46.0, 46.0, 50.0, 46.0, 46.0, 47.0, 47.0], "value": 47.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 55.0, 57.0, 55.0, 56.0, 55.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 89.0, 84.0, 82.0, 82.0, 82.0, 92.0, 82.0, 82.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 132.0, 128.0, 126.0, 132.0, 131.0, 127.0, 126.0, 210.0, 126.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 184.0, 183.0, 182.0, 188.0, 185.0, 184.0, 176.0, 183.0, 182.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 69.0, 66.0, 68.0, 66.0, 70.0, 69.0, 73.0], "value": 68.0, "unit": "score"}]}]} 03:07:10 INFO - Return code: 0 03:07:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:07:10 INFO - # TBPL SUCCESS # 03:07:10 INFO - Running post-action listener: _resource_record_post_action 03:07:10 INFO - [mozharness: 2017-05-03 10:07:10.863839Z] Finished run-tests step (success) 03:07:10 INFO - Running post-run listener: _resource_record_post_run 03:07:10 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 356212736; Read time: 140; Write time: 228396 03:07:10 INFO - TinderboxPrint: CPU usage
13.2% 03:07:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 140 03:07:10 INFO - TinderboxPrint: I/O write bytes / time
356,212,736 / 228,396 03:07:10 INFO - TinderboxPrint: CPU idle
8,258.9 (86.8%) 03:07:10 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 03:07:10 INFO - TinderboxPrint: Swap in / out
0 / 0 03:07:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98304; Read time: 0; Write time: 44 03:07:10 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 248709120; Read time: 0; Write time: 130284 03:07:11 INFO - Running post-run listener: _upload_blobber_files 03:07:11 INFO - Blob upload gear active. 03:07:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:07:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:07:11 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:07:11 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:07:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:07:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:07:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:07:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:12 INFO - (blobuploader) - INFO - Done attempting. 03:07:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:07:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:07:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:13 INFO - (blobuploader) - INFO - Done attempting. 03:07:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:07:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:07:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:18 INFO - (blobuploader) - INFO - Done attempting. 03:07:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:07:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:07:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:18 INFO - (blobuploader) - INFO - Done attempting. 03:07:18 INFO - (blobuploader) - INFO - Iteration through files over. 03:07:18 INFO - Return code: 0 03:07:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:07:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:07:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e50ae63c48eeccf669c7a4be16d69fec5b03e696bf4506dafc418c9d5afbcc9cdcf8025bdfdc7f708105836e012dcfb10c1dfa7d7496e868fa6a295bad84dae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79b4f91f2f3706a7f9082022c4d6c04f58c20fbbdc2ed768500477654f49c256d34e610835761ab84831507586497e6bbd7a81dca3a5aebe88ed8350fdf1b31a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92e315155999a8d82fad6e7ac4efe21469f72b00dd0288591b0b88fe1975f08cae22dcef59de30c8ef0de97bfdb5d180cb706a6552763c076a24bb15592b5607", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11830e0d655f39176cdbf663a97953f14f070b6723643f451cfb571f5554e0923bbad09028464c92af35bcdcaf723d97a54acc9268a2a9ae36a7d4ade3f89d4d"} 03:07:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:07:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:07:18 INFO - Contents: 03:07:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e50ae63c48eeccf669c7a4be16d69fec5b03e696bf4506dafc418c9d5afbcc9cdcf8025bdfdc7f708105836e012dcfb10c1dfa7d7496e868fa6a295bad84dae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79b4f91f2f3706a7f9082022c4d6c04f58c20fbbdc2ed768500477654f49c256d34e610835761ab84831507586497e6bbd7a81dca3a5aebe88ed8350fdf1b31a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92e315155999a8d82fad6e7ac4efe21469f72b00dd0288591b0b88fe1975f08cae22dcef59de30c8ef0de97bfdb5d180cb706a6552763c076a24bb15592b5607", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11830e0d655f39176cdbf663a97953f14f070b6723643f451cfb571f5554e0923bbad09028464c92af35bcdcaf723d97a54acc9268a2a9ae36a7d4ade3f89d4d"} 03:07:18 INFO - Running post-run listener: copy_logs_to_upload_dir 03:07:18 INFO - Copying logs to upload dir... 03:07:18 INFO - mkdir: /builds/slave/test/build/upload/logs 03:07:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.557116 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-03 03:07:18.984210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 03:07:18.987259) ========= 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=41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e50ae63c48eeccf669c7a4be16d69fec5b03e696bf4506dafc418c9d5afbcc9cdcf8025bdfdc7f708105836e012dcfb10c1dfa7d7496e868fa6a295bad84dae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79b4f91f2f3706a7f9082022c4d6c04f58c20fbbdc2ed768500477654f49c256d34e610835761ab84831507586497e6bbd7a81dca3a5aebe88ed8350fdf1b31a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92e315155999a8d82fad6e7ac4efe21469f72b00dd0288591b0b88fe1975f08cae22dcef59de30c8ef0de97bfdb5d180cb706a6552763c076a24bb15592b5607", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11830e0d655f39176cdbf663a97953f14f070b6723643f451cfb571f5554e0923bbad09028464c92af35bcdcaf723d97a54acc9268a2a9ae36a7d4ade3f89d4d"} build_url:https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/EMWhUU_JRCK9aut9Z14sEg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e50ae63c48eeccf669c7a4be16d69fec5b03e696bf4506dafc418c9d5afbcc9cdcf8025bdfdc7f708105836e012dcfb10c1dfa7d7496e868fa6a295bad84dae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79b4f91f2f3706a7f9082022c4d6c04f58c20fbbdc2ed768500477654f49c256d34e610835761ab84831507586497e6bbd7a81dca3a5aebe88ed8350fdf1b31a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92e315155999a8d82fad6e7ac4efe21469f72b00dd0288591b0b88fe1975f08cae22dcef59de30c8ef0de97bfdb5d180cb706a6552763c076a24bb15592b5607", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11830e0d655f39176cdbf663a97953f14f070b6723643f451cfb571f5554e0923bbad09028464c92af35bcdcaf723d97a54acc9268a2a9ae36a7d4ade3f89d4d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 03:07:19.015298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 03:07:19.015578) ========= 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=41bf3e9aed84707956354da8000001c5-1493804790.691339-569989645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 03:07:19.096422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 03:07:19.096716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 03:07:19.099998) ========= ========= Total master_lag: 0.40 =========