builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1493845831.54 results: success (0) revision: b25ad0674afd563e888dc07981baa626e8d794db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:31.540886) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:31.541302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:31.541587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:31.556446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:31.556700) ========= 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=4300f881736b422476174874000001bc-1493845831.145161-1757739917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-03 14:10:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.2M=0s 2017-05-03 14:10:32 (37.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138063 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:31.712065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:31.712372) ========= 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=4300f881736b422476174874000001bc-1493845831.145161-1757739917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020002 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:31.761474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:31.761792) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b25ad0674afd563e888dc07981baa626e8d794db --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 b25ad0674afd563e888dc07981baa626e8d794db --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=4300f881736b422476174874000001bc-1493845831.145161-1757739917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-03 14:10:32,249 truncating revision to first 12 chars 2017-05-03 14:10:32,249 Setting DEBUG logging. 2017-05-03 14:10:32,249 attempt 1/10 2017-05-03 14:10:32,249 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b25ad0674afd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 14:10:32,699 unpacking tar archive at: mozilla-central-b25ad0674afd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.737007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:32.518379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:32.518694) ========= script_repo_revision: b25ad0674afd563e888dc07981baa626e8d794db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:32.519062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:32.519322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 14:10:32.529566) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-03 14:10:32.529846) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1493845831.145161-1757739917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:33 INFO - MultiFileLogger online at 20170503 14:10:33 in /builds/slave/test 14:10:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:10:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:33 INFO - {'append_to_log': False, 14:10:33 INFO - 'base_work_dir': '/builds/slave/test', 14:10:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:10:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:33 INFO - 'branch': 'Firefox-Non-PGO', 14:10:33 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:33 INFO - 'config_files': ('talos/linux_config.py',), 14:10:33 INFO - 'default_actions': ('clobber', 14:10:33 INFO - 'read-buildbot-config', 14:10:33 INFO - 'download-and-extract', 14:10:33 INFO - 'populate-webroot', 14:10:33 INFO - 'create-virtualenv', 14:10:33 INFO - 'install', 14:10:33 INFO - 'run-tests'), 14:10:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:33 INFO - 'download_minidump_stackwalk': True, 14:10:33 INFO - 'download_symbols': 'ondemand', 14:10:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:33 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:33 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:33 INFO - 'gecko_profile': False, 14:10:33 INFO - 'gecko_profile_interval': 0, 14:10:33 INFO - 'installer_path': 'installer.exe', 14:10:33 INFO - 'log_level': 'info', 14:10:33 INFO - 'log_name': 'talos', 14:10:33 INFO - 'log_to_console': True, 14:10:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:33 INFO - 'opt_config_files': (), 14:10:33 INFO - 'pip_index': False, 14:10:33 INFO - 'suite': 'dromaeojs-e10s', 14:10:33 INFO - 'system_bits': '32', 14:10:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:33 INFO - 'title': 'talos-linux64-ix-045', 14:10:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:33 INFO - 'use_talos_json': True, 14:10:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:33 INFO - 'work_dir': 'build'} 14:10:33 INFO - [mozharness: 2017-05-03 21:10:33.117249Z] Running clobber step. 14:10:33 INFO - Running pre-action listener: _resource_record_pre_action 14:10:33 INFO - Running main action method: clobber 14:10:33 INFO - rmtree: /builds/slave/test/build 14:10:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:34 INFO - Running post-action listener: _resource_record_post_action 14:10:34 INFO - [mozharness: 2017-05-03 21:10:34.656915Z] Finished clobber step (success) 14:10:34 INFO - [mozharness: 2017-05-03 21:10:34.657023Z] Running read-buildbot-config step. 14:10:34 INFO - Running pre-action listener: _resource_record_pre_action 14:10:34 INFO - Running main action method: read_buildbot_config 14:10:34 INFO - Using buildbot properties: 14:10:34 INFO - { 14:10:34 INFO - "project": "", 14:10:34 INFO - "product": "firefox", 14:10:34 INFO - "who": "kwierso@gmail.com", 14:10:34 INFO - "installer_path": "public/build/target.tar.bz2", 14:10:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:10:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:10:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:10:34 INFO - "stage_platform": "linux64", 14:10:34 INFO - "basedir": "/builds/slave/test", 14:10:34 INFO - "buildnumber": 811, 14:10:34 INFO - "platform": "ubuntu64_hw", 14:10:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:10:34 INFO - "slavebuilddir": "test", 14:10:34 INFO - "taskId": "NuHYPqeEQTyGI6rRDMijsA", 14:10:34 INFO - "branch": "mozilla-central", 14:10:34 INFO - "script_repo_revision": "production", 14:10:34 INFO - "revision": "b25ad0674afd563e888dc07981baa626e8d794db", 14:10:34 INFO - "slavename": "talos-linux64-ix-045", 14:10:34 INFO - "repo_path": "mozilla-central" 14:10:34 INFO - } 14:10:34 INFO - Finding installer, test and symbols from parent task. 14:10:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NuHYPqeEQTyGI6rRDMijsA'}, attempt #1 14:10:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NuHYPqeEQTyGI6rRDMijsA'}, attempt #1 14:10:35 INFO - Task dependencies: TvuxwbEGQQy1e81Ga9u2Lg 14:10:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg'}, attempt #1 14:10:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.tar.bz2 14:10:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/test_packages.json 14:10:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.crashreporter-symbols.zip 14:10:36 INFO - Running post-action listener: _resource_record_post_action 14:10:36 INFO - [mozharness: 2017-05-03 21:10:36.020061Z] Finished read-buildbot-config step (success) 14:10:36 INFO - [mozharness: 2017-05-03 21:10:36.020280Z] Running download-and-extract step. 14:10:36 INFO - Running pre-action listener: _resource_record_pre_action 14:10:36 INFO - Running main action method: download_and_extract 14:10:36 INFO - mkdir: /builds/slave/test/build/tests 14:10:36 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')]} 14:10:36 INFO - trying https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.test_packages.json 14:10:36 INFO - Downloading https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:10:36 INFO - Downloaded 986 bytes. 14:10:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:10:36 INFO - Using the following test package requirements: 14:10:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:10:36 INFO - u'common': [u'target.common.tests.zip'], 14:10:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:10:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:10:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:10:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:10:36 INFO - u'mozbase': [u'target.common.tests.zip'], 14:10:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:10:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:10:36 INFO - u'web-platform': [u'target.common.tests.zip', 14:10:36 INFO - u'target.web-platform.tests.zip'], 14:10:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:10:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:10:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.common.tests.zip 14:10:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:10:36 INFO - Fetch https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.common.tests.zip into memory 14:10:37 INFO - Content-Length response header: 58436048 14:10:37 INFO - Bytes received: 58436048 14:10:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:10:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.common.tests.zip 14:10:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:10:47 INFO - Fetch https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.common.tests.zip into memory 14:10:48 INFO - Content-Length response header: 58436048 14:10:48 INFO - Bytes received: 58436048 14:10:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.talos.tests.zip 14:10:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:10:59 INFO - Fetch https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.talos.tests.zip into memory 14:11:00 INFO - Content-Length response header: 14408809 14:11:00 INFO - Bytes received: 14408809 14:11: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')]} 14:11:00 INFO - trying https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.tar.bz2 14:11:00 INFO - Downloading https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:11:01 INFO - Downloaded 58258763 bytes. 14:11:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.tar.bz2 14:11:01 INFO - mkdir: /builds/slave/test/properties 14:11:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:01 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:01 INFO - Contents: 14:11:01 INFO - build_url:https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.tar.bz2 14:11:01 INFO - Running post-action listener: _resource_record_post_action 14:11:01 INFO - Running post-action listener: set_extra_try_arguments 14:11:01 INFO - [mozharness: 2017-05-03 21:11:01.429342Z] Finished download-and-extract step (success) 14:11:01 INFO - [mozharness: 2017-05-03 21:11:01.429439Z] Running populate-webroot step. 14:11:01 INFO - Running pre-action listener: _resource_record_pre_action 14:11:01 INFO - Running main action method: populate_webroot 14:11:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:01 INFO - '--tppagecycles', 14:11:01 INFO - '7'], 14:11:01 INFO - 'tests': ['tsvgm']}}, 14:11:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:11:01 INFO - 'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:11:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:11:01 INFO - 'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['damp', 'tps']}, 14:11:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:11:01 INFO - 'tests': ['damp', 'tps']}, 14:11:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['dromaeo_dom']}, 14:11:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:11:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:11:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['a11yr', 14:11:01 INFO - 'ts_paint', 14:11:01 INFO - 'tpaint', 14:11:01 INFO - 'sessionrestore', 14:11:01 INFO - 'sessionrestore_no_auto_restore', 14:11:01 INFO - 'tabpaint']}, 14:11:01 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:01 INFO - 'ts_paint', 14:11:01 INFO - 'tpaint', 14:11:01 INFO - 'sessionrestore', 14:11:01 INFO - 'sessionrestore_no_auto_restore', 14:11:01 INFO - 'tabpaint']}, 14:11:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:01 INFO - 'ts_paint', 14:11:01 INFO - 'tpaint', 14:11:01 INFO - 'sessionrestore', 14:11:01 INFO - 'sessionrestore_no_auto_restore', 14:11:01 INFO - 'tabpaint']}, 14:11:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:01 INFO - 'ts_paint', 14:11:01 INFO - 'tpaint', 14:11:01 INFO - 'sessionrestore', 14:11:01 INFO - 'sessionrestore_no_auto_restore', 14:11:01 INFO - 'tabpaint']}, 14:11:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['a11yr', 14:11:01 INFO - 'ts_paint', 14:11:01 INFO - 'tpaint', 14:11:01 INFO - 'sessionrestore', 14:11:01 INFO - 'sessionrestore_no_auto_restore', 14:11:01 INFO - 'tabpaint']}, 14:11:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['a11yr', 14:11:01 INFO - 'ts_paint', 14:11:01 INFO - 'tpaint', 14:11:01 INFO - 'sessionrestore', 14:11:01 INFO - 'sessionrestore_no_auto_restore', 14:11:01 INFO - 'tabpaint']}, 14:11:01 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:11:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:11:01 INFO - 'bloom_basic_ref']}, 14:11:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['tsvgx', 14:11:01 INFO - 'tsvgr_opacity', 14:11:01 INFO - 'tart', 14:11:01 INFO - 'tscrollx', 14:11:01 INFO - 'cart', 14:11:01 INFO - 'tsvg_static']}, 14:11:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:01 INFO - 'tsvgr_opacity', 14:11:01 INFO - 'tart', 14:11:01 INFO - 'tscrollx', 14:11:01 INFO - 'cart', 14:11:01 INFO - 'tsvg_static']}, 14:11:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:11:01 INFO - 'talos_options': ['--disable-e10s'], 14:11:01 INFO - 'tests': ['tp5o']}, 14:11:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:11:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:11:01 INFO - 'talos_options': ['--disable-e10s', 14:11:01 INFO - '--xperf_path', 14:11:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:01 INFO - 'tests': ['tp5n']}, 14:11:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:11:01 INFO - 'talos_options': ['--xperf_path', 14:11:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:01 INFO - 'tests': ['tp5n']}}, 14:11:01 INFO - 'talos.zip': {'path': '', 14:11:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:01 INFO - Running post-action listener: _resource_record_post_action 14:11:01 INFO - [mozharness: 2017-05-03 21:11:01.443240Z] Finished populate-webroot step (success) 14:11:01 INFO - [mozharness: 2017-05-03 21:11:01.443330Z] Running create-virtualenv step. 14:11:01 INFO - Running pre-action listener: _resource_record_pre_action 14:11:01 INFO - Running main action method: create_virtualenv 14:11:01 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11: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 14:11:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:01 INFO - Using real prefix '/usr' 14:11:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:02 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:04 INFO - Installing pip.................done. 14:11:04 INFO - Return code: 0 14:11:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:11:04 INFO - Reading from file tmpfile_stdout 14:11:04 INFO - Output received: 14:11: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) 14:11:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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 0x16321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, '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': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', '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 14:11: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 14:11: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 14:11:04 INFO - Using env: {'DISPLAY': ':0', 14:11:04 INFO - 'HOME': '/home/cltbld', 14:11:04 INFO - 'LANG': 'en_US.UTF-8', 14:11:04 INFO - 'LANGUAGE': 'en_US:en', 14:11:04 INFO - 'LOGNAME': 'cltbld', 14:11:04 INFO - 'MAIL': '/var/mail/cltbld', 14:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:04 INFO - 'MOZ_NO_REMOTE': '1', 14:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:04 INFO - 'NO_EM_RESTART': '1', 14:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:04 INFO - 'PWD': '/builds/slave/test', 14:11:04 INFO - 'SHELL': '/bin/bash', 14:11:04 INFO - 'SHLVL': '1', 14:11:04 INFO - 'TERM': 'linux', 14:11:04 INFO - 'TMOUT': '86400', 14:11:04 INFO - 'USER': 'cltbld', 14:11:04 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:04 INFO - '_': '/tools/buildbot/bin/python'} 14:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11: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 14:11:04 INFO - Cleaning up... 14:11:04 INFO - Return code: 0 14:11:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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 0x16321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, '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': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', '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 14:11: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 14:11: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 14:11:04 INFO - Using env: {'DISPLAY': ':0', 14:11:04 INFO - 'HOME': '/home/cltbld', 14:11:04 INFO - 'LANG': 'en_US.UTF-8', 14:11:04 INFO - 'LANGUAGE': 'en_US:en', 14:11:04 INFO - 'LOGNAME': 'cltbld', 14:11:04 INFO - 'MAIL': '/var/mail/cltbld', 14:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:04 INFO - 'MOZ_NO_REMOTE': '1', 14:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:04 INFO - 'NO_EM_RESTART': '1', 14:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:04 INFO - 'PWD': '/builds/slave/test', 14:11:04 INFO - 'SHELL': '/bin/bash', 14:11:04 INFO - 'SHLVL': '1', 14:11:04 INFO - 'TERM': 'linux', 14:11:04 INFO - 'TMOUT': '86400', 14:11:04 INFO - 'USER': 'cltbld', 14:11:04 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:04 INFO - '_': '/tools/buildbot/bin/python'} 14:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:04 INFO - Downloading/unpacking psutil>=3.1.1 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:05 INFO - Installing collected packages: psutil 14:11:05 INFO - Running setup.py install for psutil 14:11:05 INFO - building 'psutil._psutil_linux' extension 14:11: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 14:11: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:11:06 INFO - building 'psutil._psutil_posix' extension 14:11:06 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 14:11: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 14:11:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:06 INFO - Successfully installed psutil 14:11:06 INFO - Cleaning up... 14:11:06 INFO - Return code: 0 14:11:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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 0x16321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, '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': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', '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 14:11: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 14:11: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 14:11:06 INFO - Using env: {'DISPLAY': ':0', 14:11:06 INFO - 'HOME': '/home/cltbld', 14:11:06 INFO - 'LANG': 'en_US.UTF-8', 14:11:06 INFO - 'LANGUAGE': 'en_US:en', 14:11:06 INFO - 'LOGNAME': 'cltbld', 14:11:06 INFO - 'MAIL': '/var/mail/cltbld', 14:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:06 INFO - 'MOZ_NO_REMOTE': '1', 14:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:06 INFO - 'NO_EM_RESTART': '1', 14:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:06 INFO - 'PWD': '/builds/slave/test', 14:11:06 INFO - 'SHELL': '/bin/bash', 14:11:06 INFO - 'SHLVL': '1', 14:11:06 INFO - 'TERM': 'linux', 14:11:06 INFO - 'TMOUT': '86400', 14:11:06 INFO - 'USER': 'cltbld', 14:11:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:06 INFO - '_': '/tools/buildbot/bin/python'} 14:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:07 INFO - Installing collected packages: mozsystemmonitor 14:11:07 INFO - Running setup.py install for mozsystemmonitor 14:11:07 INFO - Successfully installed mozsystemmonitor 14:11:07 INFO - Cleaning up... 14:11:07 INFO - Return code: 0 14:11:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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 0x16321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, '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': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', '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 14:11: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 14:11: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 14:11:07 INFO - Using env: {'DISPLAY': ':0', 14:11:07 INFO - 'HOME': '/home/cltbld', 14:11:07 INFO - 'LANG': 'en_US.UTF-8', 14:11:07 INFO - 'LANGUAGE': 'en_US:en', 14:11:07 INFO - 'LOGNAME': 'cltbld', 14:11:07 INFO - 'MAIL': '/var/mail/cltbld', 14:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:07 INFO - 'MOZ_NO_REMOTE': '1', 14:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:07 INFO - 'NO_EM_RESTART': '1', 14:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:07 INFO - 'PWD': '/builds/slave/test', 14:11:07 INFO - 'SHELL': '/bin/bash', 14:11:07 INFO - 'SHLVL': '1', 14:11:07 INFO - 'TERM': 'linux', 14:11:07 INFO - 'TMOUT': '86400', 14:11:07 INFO - 'USER': 'cltbld', 14:11:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:07 INFO - '_': '/tools/buildbot/bin/python'} 14:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:08 INFO - Downloading/unpacking jsonschema==2.5.1 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:09 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:09 INFO - warning: no files found matching '*.txt' 14:11:09 INFO - no previously-included directories found matching 'build' 14:11:09 INFO - no previously-included directories found matching 'dist' 14:11:09 INFO - no previously-included directories found matching '.git*' 14:11:09 INFO - Installing collected packages: jsonschema, functools32 14:11:09 INFO - Running setup.py install for functools32 14:11:09 INFO - warning: no files found matching '*.txt' 14:11:09 INFO - no previously-included directories found matching 'build' 14:11:09 INFO - no previously-included directories found matching 'dist' 14:11:09 INFO - no previously-included directories found matching '.git*' 14:11:09 INFO - Successfully installed jsonschema functools32 14:11:09 INFO - Cleaning up... 14:11:09 INFO - Return code: 0 14:11:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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 0x16321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, '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': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', '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 14:11: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 14:11: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 14:11:09 INFO - Using env: {'DISPLAY': ':0', 14:11:09 INFO - 'HOME': '/home/cltbld', 14:11:09 INFO - 'LANG': 'en_US.UTF-8', 14:11:09 INFO - 'LANGUAGE': 'en_US:en', 14:11:09 INFO - 'LOGNAME': 'cltbld', 14:11:09 INFO - 'MAIL': '/var/mail/cltbld', 14:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:09 INFO - 'MOZ_NO_REMOTE': '1', 14:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:09 INFO - 'NO_EM_RESTART': '1', 14:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:09 INFO - 'PWD': '/builds/slave/test', 14:11:09 INFO - 'SHELL': '/bin/bash', 14:11:09 INFO - 'SHLVL': '1', 14:11:09 INFO - 'TERM': 'linux', 14:11:09 INFO - 'TMOUT': '86400', 14:11:09 INFO - 'USER': 'cltbld', 14:11:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:09 INFO - '_': '/tools/buildbot/bin/python'} 14:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:11:09 INFO - Cleaning up... 14:11:09 INFO - Return code: 0 14:11:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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 0x16321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, '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': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', '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 14:11: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 14:11: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 14:11:09 INFO - Using env: {'DISPLAY': ':0', 14:11:09 INFO - 'HOME': '/home/cltbld', 14:11:09 INFO - 'LANG': 'en_US.UTF-8', 14:11:09 INFO - 'LANGUAGE': 'en_US:en', 14:11:09 INFO - 'LOGNAME': 'cltbld', 14:11:09 INFO - 'MAIL': '/var/mail/cltbld', 14:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:09 INFO - 'MOZ_NO_REMOTE': '1', 14:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:09 INFO - 'NO_EM_RESTART': '1', 14:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:09 INFO - 'PWD': '/builds/slave/test', 14:11:09 INFO - 'SHELL': '/bin/bash', 14:11:09 INFO - 'SHLVL': '1', 14:11:09 INFO - 'TERM': 'linux', 14:11:09 INFO - 'TMOUT': '86400', 14:11:09 INFO - 'USER': 'cltbld', 14:11:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:09 INFO - '_': '/tools/buildbot/bin/python'} 14:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:09 INFO - Downloading/unpacking blobuploader==1.2.4 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:11 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:11 INFO - Downloading docopt-0.6.1.tar.gz 14:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:11 INFO - Running setup.py install for blobuploader 14:11:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:11 INFO - Running setup.py install for requests 14:11:12 INFO - Running setup.py install for docopt 14:11:12 INFO - Successfully installed blobuploader requests docopt 14:11:12 INFO - Cleaning up... 14:11:12 INFO - Return code: 0 14:11:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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 0x16321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, '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': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', '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 14:11: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 14:11: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 14:11:12 INFO - Using env: {'DISPLAY': ':0', 14:11:12 INFO - 'HOME': '/home/cltbld', 14:11:12 INFO - 'LANG': 'en_US.UTF-8', 14:11:12 INFO - 'LANGUAGE': 'en_US:en', 14:11:12 INFO - 'LOGNAME': 'cltbld', 14:11:12 INFO - 'MAIL': '/var/mail/cltbld', 14:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:12 INFO - 'MOZ_NO_REMOTE': '1', 14:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:12 INFO - 'NO_EM_RESTART': '1', 14:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:12 INFO - 'PWD': '/builds/slave/test', 14:11:12 INFO - 'SHELL': '/bin/bash', 14:11:12 INFO - 'SHLVL': '1', 14:11:12 INFO - 'TERM': 'linux', 14:11:12 INFO - 'TMOUT': '86400', 14:11:12 INFO - 'USER': 'cltbld', 14:11:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:12 INFO - '_': '/tools/buildbot/bin/python'} 14:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:12 INFO - Running setup.py (path:/tmp/pip-n3DzGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:12 INFO - Running setup.py (path:/tmp/pip-jBm3xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:12 INFO - Running setup.py (path:/tmp/pip-q1BChv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:12 INFO - Running setup.py (path:/tmp/pip-jpAucX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:12 INFO - Running setup.py (path:/tmp/pip-T7TEZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:12 INFO - Running setup.py (path:/tmp/pip-OEgthv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:12 INFO - Running setup.py (path:/tmp/pip-FQjOQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:12 INFO - Running setup.py (path:/tmp/pip-g7v1jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:13 INFO - Running setup.py (path:/tmp/pip-vgbZGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:13 INFO - Running setup.py (path:/tmp/pip-OJ0IKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:13 INFO - Running setup.py (path:/tmp/pip-6z9RGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:13 INFO - Running setup.py (path:/tmp/pip-C3OQjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:13 INFO - Running setup.py (path:/tmp/pip-x0O_MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:13 INFO - Running setup.py (path:/tmp/pip-2d4UJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:13 INFO - Running setup.py (path:/tmp/pip-4ih_dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:13 INFO - Running setup.py (path:/tmp/pip-1WbjH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:13 INFO - Running setup.py (path:/tmp/pip-zYa0up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:13 INFO - Running setup.py install for manifestparser 14:11:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:13 INFO - Running setup.py install for mozcrash 14:11:13 INFO - Running setup.py install for mozdebug 14:11:13 INFO - Running setup.py install for mozdevice 14:11:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:14 INFO - Running setup.py install for mozfile 14:11:14 INFO - Running setup.py install for mozhttpd 14:11:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:14 INFO - Running setup.py install for mozinfo 14:11:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:14 INFO - Running setup.py install for mozInstall 14:11:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:14 INFO - Running setup.py install for mozleak 14:11:14 INFO - Running setup.py install for mozlog 14:11:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:14 INFO - Running setup.py install for moznetwork 14:11:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:14 INFO - Running setup.py install for mozprocess 14:11:14 INFO - Running setup.py install for mozprofile 14:11:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:15 INFO - Running setup.py install for mozrunner 14:11:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:15 INFO - Running setup.py install for mozscreenshot 14:11:15 INFO - Running setup.py install for moztest 14:11:15 INFO - Running setup.py install for mozversion 14:11:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:15 INFO - Cleaning up... 14:11:15 INFO - Return code: 0 14:11:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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 0x16321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, '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': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', '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 14:11: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 14:11: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 14:11:15 INFO - Using env: {'DISPLAY': ':0', 14:11:15 INFO - 'HOME': '/home/cltbld', 14:11:15 INFO - 'LANG': 'en_US.UTF-8', 14:11:15 INFO - 'LANGUAGE': 'en_US:en', 14:11:15 INFO - 'LOGNAME': 'cltbld', 14:11:15 INFO - 'MAIL': '/var/mail/cltbld', 14:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:15 INFO - 'MOZ_NO_REMOTE': '1', 14:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:15 INFO - 'NO_EM_RESTART': '1', 14:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:15 INFO - 'PWD': '/builds/slave/test', 14:11:15 INFO - 'SHELL': '/bin/bash', 14:11:15 INFO - 'SHLVL': '1', 14:11:15 INFO - 'TERM': 'linux', 14:11:15 INFO - 'TMOUT': '86400', 14:11:15 INFO - 'USER': 'cltbld', 14:11:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:15 INFO - '_': '/tools/buildbot/bin/python'} 14:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:15 INFO - Running setup.py (path:/tmp/pip-c8gNI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11: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)) 14:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:15 INFO - Running setup.py (path:/tmp/pip-y7aSf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11: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)) 14:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:15 INFO - Running setup.py (path:/tmp/pip-XXLOzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11: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)) 14:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:15 INFO - Running setup.py (path:/tmp/pip-yzCmbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:16 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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:16 INFO - Running setup.py (path:/tmp/pip-rsNRlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:16 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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:16 INFO - Running setup.py (path:/tmp/pip-hvDBj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:16 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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:16 INFO - Running setup.py (path:/tmp/pip-2xCJxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:16 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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:16 INFO - Running setup.py (path:/tmp/pip-q_mmUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11: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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:16 INFO - Running setup.py (path:/tmp/pip-dmVKe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11: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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:16 INFO - Running setup.py (path:/tmp/pip-XIygu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11: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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:16 INFO - Running setup.py (path:/tmp/pip-8_VN3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11: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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:16 INFO - Running setup.py (path:/tmp/pip-dzQPlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11: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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:16 INFO - Running setup.py (path:/tmp/pip-mcvqQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11: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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:16 INFO - Running setup.py (path:/tmp/pip-rOdIsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11: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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:16 INFO - Running setup.py (path:/tmp/pip-E9CqTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11: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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:16 INFO - Running setup.py (path:/tmp/pip-CXI57S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11: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)) 14:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:16 INFO - Running setup.py (path:/tmp/pip-5QVwDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:17 INFO - Downloading blessings-1.6.tar.gz 14:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:18 INFO - Installing collected packages: blessings 14:11:18 INFO - Running setup.py install for blessings 14:11:18 INFO - Successfully installed blessings 14:11:18 INFO - Cleaning up... 14:11:18 INFO - Return code: 0 14:11:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:18 INFO - Reading from file tmpfile_stdout 14:11:18 INFO - Current package versions: 14:11:18 INFO - argparse == 1.2.1 14:11:18 INFO - blessings == 1.6 14:11:18 INFO - blobuploader == 1.2.4 14:11:18 INFO - docopt == 0.6.1 14:11:18 INFO - functools32 == 3.2.3-2 14:11:18 INFO - jsonschema == 2.5.1 14:11:18 INFO - manifestparser == 1.1 14:11:18 INFO - mozInstall == 1.12 14:11:18 INFO - mozcrash == 1.0 14:11:18 INFO - mozdebug == 0.1 14:11:18 INFO - mozdevice == 0.50 14:11:18 INFO - mozfile == 1.2 14:11:18 INFO - mozhttpd == 0.7 14:11:18 INFO - mozinfo == 0.9 14:11:18 INFO - mozleak == 0.1 14:11:18 INFO - mozlog == 3.4 14:11:18 INFO - moznetwork == 0.27 14:11:18 INFO - mozprocess == 0.25 14:11:18 INFO - mozprofile == 0.28 14:11:18 INFO - mozrunner == 6.13 14:11:18 INFO - mozscreenshot == 0.1 14:11:18 INFO - mozsystemmonitor == 0.3 14:11:18 INFO - moztest == 0.8 14:11:18 INFO - mozversion == 1.4 14:11:18 INFO - psutil == 3.1.1 14:11:18 INFO - requests == 1.2.3 14:11:18 INFO - wsgiref == 0.1.2 14:11:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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 0x16321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, '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': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', '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 14:11: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 14:11: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 14:11:18 INFO - Using env: {'DISPLAY': ':0', 14:11:18 INFO - 'HOME': '/home/cltbld', 14:11:18 INFO - 'LANG': 'en_US.UTF-8', 14:11:18 INFO - 'LANGUAGE': 'en_US:en', 14:11:18 INFO - 'LOGNAME': 'cltbld', 14:11:18 INFO - 'MAIL': '/var/mail/cltbld', 14:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:18 INFO - 'MOZ_NO_REMOTE': '1', 14:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:18 INFO - 'NO_EM_RESTART': '1', 14:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:18 INFO - 'PWD': '/builds/slave/test', 14:11:18 INFO - 'SHELL': '/bin/bash', 14:11:18 INFO - 'SHLVL': '1', 14:11:18 INFO - 'TERM': 'linux', 14:11:18 INFO - 'TMOUT': '86400', 14:11:18 INFO - 'USER': 'cltbld', 14:11:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:18 INFO - '_': '/tools/buildbot/bin/python'} 14:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11: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)) 14:11:18 INFO - Cleaning up... 14:11:18 INFO - Return code: 0 14:11:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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 0x16321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, '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': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', '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 14:11: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 14:11: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 14:11:18 INFO - Using env: {'DISPLAY': ':0', 14:11:18 INFO - 'HOME': '/home/cltbld', 14:11:18 INFO - 'LANG': 'en_US.UTF-8', 14:11:18 INFO - 'LANGUAGE': 'en_US:en', 14:11:18 INFO - 'LOGNAME': 'cltbld', 14:11:18 INFO - 'MAIL': '/var/mail/cltbld', 14:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:18 INFO - 'MOZ_NO_REMOTE': '1', 14:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:18 INFO - 'NO_EM_RESTART': '1', 14:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:18 INFO - 'PWD': '/builds/slave/test', 14:11:18 INFO - 'SHELL': '/bin/bash', 14:11:18 INFO - 'SHLVL': '1', 14:11:18 INFO - 'TERM': 'linux', 14:11:18 INFO - 'TMOUT': '86400', 14:11:18 INFO - 'USER': 'cltbld', 14:11:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:18 INFO - '_': '/tools/buildbot/bin/python'} 14:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:18 INFO - Cleaning up... 14:11:18 INFO - Return code: 0 14:11:18 INFO - Running post-action listener: _resource_record_post_action 14:11:18 INFO - Running post-action listener: _start_resource_monitoring 14:11:18 INFO - Starting resource monitoring. 14:11:18 INFO - [mozharness: 2017-05-03 21:11:18.946886Z] Finished create-virtualenv step (success) 14:11:18 INFO - [mozharness: 2017-05-03 21:11:18.947356Z] Running install step. 14:11:18 INFO - Running pre-action listener: _resource_record_pre_action 14:11:18 INFO - Running main action method: install 14:11:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:19 INFO - Reading from file tmpfile_stdout 14:11:19 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:19 INFO - Reading from file tmpfile_stdout 14:11:19 INFO - Output received: 14:11:19 INFO - Usage: mozinstall [options] installer 14:11:19 INFO - Options: 14:11:19 INFO - -h, --help show this help message and exit 14:11:19 INFO - -d DEST, --destination=DEST 14:11:19 INFO - Directory to install application into. [default: 14:11:19 INFO - "/builds/slave/test"] 14:11:19 INFO - --app=APP Application being installed. [default: firefox] 14:11:19 INFO - mkdir: /builds/slave/test/build/application 14:11:19 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'] 14:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:11:34 INFO - Reading from file tmpfile_stdout 14:11:34 INFO - Output received: 14:11:34 INFO - /builds/slave/test/build/application/firefox/firefox 14:11:34 INFO - Running post-action listener: _resource_record_post_action 14:11:34 INFO - [mozharness: 2017-05-03 21:11:34.127821Z] Finished install step (success) 14:11:34 INFO - [mozharness: 2017-05-03 21:11:34.128066Z] Running run-tests step. 14:11:34 INFO - Running pre-action listener: _resource_record_pre_action 14:11:34 INFO - Running main action method: run_tests 14:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:34 INFO - Python 2.7.3 14:11:34 INFO - Return code: 0 14:11:34 INFO - grabbing minidump binary from tooltool 14:11:34 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')]} 14:11:34 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 0x18cd290>, '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 0x18cdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ce040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:34 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 14:11:34 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 14:11:34 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 14:11:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:34 INFO - Return code: 0 14:11:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:11:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:34 INFO - ENV: RUST_BACKTRACE is now 1 14:11:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:11:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 14:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 14:11:34 INFO - Using env: {'DISPLAY': ':0', 14:11:34 INFO - 'HOME': '/home/cltbld', 14:11:34 INFO - 'LANG': 'en_US.UTF-8', 14:11:34 INFO - 'LANGUAGE': 'en_US:en', 14:11:34 INFO - 'LOGNAME': 'cltbld', 14:11:34 INFO - 'MAIL': '/var/mail/cltbld', 14:11:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:34 INFO - 'MOZ_NO_REMOTE': '1', 14:11:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:34 INFO - 'NO_EM_RESTART': '1', 14:11:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:34 INFO - 'PWD': '/builds/slave/test', 14:11:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:34 INFO - 'RUST_BACKTRACE': '1', 14:11:34 INFO - 'SHELL': '/bin/bash', 14:11:34 INFO - 'SHLVL': '1', 14:11:34 INFO - 'TERM': 'linux', 14:11:34 INFO - 'TMOUT': '86400', 14:11:34 INFO - 'USER': 'cltbld', 14:11:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493845831.145161-1757739917', 14:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:34 INFO - '_': '/tools/buildbot/bin/python'} 14:11:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 14:11:34 INFO - mozversion application_buildid: 20170503204431 14:11:34 INFO - mozversion application_changeset: b25ad0674afd563e888dc07981baa626e8d794db 14:11:34 INFO - mozversion application_display_name: Nightly 14:11:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:34 INFO - mozversion application_name: Firefox 14:11:34 INFO - mozversion application_remotingname: firefox 14:11:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:11:34 INFO - mozversion application_vendor: Mozilla 14:11:34 INFO - mozversion application_version: 55.0a1 14:11:34 INFO - mozversion platform_buildid: 20170503204431 14:11:34 INFO - mozversion platform_changeset: b25ad0674afd563e888dc07981baa626e8d794db 14:11:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:11:34 INFO - mozversion platform_version: 55.0a1 14:11:34 INFO - using testdate: 1493845894 14:11:34 INFO - actual date: 1493845894 14:11:34 INFO - starting webserver on 'localhost:49961' 14:11:34 INFO - SUITE-START | Running 2 tests 14:11:34 INFO - TEST-START | dromaeo_css 14:11:34 INFO - operating with platform_type : linux_ 14:11:34 INFO - Initialising browser for dromaeo_css test... 14:11:34 INFO - TEST-INFO | started process 30988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUCpPvC/profile http://localhost:49961/getInfo.html) 14:11:39 INFO - PID 30988 | __metrics Screen width/height:1600/1200 14:11:39 INFO - PID 30988 | colorDepth:24 14:11:39 INFO - PID 30988 | Browser inner width/height: 1024/695 14:11:39 INFO - PID 30988 | __metrics 14:11:41 INFO - TEST-INFO | 30988: exit 0 14:11:41 INFO - Browser initialized. 14:11:41 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:41 INFO - TEST-INFO | started process 31158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUCpPvC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:53 INFO - PID 31158 | RSS: Main: 160104448 14:11:53 INFO - PID 31158 | 14:14:59 INFO - PID 31158 | Cycle 1(1): loaded http://localhost:49961/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49961/tests/dromaeo/cssquery-ext.html) 14:15:00 INFO - PID 31158 | RSS: Main: 163160064 14:15:00 INFO - PID 31158 | 14:18:02 INFO - PID 31158 | Cycle 1(1): loaded http://localhost:49961/tests/dromaeo/cssquery-ext.html (next: http://localhost:49961/tests/dromaeo/cssquery-jquery.html) 14:18:03 INFO - PID 31158 | RSS: Main: 158298112 14:18:03 INFO - PID 31158 | 14:21:05 INFO - PID 31158 | Cycle 1(1): loaded http://localhost:49961/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49961/tests/dromaeo/cssquery-mootools.html) 14:21:05 INFO - PID 31158 | RSS: Main: 166281216 14:21:05 INFO - PID 31158 | 14:24:07 INFO - PID 31158 | Cycle 1(1): loaded http://localhost:49961/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49961/tests/dromaeo/cssquery-prototype.html) 14:24:08 INFO - PID 31158 | RSS: Main: 157896704 14:24:08 INFO - PID 31158 | 14:27:11 INFO - PID 31158 | Cycle 1(1): loaded http://localhost:49961/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49961/tests/dromaeo/cssquery-yui.html) 14:27:11 INFO - PID 31158 | RSS: Main: 162603008 14:27:11 INFO - PID 31158 | 14:30:13 INFO - PID 31158 | Cycle 1(1): loaded http://localhost:49961/tests/dromaeo/cssquery-yui.html (next: http://localhost:49961/tests/dromaeo/cssquery-dojo.html) 14:30:13 INFO - PID 31158 | RSS: Main: 166113280 14:30:13 INFO - PID 31158 | 14:30:13 INFO - PID 31158 | __start_tp_report 14:30:13 INFO - PID 31158 | _x_x_mozilla_page_load 14:30:13 INFO - PID 31158 | _x_x_mozilla_page_load_details 14:30:13 INFO - PID 31158 | |i|pagename|runs| 14:30:13 INFO - PID 31158 | |0;dojo.html;2688.475747229291;2690.166048524957;2707.269037359913;2724.60493228482;2730.6859711133225;5160.638755287131;5161.0968080585935;5186;5196.896062078757;5242.370915490142;5242.7640756165965;5244;5255;5353.7590808413615;5362.624616276862;4675.485696573392;4702.177119004177;4760.4525479569775;4788.616910647157;4794.712317260958;4817.108834865544;4825.831095911626;4828.203346447849;4832.106060378824;4847.660663753539;4629.398178236807;4689.155951928651;4708.952910470885;4765.1660959331975;4775.761211939389;4721.457032441244;4722.386089808338;4748.71507709535;4763.166445871959;4775.928361074587;4639.164950308943;4657.231556793159;4689.085628302482;4709.199436095838;4720.976395118037;5164.535191832715;5248.501392367719;5285.68285902847;5297.867553311198;5333.786648534093;5637.126245431924;5685.545156387479;5728.5417166626985;5741.62679425836;5750.223719797816;5684.2326285951285;5726.541876649858;5730.341010783772;5732.942670573282;5739.684317362543;5226.268322434862;5325.786968521294;5332.33345831771;5340.679559226459;5390.137577987503;5854.590178687451;5856.765729370777;5878.353381128072;5903.996320625504;5959.821205363846;5604.243427137284;5616.185653080281;5658.91511627326;5665.603407761417;5670.716464176775;5627.465390787868;5667.263255776723;5714.771324165325;5724.25584673998;5779.190913272145;5676.68778217202;5679.801206957736;5680.971595141998;5681.801136960186;5694.861027794458;5468.507834294933;5556.249906262603;5563.638363506359;5661.490465858093;5674.744636491368;4700.623950083985;4732.290156476556;4744.857654270378;4749.1926372516755;4786.928196077061;4071.633552980187;4072.6538244249573;4080.877758616345;4097.426360309559;4113.25961326964;4808.110499557593;4869.415670119608;4870.025994801054;4881.170201065827;4916.606671466274;5660.122680984454;5665.688387138747;5717.028105222123;5729.684867332337;5732.455416735404;4789.832355867528;4820.325154478376;4824.8793780155775;4826.927596086061;4830.154722923475;5043.747812609355;5051.494850514992;5054.342935418372;5060.84817455477;5061.139606266944;5294.708791016531;5296.496832800878;5298.364196296315;5307.734613269398;5311.867203319871;5646.322441307069;5702.942970570407;5707.6575405475805;5708.457696518824;5708.571857110816;5253.448387919213;5264.368275806928;5298.523132918056;5316.468353164652;5352.1971704243115;5626.5780066496;5648.943510564842;5657.264555607745;5673.347565030074;5679.659220446786;5663.716814159358;5759.625624334405;5767.538596912321;5772.9711351442975;5778.942210578009;5529.336479622471;5543.667379957215;5608.747606357642;5610.102383618601;5629.437056294338;5581.804636837691;5613.691246981455;5618.971905140448;5621.044422448112;5633;5448.83653490396;5547.389787123332;5553.944460555343;5555.2222688822785;5604.551635869202;5471.589630777628;5527.198556209408;5540.695261760642;5616.8876622466505;5622.269105016322;5494.532964698045;5495.313085864267;5500.779968801363;5507.394186639386;5532.806351777668 14:30:13 INFO - PID 31158 | |1;ext.html;621.9595726277792;661.738613247767;683.6035099642206;1149.9080073594107;1185.0874826383679;34757;35612.10969725758;35647.4652880207;35707.2858542829;35749.46375804359;32862.34275314492;33319;33334;33370.49944250838;33455.498167527505;6501.4798816094835;6625.635590042546;6896.069030680869;7098.148222213342;7107.85784284314;6987.161540615133;7043.190033146177;7071.010058591775;7079.150501939775;7094.11323584552;7014.403775679073;7091.5390499617615;7095.85808283834;7135.607541585211;7147.249538798429;7072.115985501812;7079.362857342864;7100.360967512948;7107.538010029331;7108.39578635814;6947.340002699735;6972.51192416531;6994.510384273103;6995.755148569776;7012.088428504313;32470.675293247237;32734;32814.83592582046;32955.6704432955;33022;3014.608100946885;3039.741621962136;3048.253177971389;3058.0520038788045;3059.9541006884915;24905;24950.12674556382;25074.24777256667;25108;25129.24612261635;3146.465100932847;3148.323110531224;3155.2742869139997;3170.239142605781;3188.2029492626843;139537.99999999898;139656.30171849075;140094;153756;158298.99999999884;40026.79986600106;40253.39619905704;40291.395629065584;40426;40475;41210.38184427236;41572;41717.165656687306;45030;46115;11886.16796824214;11972.820407693891;12029.639110826689;12038;12077.214981026382;9354.579043943038;9373.953130234306;9412.388194767318;9420.293477989042;9460.195883349854;12984.805227921588;13013.47946082165;13023.47906083746;13144.474221031243;13200.537981170613;5367.221752845816;5460.945390546044;5574.470425309589;5583.469570390806;5628.409017053233;878.9956050219708;906.9727908162765;918.7886786039248;922.5663937949154;926.8239034583543;21739.782602173775;21858.453538661342;22011.33965981023;22068.889655551942;22098;980.568549838069;991.6578780320777;1012.4229189361993;1020.454057079459;1023.5496381592076;11242.887571124347;11535;11600.709982250512;11628.94185529084;11662.650120496399;173745;175059;175688;175894;176820;40817;41268;41282.58717412847;41361.79319103385;41473.79263103665;1208.4018410886667;1238.207547169812;1242.7514497100617;1243.0801207106856;1253.0727261826182;19828.801711983273;20712.792872071688;21687.45781355479;23963.52072958496;25357.19087862198;37501.81249093737;39170.608293916695;39219.60780392159;39344.60655393409;39395.40906886342;157478;157537;158334;158436;158484;29650.479709224957;29694;29781.10656680303;29956.850215748782;30133.09600711982;36175.81912090423;36192.63807361998;36343.63656363403;36563.63436365602;36666.45000325051;27960.30099247535;28260.71739282663;28460.288492787848;28487.28781780472;29517.262068447602;26992.865035674695;27558.311042224104;27608.447831043668;27940.25015747287;28703.282417939718;31307.686923130477;31311;31352.216194594406;31440.528392074593;31475.213119671276;26989.59515607307;28514.14457566276;28545.571816422354;28619.713802861705;29722.851385743797;22321.553568928855;22631.773682262967;23262.883685581462;23295.534089317778;23453.296401107993 14:30:13 INFO - PID 31158 | |2;jquery.html;422.4930083899322;428.05495300072306;430.48771961365975;434.7587089165513;442.14224404654965;17309.740353894686;17338.653226935454;17919.64160716785;18024.098795060243;18093.27626894926;18029.81970180301;18276.725849112274;18546;18583;18599.070046497654;5428.158635411518;5498.872731090117;5582.637128586649;5598.692071936042;5651.32184137902;5508.173773933902;5577.972110139443;5596.160575913605;5596.748146333404;5613.522850557708;5251.737413129347;5476.507114359707;5489.6980666063355;5494.1758736189695;5519.199716041192;5441.5102640762525;5443.455654434564;5467.17992301158;5467.972660136694;5469;4961.677490963112;4968.826091086795;4976.104301225778;4983.626228032912;5000.89998200034;22167.44581385462;22304.219352322754;22599.20902768395;22759;22852.77147228523;1565.92953317101;1593.784839046737;1603.286537490817;1603.847634474723;1607.2365626327519;14806.925965370105;14905.776413353808;15243.314050867737;15457.922710386376;15475.535733928;2042.1116814185878;2114.756802967663;2147.4953385954286;2147.871127732341;2150.397888591197;78613;85383.77395621529;87498.5625071877;93915.53042234814;99481.50259248658;10715.732106697395;11264.94367528157;11275.210735248455;11375.089992800557;11538.711532211593;15786.447474338343;15789.763153552705;15816.209189540477;15819;15841.762373564407;7418.703251869865;7518.511296765692;7679.884801727979;7837.412194085467;7844.921550784419;6727.091842601186;6921.48088893335;6938.167419909643;7127.002219689248;7165.928340716526;6805.353491418307;6831.69257383419;6841.350071743176;6855.6572171391235;7006.334398232159;2015.1637070615823;2039.4901274681329;2046.815786579215;2064.7728749837506;2138.978610213909;856.2379482260793;889.7775556110972;894.821035792844;895.5253715530779;916.7387294621001;17091.97448153115;17335;17762.91118544425;17810.5547361317;18023.639527209383;884.1556313720511;890.7951171230524;897.1611543206992;908.4640062363105;915.839728047589;9233;9541.570629321697;9748;9851.50742462874;9960.302778805413;348506;350577;354569.3027996927;360400;366491;64702.352976470575;73039.26960730324;74601.25398745944;75024;75664.62167689126;1056.8414737789394;1058.090042563395;1096.8793432722393;1100.1913593508764;1108.0304733358312;17109.914450427666;17396.652066958843;17417.651646967242;17985.640287194445;18458.26166953307;37142;38342;38560.80719596384;38942.221155577296;39373.80313098416;46243.306350405444;46305.768471157426;46523;46933.530664694284;48854;8130.75607731769;8199.877001845096;8372.41393102477;8463.407561470884;8525.848483492546;13509.324533773075;13653.79519307231;13766.518171863936;13789.931050345085;13937.790933135808;11036.172287078341;11217.49521271561;11439.370834604177;11477.82783258235;11784.077963555417;10041.748956276151;10784.838227426751;10986.945065274622;11139.275947063416;11246.100311974858;10762.3542587445;11215.43922803873;11640.767184656428;11744.471498782405;11797.469113889723;8578.4424012439;8687.348448866234;8818.382713210014;8937.195652391316;8960.596773145355;11159.55361785552;11311.683508750873;11551.075913927034;11562.653120406401;11614.825777613512 14:30:13 INFO - PID 31158 | |3;mootools.html;1246.9501219951203;1302.4269321498539;1317.6771690935723;1320.6830360713432;1328.1698938163645;9723.562439690213;10198.235132365066;10202.030807073326;10207.540660670269;10443.321184123046;9639.180669643089;9702.660406885743;9730.513474326273;9769.951150244256;9784.559694813732;2208.282308249821;2267.047839907243;2268.2514770125817;2275.180934863448;2275.374272075176;1981.821636052755;2028.1177687705895;2031.6343058249508;2035.2469586253108;2037.2258541754186;2154.622940985329;2157.546915147821;2191.5835991161707;2200.1309482754305;2202.6916231727573;2162.2107930605293;2196.5057861981086;2198.934031979027;2199.626063569197;2201.273579718689;2053.1787285085934;2141.453929248047;2175.3908905506482;2201.4496375906024;2203.5262418580082;10092.142167915736;10123.89876101237;10166.034226748521;10182.439965801952;10191.490425478696;5504.889902201933;5746.741396637161;5751.482366586985;5751.971240143773;5753.280839895013;3348.28011977426;3473.478978153272;3489.319582681378;3525.894223173309;3528.7177025837873;1100.7963526747578;1148.104478506766;1148.2478976270556;1153.6366044695894;1156.0347110163025;15165;15182.924085379613;15255.466058687893;15277.770833437507;15329.923350383177;4655.74393408359;4909.140900342426;5018.548330650259;5030.647854650212;5046.39443266803;10905.291156074829;10909.509072091774;10929.945350273198;10933.617323393642;10951.397673128055;5543.445655434424;5575.69333686643;5578.358488773762;5581.944180558143;5598.10430331145;5042.344495215599;5131.61512886535;5180.093483640348;5187.584993200535;5219.582433405319;3676.5955744868043;3842.423636454554;3870.322693528621;3902.9219415612097;3955.861544845974;1091.748897753521;1102.7573933734566;1106.6292791914639;1118.3625333559955;1120.0423637789736;687.5977553131374;710.3535782438059;710.8720430322592;725.9564426134343;729.4492658043143;5313.601479889024;5402.270693456412;5403.513683768401;5421.105517589633;5515.586331025189;541.5910987204635;558.2742434834698;558.541995563642;558.8323502949099;567.9886402272014;3581.3374525712825;3665.2669466106886;3678.301122786662;3722.553293604785;3791.9431208531896;13090.410931508104;13525.59423217305;13562.254076025716;13586.660333491543;13659;13004.674883127998;13333.066685332127;13338.199708017355;13339.866601333862;13366.131201471873;7473.065866766654;7675.078990521173;7703.345215656732;7788.8052798679355;7811.609419529001;5398.676079435247;5433.673979561239;5594.496495315441;5665.49010589049;5811.041178205549;10679;10718;10748;10792.62225822124;10884.401357925073;11079.446027698421;11099.611513596985;11117.888821111685;11207.831882521605;11338.886611133783;6876.587404755731;7046.401055910305;7055.047568578177;7077.7168913242895;7095.609741464269;8925.642974280956;9024.819503610022;9050.728478145666;9053.68312109073;9070.047644997445;7629.694812207449;7939.166387529226;7939.960300198462;8045;8063;7556.131044929683;7758.456908016385;7830.608469576385;7851.489653172525;7885.881711774213;6977.546459480118;7135.750248741477;7196.532225405541;7220.38626716735;7227.241139680258;4883.096627123993;4917.754112294442;4985.152524070844;5013.874653133555;5052.747362631927;5116.360454943132;5172.431032586337;5226.398964119023;5252.501012403815;5294.12646913255 14:30:13 INFO - PID 31158 | |4;prototype.html;366.99633003669953;395.4345286240678;399.92601368746784;402.6999885085611;404.276345341838;5532.1425179097205;5539.972300138499;5572.832815015556;5580.330360356763;5601.60788744788;5450.700211488366;5455.509004189622;5479;5483.259759932408;5495.835124946248;4141.73078749881;4286.378475121106;4297.59172878576;4314.352847072949;4326.6538676905775;4276.636485898703;4298.376735373369;4300.3764454154125;4301.118270754503;4301.483821941371;4271.188474189909;4277.3156294992805;4287.764172970486;4294.785260736966;4299.591538803808;4223.746575205498;4229;4278.807453664593;4281.957180428202;4285.164392943378;3844.2888065707934;3846.442265871433;3855.055511399725;3862.1503269280715;3869.7097717671286;5385.434529374398;5402.675839449606;5408.3509978802795;5411.512963833274;5428.809991650312;4974.477679843637;5018.80553626998;5047.16721740916;5091.541761241506;5106.310648062501;5790.884182316372;5801.723620803416;5812.796552120698;5830.56270779689;5831.825045248649;4319.740815551077;4341.565843415665;4342.956570434287;4347.0653809430805;4382.342648602703;5947.524198064145;6095.146679464923;6110.816675499742;6119.204503414528;6133.294671112834;4470.284754439274;4501.279795232747;4505.684602077823;4507.2788353863225;4511.729296242236;4534.206513860061;4549.135664223787;4559.749213793207;4561.2245918193985;4569.360289559464;4545.431821022372;4693.5775780179265;4720.929186062212;4739.573438390561;4742.620590352833;5747.9882041286055;5753.510951569164;5754.74103665336;5758.856028599234;5773.769049237983;1395.1489591349268;1405.8383285922046;1435.397133204057;1436.2387934394787;1438.8417324054237;932.8320902237663;939.3893968920256;949.2168960607527;953.3326671330096;953.5994882149514;5035.723035233097;5064.1897296433135;5073.441921388644;5103.693778373236;5104.923426148611;5936.5250779937505;6044.516438684895;6065.787697430569;6088.086786981989;6093.573449858556;4955.083309587738;5032.974835125801;5049.091163590516;5050.84847454577;5083.856132370261;3181.5545823584716;3188.8041984255906;3198.472252078381;3203.5034569641743;3223.403670320998;5425.294711687456;5533.695646739468;5567.137093750475;5595.720213989284;5596.748146333425;5994.610350327215;6109.961306577892;6130.681903390792;6155.446009859134;6163.722632481549;5582.469665381782;5584.664920104807;5593.776248950077;5626.859328516656;5630.5214056805635;5976.193213916065;6043.969780151071;6045.6070355426755;6061.877503721185;6069.393060693896;5720.170575266647;5913.91129133072;5915.91126133117;5934.703264836655;5946.881062378641;5568.49883510486;5586.748596313095;5592;5607.943920560742;5611.74747136388;3957.9010524737114;4024.189114898249;4029.395590661424;4054.614811592894;4066.755994640331;6022.518198544193;6031.5476339273855;6033.456988871023;6055;6075.453209211192;5839.211706419579;5839.35767065614;5847.795327163699;5856.472917437281;5885.558583106199;5700.686462244616;5814.970925145347;5820.894030134261;5822.214001109796;5833.066709326487;5720.141978703228;5750.137479378127;5754.884902302014;5772.307323121252;5784.2769653793275;5823.330317013429;5845.824625261249;5854.62416332153;5882.970585147047;5921.763129474945;5690.94717477268;5692.5445964321925;5712.80005199816;5715.257016587983;5724.59747361899 14:30:13 INFO - PID 31158 | |5;yui.html;735.9852802943938;749.4753672429301;760.3650951455535;768.0169383189516;784.5880912520926;12541.937290313535;12665.176763510377;13238;13265;13303.467861285537;14354.78467822981;14721.705565888702;14762.852371476281;14850;14854.960152789283;835.482001159282;863.1282404771164;871.4117970370006;876.5967654878764;878.0736323179044;908.2552307108141;909.727081875438;911.3984770051767;912.9543522823866;915.5239275576696;945.9337846350758;951.5052172870104;954.0840792838883;954.8901876284247;955.4362925873733;942.2556180617304;949.1078386316874;949.9002604726508;952.6760901293524;952.9666461673843;697.0311267338403;698.8602279544111;699.2552931128332;700.618163101106;702.0487239790062;14271.143731376047;14370.497032603913;14468.276586170754;14528.357449102343;14737.410503579844;14115;14164.150150990974;14499.492517761828;14534;14605.561833145022;11023.944880275627;11235.101191904629;11364.829527557093;11369.31784092957;11426.94286528562;2717.578775289833;2718.1709578578525;2720;2729.849858257795;2749.463854548364;68378.65810670964;70455.64772176158;71561;73113.26886731118;73190.99999999946;10820.78358432827;10837.295575787548;10847.240693151403;10897.727556811144;10964.17768667353;17127.914360428367;17695.646087078185;17766;21542.56914861694;22230;5841.678707671119;5876.676782776988;6278.529110316745;6317.336679648571;6326.051092336186;2893.8119022263486;2948.1450379390167;2959.5412711029826;2963.777716671258;2974.6579143398353;3302.9174270643425;3360.2943381890077;3366.7811592246426;3385.136790118504;3396.847141878621;703.2124021096405;707.1620130145793;708.5288283291553;708.8369674974682;710.7476845719798;606.1332294818452;609.762192744821;615.6860001399318;616.140484024783;629.8425393651587;8997.955010224907;9852.901470985198;9867.358621689567;10074.546645400975;10371.429571373646;600.6756351570191;605.8273392083236;607.908813677943;609.9969500152471;625.8685676007998;4349.151915376535;4367.650587952956;4422.115576884636;4459.44256967879;4464.129494748493;62974.37025629777;63059;63211.36788632055;63491;64736.352636473035;57916;58131.41868581345;58264.41735582675;58364.12453813196;58652;52710.472895270555;52884.73557632187;52973.735131324866;54198;54428.183577246375;8548;8861.33539984491;8883.644654213758;8959.507227102571;8962.372633915564;28017.859910701132;28026.579601305588;28170.577441338806;28343.716562834106;29668.406631867674;33159.83420082884;33161.336773263916;33232.1691957703;33883.66116338805;34023.82988085044;11750.882491174978;12018.519259229533;12217.877821221675;12272.81590776157;12385.071119665881;14122.152670839372;14296.928515357356;14776.33506492189;14852.480163194236;15082.321295541507;12892.548760793326;13052.738945221232;13302.800457992944;13489.730205395641;13606.86393136056;13191.868081319064;13668.24824634615;13808;13934.58196254114;14103.224322662352;12923.806142907675;13314.93342533281;13329.933350333185;13381.130226535244;13386.933065334611;8690.087540808125;8776.605052772513;9270.907290927275;9715.9028409715;9773.462459564793;10268.178545716473;10390.480475976019;10797.406142661916;10940.288881222696;10964 14:30:13 INFO - PID 31158 | __end_tp_report 14:30:13 INFO - PID 31158 | __start_cc_report 14:30:13 INFO - PID 31158 | _x_x_mozilla_cycle_collect,362 14:30:13 INFO - PID 31158 | __end_cc_report 14:30:13 INFO - PID 31158 | __startTimestamp1493847013776__endTimestamp 14:30:13 INFO - PID 31158 | 14:30:13 INFO - PID 31158 | ------- Summary: start ------- 14:30:13 INFO - PID 31158 | Number of tests: 6 14:30:13 INFO - PID 31158 | 14:30:13 INFO - PID 31158 | [#0] dojo.html Cycles:165 Average:5218.35 Median:5353.76 stddev:619.05 (11.6%) stddev-sans-first:588.28 14:30:13 INFO - PID 31158 | Values: 2688.5 2690.2 2707.3 2724.6 2730.7 5160.6 5161.1 5186.0 5196.9 5242.4 5242.8 5244.0 5255.0 5353.8 5362.6 4675.5 4702.2 4760.5 4788.6 4794.7 4817.1 4825.8 4828.2 4832.1 4847.7 4629.4 4689.2 4709.0 4765.2 4775.8 4721.5 4722.4 4748.7 4763.2 4775.9 4639.2 4657.2 4689.1 4709.2 4721.0 5164.5 5248.5 5285.7 5297.9 5333.8 5637.1 5685.5 5728.5 5741.6 5750.2 5684.2 5726.5 5730.3 5732.9 5739.7 5226.3 5325.8 5332.3 5340.7 5390.1 5854.6 5856.8 5878.4 5904.0 5959.8 5604.2 5616.2 5658.9 5665.6 5670.7 5627.5 5667.3 5714.8 5724.3 5779.2 5676.7 5679.8 5681.0 5681.8 5694.9 5468.5 5556.2 5563.6 5661.5 5674.7 4700.6 4732.3 4744.9 4749.2 4786.9 4071.6 4072.7 4080.9 4097.4 4113.3 4808.1 4869.4 4870.0 4881.2 4916.6 5660.1 5665.7 5717.0 5729.7 5732.5 4789.8 4820.3 4824.9 4826.9 4830.2 5043.7 5051.5 5054.3 5060.8 5061.1 5294.7 5296.5 5298.4 5307.7 5311.9 5646.3 5702.9 5707.7 5708.5 5708.6 5253.4 5264.4 5298.5 5316.5 5352.2 5626.6 5648.9 5657.3 5673.3 5679.7 5663.7 5759.6 5767.5 5773.0 5778.9 5529.3 5543.7 5608.7 5610.1 5629.4 5581.8 5613.7 5619.0 5621.0 5633.0 5448.8 5547.4 5553.9 5555.2 5604.6 5471.6 5527.2 5540.7 5616.9 5622.3 5494.5 5495.3 5500.8 5507.4 5532.8 14:30:13 INFO - PID 31158 | 14:30:13 INFO - PID 31158 | [#1] ext.html Cycles:180 Average:31011.78 Median:17311.77 stddev:41386.48 (239.1%) stddev-sans-first:41439.67 14:30:13 INFO - PID 31158 | Values: 622.0 661.7 683.6 1149.9 1185.1 34757.0 35612.1 35647.5 35707.3 35749.5 32862.3 33319.0 33334.0 33370.5 33455.5 6501.5 6625.6 6896.1 7098.1 7107.9 6987.2 7043.2 7071.0 7079.2 7094.1 7014.4 7091.5 7095.9 7135.6 7147.2 7072.1 7079.4 7100.4 7107.5 7108.4 6947.3 6972.5 6994.5 6995.8 7012.1 32470.7 32734.0 32814.8 32955.7 33022.0 3014.6 3039.7 3048.3 3058.1 3060.0 24905.0 24950.1 25074.2 25108.0 25129.2 3146.5 3148.3 3155.3 3170.2 3188.2 139538.0 139656.3 140094.0 153756.0 158299.0 40026.8 40253.4 40291.4 40426.0 40475.0 41210.4 41572.0 41717.2 45030.0 46115.0 11886.2 11972.8 12029.6 12038.0 12077.2 9354.6 9374.0 9412.4 9420.3 9460.2 12984.8 13013.5 13023.5 13144.5 13200.5 5367.2 5460.9 5574.5 5583.5 5628.4 879.0 907.0 918.8 922.6 926.8 21739.8 21858.5 22011.3 22068.9 22098.0 980.6 991.7 1012.4 1020.5 1023.5 11242.9 11535.0 11600.7 11628.9 11662.7 173745.0 175059.0 175688.0 175894.0 176820.0 40817.0 41268.0 41282.6 41361.8 41473.8 1208.4 1238.2 1242.8 1243.1 1253.1 19828.8 20712.8 21687.5 23963.5 25357.2 37501.8 39170.6 39219.6 39344.6 39395.4 157478.0 157537.0 158334.0 158436.0 158484.0 29650.5 29694.0 29781.1 29956.9 30133.1 36175.8 36192.6 36343.6 36563.6 36666.5 27960.3 28260.7 28460.3 28487.3 29517.3 26992.9 27558.3 27608.4 27940.3 28703.3 31307.7 31311.0 31352.2 31440.5 31475.2 26989.6 28514.1 28545.6 28619.7 29722.9 22321.6 22631.8 23262.9 23295.5 23453.3 14:30:13 INFO - PID 31158 | 14:30:13 INFO - PID 31158 | [#2] jquery.html Cycles:180 Average:24515.38 Median:37742.00 stddev:59280.95 (157.1%) stddev-sans-first:59419.65 14:30:13 INFO - PID 31158 | Values: 422.5 428.1 430.5 434.8 442.1 17309.7 17338.7 17919.6 18024.1 18093.3 18029.8 18276.7 18546.0 18583.0 18599.1 5428.2 5498.9 5582.6 5598.7 5651.3 5508.2 5578.0 5596.2 5596.7 5613.5 5251.7 5476.5 5489.7 5494.2 5519.2 5441.5 5443.5 5467.2 5468.0 5469.0 4961.7 4968.8 4976.1 4983.6 5000.9 22167.4 22304.2 22599.2 22759.0 22852.8 1565.9 1593.8 1603.3 1603.8 1607.2 14806.9 14905.8 15243.3 15457.9 15475.5 2042.1 2114.8 2147.5 2147.9 2150.4 78613.0 85383.8 87498.6 93915.5 99481.5 10715.7 11264.9 11275.2 11375.1 11538.7 15786.4 15789.8 15816.2 15819.0 15841.8 7418.7 7518.5 7679.9 7837.4 7844.9 6727.1 6921.5 6938.2 7127.0 7165.9 6805.4 6831.7 6841.4 6855.7 7006.3 2015.2 2039.5 2046.8 2064.8 2139.0 856.2 889.8 894.8 895.5 916.7 17092.0 17335.0 17762.9 17810.6 18023.6 884.2 890.8 897.2 908.5 915.8 9233.0 9541.6 9748.0 9851.5 9960.3 348506.0 350577.0 354569.3 360400.0 366491.0 64702.4 73039.3 74601.3 75024.0 75664.6 1056.8 1058.1 1096.9 1100.2 1108.0 17109.9 17396.7 17417.7 17985.6 18458.3 37142.0 38342.0 38560.8 38942.2 39373.8 46243.3 46305.8 46523.0 46933.5 48854.0 8130.8 8199.9 8372.4 8463.4 8525.8 13509.3 13653.8 13766.5 13789.9 13937.8 11036.2 11217.5 11439.4 11477.8 11784.1 10041.7 10784.8 10986.9 11139.3 11246.1 10762.4 11215.4 11640.8 11744.5 11797.5 8578.4 8687.3 8818.4 8937.2 8960.6 11159.6 11311.7 11551.1 11562.7 11614.8 14:30:13 INFO - PID 31158 | 14:30:13 INFO - PID 31158 | [#3] mootools.html Cycles:180 Average:6129.72 Median:3856.37 stddev:3951.30 (102.5%) stddev-sans-first:3945.35 14:30:13 INFO - PID 31158 | Values: 1247.0 1302.4 1317.7 1320.7 1328.2 9723.6 10198.2 10202.0 10207.5 10443.3 9639.2 9702.7 9730.5 9770.0 9784.6 2208.3 2267.0 2268.3 2275.2 2275.4 1981.8 2028.1 2031.6 2035.2 2037.2 2154.6 2157.5 2191.6 2200.1 2202.7 2162.2 2196.5 2198.9 2199.6 2201.3 2053.2 2141.5 2175.4 2201.4 2203.5 10092.1 10123.9 10166.0 10182.4 10191.5 5504.9 5746.7 5751.5 5752.0 5753.3 3348.3 3473.5 3489.3 3525.9 3528.7 1100.8 1148.1 1148.2 1153.6 1156.0 15165.0 15182.9 15255.5 15277.8 15329.9 4655.7 4909.1 5018.5 5030.6 5046.4 10905.3 10909.5 10929.9 10933.6 10951.4 5543.4 5575.7 5578.4 5581.9 5598.1 5042.3 5131.6 5180.1 5187.6 5219.6 3676.6 3842.4 3870.3 3902.9 3955.9 1091.7 1102.8 1106.6 1118.4 1120.0 687.6 710.4 710.9 726.0 729.4 5313.6 5402.3 5403.5 5421.1 5515.6 541.6 558.3 558.5 558.8 568.0 3581.3 3665.3 3678.3 3722.6 3791.9 13090.4 13525.6 13562.3 13586.7 13659.0 13004.7 13333.1 13338.2 13339.9 13366.1 7473.1 7675.1 7703.3 7788.8 7811.6 5398.7 5433.7 5594.5 5665.5 5811.0 10679.0 10718.0 10748.0 10792.6 10884.4 11079.4 11099.6 11117.9 11207.8 11338.9 6876.6 7046.4 7055.0 7077.7 7095.6 8925.6 9024.8 9050.7 9053.7 9070.0 7629.7 7939.2 7940.0 8045.0 8063.0 7556.1 7758.5 7830.6 7851.5 7885.9 6977.5 7135.8 7196.5 7220.4 7227.2 4883.1 4917.8 4985.2 5013.9 5052.7 5116.4 5172.4 5226.4 5252.5 5294.1 14:30:13 INFO - PID 31158 | 14:30:13 INFO - PID 31158 | [#4] prototype.html Cycles:180 Average:4837.54 Median:5513.99 stddev:1405.44 (25.5%) stddev-sans-first:1368.75 14:30:13 INFO - PID 31158 | Values: 367.0 395.4 399.9 402.7 404.3 5532.1 5540.0 5572.8 5580.3 5601.6 5450.7 5455.5 5479.0 5483.3 5495.8 4141.7 4286.4 4297.6 4314.4 4326.7 4276.6 4298.4 4300.4 4301.1 4301.5 4271.2 4277.3 4287.8 4294.8 4299.6 4223.7 4229.0 4278.8 4282.0 4285.2 3844.3 3846.4 3855.1 3862.2 3869.7 5385.4 5402.7 5408.4 5411.5 5428.8 4974.5 5018.8 5047.2 5091.5 5106.3 5790.9 5801.7 5812.8 5830.6 5831.8 4319.7 4341.6 4343.0 4347.1 4382.3 5947.5 6095.1 6110.8 6119.2 6133.3 4470.3 4501.3 4505.7 4507.3 4511.7 4534.2 4549.1 4559.7 4561.2 4569.4 4545.4 4693.6 4720.9 4739.6 4742.6 5748.0 5753.5 5754.7 5758.9 5773.8 1395.1 1405.8 1435.4 1436.2 1438.8 932.8 939.4 949.2 953.3 953.6 5035.7 5064.2 5073.4 5103.7 5104.9 5936.5 6044.5 6065.8 6088.1 6093.6 4955.1 5033.0 5049.1 5050.8 5083.9 3181.6 3188.8 3198.5 3203.5 3223.4 5425.3 5533.7 5567.1 5595.7 5596.7 5994.6 6110.0 6130.7 6155.4 6163.7 5582.5 5584.7 5593.8 5626.9 5630.5 5976.2 6044.0 6045.6 6061.9 6069.4 5720.2 5913.9 5915.9 5934.7 5946.9 5568.5 5586.7 5592.0 5607.9 5611.7 3957.9 4024.2 4029.4 4054.6 4066.8 6022.5 6031.5 6033.5 6055.0 6075.5 5839.2 5839.4 5847.8 5856.5 5885.6 5700.7 5815.0 5820.9 5822.2 5833.1 5720.1 5750.1 5754.9 5772.3 5784.3 5823.3 5845.8 5854.6 5883.0 5921.8 5690.9 5692.5 5712.8 5715.3 5724.6 14:30:13 INFO - PID 31158 | 14:30:13 INFO - PID 31158 | [#5] yui.html Cycles:180 Average:14965.32 Median:18710.34 stddev:18335.48 (98.0%) stddev-sans-first:18355.78 14:30:13 INFO - PID 31158 | Values: 736.0 749.5 760.4 768.0 784.6 12541.9 12665.2 13238.0 13265.0 13303.5 14354.8 14721.7 14762.9 14850.0 14855.0 835.5 863.1 871.4 876.6 878.1 908.3 909.7 911.4 913.0 915.5 945.9 951.5 954.1 954.9 955.4 942.3 949.1 949.9 952.7 953.0 697.0 698.9 699.3 700.6 702.0 14271.1 14370.5 14468.3 14528.4 14737.4 14115.0 14164.2 14499.5 14534.0 14605.6 11023.9 11235.1 11364.8 11369.3 11426.9 2717.6 2718.2 2720.0 2729.8 2749.5 68378.7 70455.6 71561.0 73113.3 73191.0 10820.8 10837.3 10847.2 10897.7 10964.2 17127.9 17695.6 17766.0 21542.6 22230.0 5841.7 5876.7 6278.5 6317.3 6326.1 2893.8 2948.1 2959.5 2963.8 2974.7 3302.9 3360.3 3366.8 3385.1 3396.8 703.2 707.2 708.5 708.8 710.7 606.1 609.8 615.7 616.1 629.8 8998.0 9852.9 9867.4 10074.5 10371.4 600.7 605.8 607.9 610.0 625.9 4349.2 4367.7 4422.1 4459.4 4464.1 62974.4 63059.0 63211.4 63491.0 64736.4 57916.0 58131.4 58264.4 58364.1 58652.0 52710.5 52884.7 52973.7 54198.0 54428.2 8548.0 8861.3 8883.6 8959.5 8962.4 28017.9 28026.6 28170.6 28343.7 29668.4 33159.8 33161.3 33232.2 33883.7 34023.8 11750.9 12018.5 12217.9 12272.8 12385.1 14122.2 14296.9 14776.3 14852.5 15082.3 12892.5 13052.7 13302.8 13489.7 13606.9 13191.9 13668.2 13808.0 13934.6 14103.2 12923.8 13314.9 13329.9 13381.1 13386.9 8690.1 8776.6 9270.9 9715.9 9773.5 10268.2 10390.5 10797.4 10940.3 10964.0 14:30:13 INFO - PID 31158 | -------- Summary: end -------- 14:30:13 INFO - PID 31158 | 14:30:14 INFO - TEST-INFO | 31158: exit 0 14:30:14 INFO - TEST-OK | dromaeo_css | took 1120201ms 14:30:14 INFO - TEST-START | kraken 14:30:14 INFO - operating with platform_type : linux_ 14:30:14 INFO - Initialising browser for kraken test... 14:30:14 INFO - TEST-INFO | started process 31586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwrtB7D/profile http://localhost:49961/getInfo.html) 14:30:19 INFO - PID 31586 | __metrics Screen width/height:1600/1200 14:30:19 INFO - PID 31586 | colorDepth:24 14:30:19 INFO - PID 31586 | Browser inner width/height: 1024/695 14:30:19 INFO - PID 31586 | __metrics 14:30:21 INFO - TEST-INFO | 31586: exit 0 14:30:21 INFO - Browser initialized. 14:30:21 INFO - Running cycle 1/1 for kraken test... 14:30:21 INFO - TEST-INFO | started process 31758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwrtB7D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:33 INFO - PID 31758 | RSS: Main: 160067584 14:30:33 INFO - PID 31758 | 14:30:36 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49961/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:37 INFO - PID 31758 | RSS: Main: 165433344 14:30:37 INFO - PID 31758 | 14:30:39 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49961/tests/kraken/driver.html?testName=audio-dft) 14:30:40 INFO - PID 31758 | RSS: Main: 163860480 14:30:40 INFO - PID 31758 | 14:30:43 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49961/tests/kraken/driver.html?testName=audio-fft) 14:30:43 INFO - PID 31758 | RSS: Main: 160641024 14:30:43 INFO - PID 31758 | 14:30:46 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49961/tests/kraken/driver.html?testName=audio-oscillator) 14:30:46 INFO - PID 31758 | RSS: Main: 161062912 14:30:46 INFO - PID 31758 | 14:30:48 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49961/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:49 INFO - PID 31758 | RSS: Main: 161304576 14:30:49 INFO - PID 31758 | 14:30:52 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49961/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:53 INFO - PID 31758 | RSS: Main: 166952960 14:30:53 INFO - PID 31758 | 14:30:56 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49961/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:57 INFO - PID 31758 | RSS: Main: 164212736 14:30:57 INFO - PID 31758 | 14:31:00 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49961/tests/kraken/driver.html?testName=json-parse-financial) 14:31:00 INFO - PID 31758 | RSS: Main: 165404672 14:31:00 INFO - PID 31758 | 14:31:02 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49961/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:03 INFO - PID 31758 | RSS: Main: 165453824 14:31:03 INFO - PID 31758 | 14:31:04 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49961/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:05 INFO - PID 31758 | RSS: Main: 165265408 14:31:05 INFO - PID 31758 | 14:31:07 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49961/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:08 INFO - PID 31758 | RSS: Main: 165421056 14:31:08 INFO - PID 31758 | 14:31:11 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:11 INFO - PID 31758 | RSS: Main: 165924864 14:31:11 INFO - PID 31758 | 14:31:15 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:15 INFO - PID 31758 | RSS: Main: 166195200 14:31:15 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | Cycle 1(1): loaded http://localhost:49961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49961/tests/kraken/driver.html?testName=ai-astar) 14:31:17 INFO - PID 31758 | RSS: Main: 167415808 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | __start_tp_report 14:31:17 INFO - PID 31758 | _x_x_mozilla_page_load 14:31:17 INFO - PID 31758 | _x_x_mozilla_page_load_details 14:31:17 INFO - PID 31758 | |i|pagename|runs| 14:31:17 INFO - PID 31758 | |0;ai-astar;103;114;112;115;114;111;114;112;111;113 14:31:17 INFO - PID 31758 | |1;audio-beat-detection;156;130;123;170;129;126;124;125;144;125 14:31:17 INFO - PID 31758 | |2;audio-dft;164;166;163;166;167;169;174;164;164;164 14:31:17 INFO - PID 31758 | |3;audio-fft;77;76;75;121;76;77;75;75;96;79 14:31:17 INFO - PID 31758 | |4;audio-oscillator;84;83;106;84;84;83;98;84;83;105 14:31:17 INFO - PID 31758 | |5;imaging-gaussian-blur;114;115;114;115;115;114;114;119;114;113 14:31:17 INFO - PID 31758 | |6;imaging-darkroom;151;150;153;150;151;151;151;151;151;150 14:31:17 INFO - PID 31758 | |7;imaging-desaturate;94;95;94;95;95;95;94;95;96;95 14:31:17 INFO - PID 31758 | |8;json-parse-financial;54;53;53;55;57;54;54;53;54;59 14:31:17 INFO - PID 31758 | |9;json-stringify-tinderbox;57;56;56;56;56;57;56;58;55;56 14:31:17 INFO - PID 31758 | |10;stanford-crypto-aes;82;90;82;82;82;83;82;84;81;83 14:31:17 INFO - PID 31758 | |11;stanford-crypto-ccm;149;132;133;132;132;140;144;136;186;142 14:31:17 INFO - PID 31758 | |12;stanford-crypto-pbkdf2;192;186;193;193;195;190;188;194;184;193 14:31:17 INFO - PID 31758 | |13;stanford-crypto-sha256-iterative;73;73;76;73;73;72;73;70;70;70 14:31:17 INFO - PID 31758 | __end_tp_report 14:31:17 INFO - PID 31758 | __start_cc_report 14:31:17 INFO - PID 31758 | _x_x_mozilla_cycle_collect,815 14:31:17 INFO - PID 31758 | __end_cc_report 14:31:17 INFO - PID 31758 | __startTimestamp1493847077715__endTimestamp 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | ------- Summary: start ------- 14:31:17 INFO - PID 31758 | Number of tests: 14 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:3.41 (3.0%) stddev-sans-first:1.45 14:31:17 INFO - PID 31758 | Values: 103.0 114.0 112.0 115.0 114.0 111.0 114.0 112.0 111.0 113.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:129.50 stddev:16.17 (12.5%) stddev-sans-first:15.30 14:31:17 INFO - PID 31758 | Values: 156.0 130.0 123.0 170.0 129.0 126.0 124.0 125.0 144.0 125.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:3.31 (2.0%) stddev-sans-first:3.43 14:31:17 INFO - PID 31758 | Values: 164.0 166.0 163.0 166.0 167.0 169.0 174.0 164.0 164.0 164.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.50 stddev:14.87 (19.4%) stddev-sans-first:15.63 14:31:17 INFO - PID 31758 | Values: 77.0 76.0 75.0 121.0 76.0 77.0 75.0 75.0 96.0 79.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:84.00 stddev:9.62 (11.4%) stddev-sans-first:10.00 14:31:17 INFO - PID 31758 | Values: 84.0 83.0 106.0 84.0 84.0 83.0 98.0 84.0 83.0 105.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.64 (1.4%) stddev-sans-first:1.72 14:31:17 INFO - PID 31758 | Values: 114.0 115.0 114.0 115.0 115.0 114.0 114.0 119.0 114.0 113.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 14:31:17 INFO - PID 31758 | Values: 151.0 150.0 153.0 150.0 151.0 151.0 151.0 151.0 151.0 150.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 14:31:17 INFO - PID 31758 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:1.96 (3.6%) stddev-sans-first:2.06 14:31:17 INFO - PID 31758 | Values: 54.0 53.0 53.0 55.0 57.0 54.0 54.0 53.0 54.0 59.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 14:31:17 INFO - PID 31758 | Values: 57.0 56.0 56.0 56.0 56.0 57.0 56.0 58.0 55.0 56.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.50 stddev:2.56 (3.1%) stddev-sans-first:2.68 14:31:17 INFO - PID 31758 | Values: 82.0 90.0 82.0 82.0 82.0 83.0 82.0 84.0 81.0 83.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:141.00 stddev:16.35 (11.6%) stddev-sans-first:17.18 14:31:17 INFO - PID 31758 | Values: 149.0 132.0 133.0 132.0 132.0 140.0 144.0 136.0 186.0 142.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.80 Median:193.00 stddev:3.68 (1.9%) stddev-sans-first:3.87 14:31:17 INFO - PID 31758 | Values: 192.0 186.0 193.0 193.0 195.0 190.0 188.0 194.0 184.0 193.0 14:31:17 INFO - PID 31758 | 14:31:17 INFO - PID 31758 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.00 stddev:1.89 (2.6%) stddev-sans-first:1.99 14:31:17 INFO - PID 31758 | Values: 73.0 73.0 76.0 73.0 73.0 72.0 73.0 70.0 70.0 70.0 14:31:17 INFO - PID 31758 | -------- Summary: end -------- 14:31:17 INFO - PID 31758 | 14:31:19 INFO - TEST-INFO | 31758: exit 0 14:31:19 INFO - TEST-OK | kraken | took 64677ms 14:31:19 INFO - SUITE-END | took 1184s 14:31:19 INFO - Completed test suite (00:19:44) 14:31:19 INFO - javascript benchmark 14:31:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6716.984956595872, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2688.475747229291, 2690.166048524957, 2707.269037359913, 2724.60493228482, 2730.6859711133225, 5160.638755287131, 5161.0968080585935, 5186.0, 5196.896062078757, 5242.370915490142, 5242.7640756165965, 5244.0, 5255.0, 5353.7590808413615, 5362.624616276862, 4675.485696573392, 4702.177119004177, 4760.4525479569775, 4788.616910647157, 4794.712317260958, 4817.108834865544, 4825.831095911626, 4828.203346447849, 4832.106060378824, 4847.660663753539, 4629.398178236807, 4689.155951928651, 4708.952910470885, 4765.1660959331975, 4775.761211939389, 4721.457032441244, 4722.386089808338, 4748.71507709535, 4763.166445871959, 4775.928361074587, 4639.164950308943, 4657.231556793159, 4689.085628302482, 4709.199436095838, 4720.976395118037, 5164.535191832715, 5248.501392367719, 5285.68285902847, 5297.867553311198, 5333.786648534093, 5637.126245431924, 5685.545156387479, 5728.5417166626985, 5741.62679425836, 5750.223719797816, 5684.2326285951285, 5726.541876649858, 5730.341010783772, 5732.942670573282, 5739.684317362543, 5226.268322434862, 5325.786968521294, 5332.33345831771, 5340.679559226459, 5390.137577987503, 5854.590178687451, 5856.765729370777, 5878.353381128072, 5903.996320625504, 5959.821205363846, 5604.243427137284, 5616.185653080281, 5658.91511627326, 5665.603407761417, 5670.716464176775, 5627.465390787868, 5667.263255776723, 5714.771324165325, 5724.25584673998, 5779.190913272145, 5676.68778217202, 5679.801206957736, 5680.971595141998, 5681.801136960186, 5694.861027794458, 5468.507834294933, 5556.249906262603, 5563.638363506359, 5661.490465858093, 5674.744636491368, 4700.623950083985, 4732.290156476556, 4744.857654270378, 4749.1926372516755, 4786.928196077061, 4071.633552980187, 4072.6538244249573, 4080.877758616345, 4097.426360309559, 4113.25961326964, 4808.110499557593, 4869.415670119608, 4870.025994801054, 4881.170201065827, 4916.606671466274, 5660.122680984454, 5665.688387138747, 5717.028105222123, 5729.684867332337, 5732.455416735404, 4789.832355867528, 4820.325154478376, 4824.8793780155775, 4826.927596086061, 4830.154722923475, 5043.747812609355, 5051.494850514992, 5054.342935418372, 5060.84817455477, 5061.139606266944, 5294.708791016531, 5296.496832800878, 5298.364196296315, 5307.734613269398, 5311.867203319871, 5646.322441307069, 5702.942970570407, 5707.6575405475805, 5708.457696518824, 5708.571857110816, 5253.448387919213, 5264.368275806928, 5298.523132918056, 5316.468353164652, 5352.1971704243115, 5626.5780066496, 5648.943510564842, 5657.264555607745, 5673.347565030074, 5679.659220446786, 5663.716814159358, 5759.625624334405, 5767.538596912321, 5772.9711351442975, 5778.942210578009, 5529.336479622471, 5543.667379957215, 5608.747606357642, 5610.102383618601, 5629.437056294338, 5581.804636837691, 5613.691246981455, 5618.971905140448, 5621.044422448112, 5633.0, 5448.83653490396, 5547.389787123332, 5553.944460555343, 5555.2222688822785, 5604.551635869202, 5471.589630777628, 5527.198556209408, 5540.695261760642, 5616.8876622466505, 5622.269105016322, 5494.532964698045, 5495.313085864267, 5500.779968801363, 5507.394186639386, 5532.806351777668], "value": 5172.429350604154, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.9595726277792, 661.738613247767, 683.6035099642206, 1149.9080073594107, 1185.0874826383679, 34757.0, 35612.10969725758, 35647.4652880207, 35707.2858542829, 35749.46375804359, 32862.34275314492, 33319.0, 33334.0, 33370.49944250838, 33455.498167527505, 6501.4798816094835, 6625.635590042546, 6896.069030680869, 7098.148222213342, 7107.85784284314, 6987.161540615133, 7043.190033146177, 7071.010058591775, 7079.150501939775, 7094.11323584552, 7014.403775679073, 7091.5390499617615, 7095.85808283834, 7135.607541585211, 7147.249538798429, 7072.115985501812, 7079.362857342864, 7100.360967512948, 7107.538010029331, 7108.39578635814, 6947.340002699735, 6972.51192416531, 6994.510384273103, 6995.755148569776, 7012.088428504313, 32470.675293247237, 32734.0, 32814.83592582046, 32955.6704432955, 33022.0, 3014.608100946885, 3039.741621962136, 3048.253177971389, 3058.0520038788045, 3059.9541006884915, 24905.0, 24950.12674556382, 25074.24777256667, 25108.0, 25129.24612261635, 3146.465100932847, 3148.323110531224, 3155.2742869139997, 3170.239142605781, 3188.2029492626843, 139537.99999999898, 139656.30171849075, 140094.0, 153756.0, 158298.99999999884, 40026.79986600106, 40253.39619905704, 40291.395629065584, 40426.0, 40475.0, 41210.38184427236, 41572.0, 41717.165656687306, 45030.0, 46115.0, 11886.16796824214, 11972.820407693891, 12029.639110826689, 12038.0, 12077.214981026382, 9354.579043943038, 9373.953130234306, 9412.388194767318, 9420.293477989042, 9460.195883349854, 12984.805227921588, 13013.47946082165, 13023.47906083746, 13144.474221031243, 13200.537981170613, 5367.221752845816, 5460.945390546044, 5574.470425309589, 5583.469570390806, 5628.409017053233, 878.9956050219708, 906.9727908162765, 918.7886786039248, 922.5663937949154, 926.8239034583543, 21739.782602173775, 21858.453538661342, 22011.33965981023, 22068.889655551942, 22098.0, 980.568549838069, 991.6578780320777, 1012.4229189361993, 1020.454057079459, 1023.5496381592076, 11242.887571124347, 11535.0, 11600.709982250512, 11628.94185529084, 11662.650120496399, 173745.0, 175059.0, 175688.0, 175894.0, 176820.0, 40817.0, 41268.0, 41282.58717412847, 41361.79319103385, 41473.79263103665, 1208.4018410886667, 1238.207547169812, 1242.7514497100617, 1243.0801207106856, 1253.0727261826182, 19828.801711983273, 20712.792872071688, 21687.45781355479, 23963.52072958496, 25357.19087862198, 37501.81249093737, 39170.608293916695, 39219.60780392159, 39344.60655393409, 39395.40906886342, 157478.0, 157537.0, 158334.0, 158436.0, 158484.0, 29650.479709224957, 29694.0, 29781.10656680303, 29956.850215748782, 30133.09600711982, 36175.81912090423, 36192.63807361998, 36343.63656363403, 36563.63436365602, 36666.45000325051, 27960.30099247535, 28260.71739282663, 28460.288492787848, 28487.28781780472, 29517.262068447602, 26992.865035674695, 27558.311042224104, 27608.447831043668, 27940.25015747287, 28703.282417939718, 31307.686923130477, 31311.0, 31352.216194594406, 31440.528392074593, 31475.213119671276, 26989.59515607307, 28514.14457566276, 28545.571816422354, 28619.713802861705, 29722.851385743797, 22321.553568928855, 22631.773682262967, 23262.883685581462, 23295.534089317778, 23453.296401107993], "value": 14824.173540932572, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.4930083899322, 428.05495300072306, 430.48771961365975, 434.7587089165513, 442.14224404654965, 17309.740353894686, 17338.653226935454, 17919.64160716785, 18024.098795060243, 18093.27626894926, 18029.81970180301, 18276.725849112274, 18546.0, 18583.0, 18599.070046497654, 5428.158635411518, 5498.872731090117, 5582.637128586649, 5598.692071936042, 5651.32184137902, 5508.173773933902, 5577.972110139443, 5596.160575913605, 5596.748146333404, 5613.522850557708, 5251.737413129347, 5476.507114359707, 5489.6980666063355, 5494.1758736189695, 5519.199716041192, 5441.5102640762525, 5443.455654434564, 5467.17992301158, 5467.972660136694, 5469.0, 4961.677490963112, 4968.826091086795, 4976.104301225778, 4983.626228032912, 5000.89998200034, 22167.44581385462, 22304.219352322754, 22599.20902768395, 22759.0, 22852.77147228523, 1565.92953317101, 1593.784839046737, 1603.286537490817, 1603.847634474723, 1607.2365626327519, 14806.925965370105, 14905.776413353808, 15243.314050867737, 15457.922710386376, 15475.535733928, 2042.1116814185878, 2114.756802967663, 2147.4953385954286, 2147.871127732341, 2150.397888591197, 78613.0, 85383.77395621529, 87498.5625071877, 93915.53042234814, 99481.50259248658, 10715.732106697395, 11264.94367528157, 11275.210735248455, 11375.089992800557, 11538.711532211593, 15786.447474338343, 15789.763153552705, 15816.209189540477, 15819.0, 15841.762373564407, 7418.703251869865, 7518.511296765692, 7679.884801727979, 7837.412194085467, 7844.921550784419, 6727.091842601186, 6921.48088893335, 6938.167419909643, 7127.002219689248, 7165.928340716526, 6805.353491418307, 6831.69257383419, 6841.350071743176, 6855.6572171391235, 7006.334398232159, 2015.1637070615823, 2039.4901274681329, 2046.815786579215, 2064.7728749837506, 2138.978610213909, 856.2379482260793, 889.7775556110972, 894.821035792844, 895.5253715530779, 916.7387294621001, 17091.97448153115, 17335.0, 17762.91118544425, 17810.5547361317, 18023.639527209383, 884.1556313720511, 890.7951171230524, 897.1611543206992, 908.4640062363105, 915.839728047589, 9233.0, 9541.570629321697, 9748.0, 9851.50742462874, 9960.302778805413, 348506.0, 350577.0, 354569.3027996927, 360400.0, 366491.0, 64702.352976470575, 73039.26960730324, 74601.25398745944, 75024.0, 75664.62167689126, 1056.8414737789394, 1058.090042563395, 1096.8793432722393, 1100.1913593508764, 1108.0304733358312, 17109.914450427666, 17396.652066958843, 17417.651646967242, 17985.640287194445, 18458.26166953307, 37142.0, 38342.0, 38560.80719596384, 38942.221155577296, 39373.80313098416, 46243.306350405444, 46305.768471157426, 46523.0, 46933.530664694284, 48854.0, 8130.75607731769, 8199.877001845096, 8372.41393102477, 8463.407561470884, 8525.848483492546, 13509.324533773075, 13653.79519307231, 13766.518171863936, 13789.931050345085, 13937.790933135808, 11036.172287078341, 11217.49521271561, 11439.370834604177, 11477.82783258235, 11784.077963555417, 10041.748956276151, 10784.838227426751, 10986.945065274622, 11139.275947063416, 11246.100311974858, 10762.3542587445, 11215.43922803873, 11640.767184656428, 11744.471498782405, 11797.469113889723, 8578.4424012439, 8687.348448866234, 8818.382713210014, 8937.195652391316, 8960.596773145355, 11159.55361785552, 11311.683508750873, 11551.075913927034, 11562.653120406401, 11614.825777613512], "value": 8941.61587749248, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.9501219951203, 1302.4269321498539, 1317.6771690935723, 1320.6830360713432, 1328.1698938163645, 9723.562439690213, 10198.235132365066, 10202.030807073326, 10207.540660670269, 10443.321184123046, 9639.180669643089, 9702.660406885743, 9730.513474326273, 9769.951150244256, 9784.559694813732, 2208.282308249821, 2267.047839907243, 2268.2514770125817, 2275.180934863448, 2275.374272075176, 1981.821636052755, 2028.1177687705895, 2031.6343058249508, 2035.2469586253108, 2037.2258541754186, 2154.622940985329, 2157.546915147821, 2191.5835991161707, 2200.1309482754305, 2202.6916231727573, 2162.2107930605293, 2196.5057861981086, 2198.934031979027, 2199.626063569197, 2201.273579718689, 2053.1787285085934, 2141.453929248047, 2175.3908905506482, 2201.4496375906024, 2203.5262418580082, 10092.142167915736, 10123.89876101237, 10166.034226748521, 10182.439965801952, 10191.490425478696, 5504.889902201933, 5746.741396637161, 5751.482366586985, 5751.971240143773, 5753.280839895013, 3348.28011977426, 3473.478978153272, 3489.319582681378, 3525.894223173309, 3528.7177025837873, 1100.7963526747578, 1148.104478506766, 1148.2478976270556, 1153.6366044695894, 1156.0347110163025, 15165.0, 15182.924085379613, 15255.466058687893, 15277.770833437507, 15329.923350383177, 4655.74393408359, 4909.140900342426, 5018.548330650259, 5030.647854650212, 5046.39443266803, 10905.291156074829, 10909.509072091774, 10929.945350273198, 10933.617323393642, 10951.397673128055, 5543.445655434424, 5575.69333686643, 5578.358488773762, 5581.944180558143, 5598.10430331145, 5042.344495215599, 5131.61512886535, 5180.093483640348, 5187.584993200535, 5219.582433405319, 3676.5955744868043, 3842.423636454554, 3870.322693528621, 3902.9219415612097, 3955.861544845974, 1091.748897753521, 1102.7573933734566, 1106.6292791914639, 1118.3625333559955, 1120.0423637789736, 687.5977553131374, 710.3535782438059, 710.8720430322592, 725.9564426134343, 729.4492658043143, 5313.601479889024, 5402.270693456412, 5403.513683768401, 5421.105517589633, 5515.586331025189, 541.5910987204635, 558.2742434834698, 558.541995563642, 558.8323502949099, 567.9886402272014, 3581.3374525712825, 3665.2669466106886, 3678.301122786662, 3722.553293604785, 3791.9431208531896, 13090.410931508104, 13525.59423217305, 13562.254076025716, 13586.660333491543, 13659.0, 13004.674883127998, 13333.066685332127, 13338.199708017355, 13339.866601333862, 13366.131201471873, 7473.065866766654, 7675.078990521173, 7703.345215656732, 7788.8052798679355, 7811.609419529001, 5398.676079435247, 5433.673979561239, 5594.496495315441, 5665.49010589049, 5811.041178205549, 10679.0, 10718.0, 10748.0, 10792.62225822124, 10884.401357925073, 11079.446027698421, 11099.611513596985, 11117.888821111685, 11207.831882521605, 11338.886611133783, 6876.587404755731, 7046.401055910305, 7055.047568578177, 7077.7168913242895, 7095.609741464269, 8925.642974280956, 9024.819503610022, 9050.728478145666, 9053.68312109073, 9070.047644997445, 7629.694812207449, 7939.166387529226, 7939.960300198462, 8045.0, 8063.0, 7556.131044929683, 7758.456908016385, 7830.608469576385, 7851.489653172525, 7885.881711774213, 6977.546459480118, 7135.750248741477, 7196.532225405541, 7220.38626716735, 7227.241139680258, 4883.096627123993, 4917.754112294442, 4985.152524070844, 5013.874653133555, 5052.747362631927, 5116.360454943132, 5172.431032586337, 5226.398964119023, 5252.501012403815, 5294.12646913255], "value": 4603.75353388534, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.99633003669953, 395.4345286240678, 399.92601368746784, 402.6999885085611, 404.276345341838, 5532.1425179097205, 5539.972300138499, 5572.832815015556, 5580.330360356763, 5601.60788744788, 5450.700211488366, 5455.509004189622, 5479.0, 5483.259759932408, 5495.835124946248, 4141.73078749881, 4286.378475121106, 4297.59172878576, 4314.352847072949, 4326.6538676905775, 4276.636485898703, 4298.376735373369, 4300.3764454154125, 4301.118270754503, 4301.483821941371, 4271.188474189909, 4277.3156294992805, 4287.764172970486, 4294.785260736966, 4299.591538803808, 4223.746575205498, 4229.0, 4278.807453664593, 4281.957180428202, 4285.164392943378, 3844.2888065707934, 3846.442265871433, 3855.055511399725, 3862.1503269280715, 3869.7097717671286, 5385.434529374398, 5402.675839449606, 5408.3509978802795, 5411.512963833274, 5428.809991650312, 4974.477679843637, 5018.80553626998, 5047.16721740916, 5091.541761241506, 5106.310648062501, 5790.884182316372, 5801.723620803416, 5812.796552120698, 5830.56270779689, 5831.825045248649, 4319.740815551077, 4341.565843415665, 4342.956570434287, 4347.0653809430805, 4382.342648602703, 5947.524198064145, 6095.146679464923, 6110.816675499742, 6119.204503414528, 6133.294671112834, 4470.284754439274, 4501.279795232747, 4505.684602077823, 4507.2788353863225, 4511.729296242236, 4534.206513860061, 4549.135664223787, 4559.749213793207, 4561.2245918193985, 4569.360289559464, 4545.431821022372, 4693.5775780179265, 4720.929186062212, 4739.573438390561, 4742.620590352833, 5747.9882041286055, 5753.510951569164, 5754.74103665336, 5758.856028599234, 5773.769049237983, 1395.1489591349268, 1405.8383285922046, 1435.397133204057, 1436.2387934394787, 1438.8417324054237, 932.8320902237663, 939.3893968920256, 949.2168960607527, 953.3326671330096, 953.5994882149514, 5035.723035233097, 5064.1897296433135, 5073.441921388644, 5103.693778373236, 5104.923426148611, 5936.5250779937505, 6044.516438684895, 6065.787697430569, 6088.086786981989, 6093.573449858556, 4955.083309587738, 5032.974835125801, 5049.091163590516, 5050.84847454577, 5083.856132370261, 3181.5545823584716, 3188.8041984255906, 3198.472252078381, 3203.5034569641743, 3223.403670320998, 5425.294711687456, 5533.695646739468, 5567.137093750475, 5595.720213989284, 5596.748146333425, 5994.610350327215, 6109.961306577892, 6130.681903390792, 6155.446009859134, 6163.722632481549, 5582.469665381782, 5584.664920104807, 5593.776248950077, 5626.859328516656, 5630.5214056805635, 5976.193213916065, 6043.969780151071, 6045.6070355426755, 6061.877503721185, 6069.393060693896, 5720.170575266647, 5913.91129133072, 5915.91126133117, 5934.703264836655, 5946.881062378641, 5568.49883510486, 5586.748596313095, 5592.0, 5607.943920560742, 5611.74747136388, 3957.9010524737114, 4024.189114898249, 4029.395590661424, 4054.614811592894, 4066.755994640331, 6022.518198544193, 6031.5476339273855, 6033.456988871023, 6055.0, 6075.453209211192, 5839.211706419579, 5839.35767065614, 5847.795327163699, 5856.472917437281, 5885.558583106199, 5700.686462244616, 5814.970925145347, 5820.894030134261, 5822.214001109796, 5833.066709326487, 5720.141978703228, 5750.137479378127, 5754.884902302014, 5772.307323121252, 5784.2769653793275, 5823.330317013429, 5845.824625261249, 5854.62416332153, 5882.970585147047, 5921.763129474945, 5690.94717477268, 5692.5445964321925, 5712.80005199816, 5715.257016587983, 5724.59747361899], "value": 4398.37992796514, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.9852802943938, 749.4753672429301, 760.3650951455535, 768.0169383189516, 784.5880912520926, 12541.937290313535, 12665.176763510377, 13238.0, 13265.0, 13303.467861285537, 14354.78467822981, 14721.705565888702, 14762.852371476281, 14850.0, 14854.960152789283, 835.482001159282, 863.1282404771164, 871.4117970370006, 876.5967654878764, 878.0736323179044, 908.2552307108141, 909.727081875438, 911.3984770051767, 912.9543522823866, 915.5239275576696, 945.9337846350758, 951.5052172870104, 954.0840792838883, 954.8901876284247, 955.4362925873733, 942.2556180617304, 949.1078386316874, 949.9002604726508, 952.6760901293524, 952.9666461673843, 697.0311267338403, 698.8602279544111, 699.2552931128332, 700.618163101106, 702.0487239790062, 14271.143731376047, 14370.497032603913, 14468.276586170754, 14528.357449102343, 14737.410503579844, 14115.0, 14164.150150990974, 14499.492517761828, 14534.0, 14605.561833145022, 11023.944880275627, 11235.101191904629, 11364.829527557093, 11369.31784092957, 11426.94286528562, 2717.578775289833, 2718.1709578578525, 2720.0, 2729.849858257795, 2749.463854548364, 68378.65810670964, 70455.64772176158, 71561.0, 73113.26886731118, 73190.99999999946, 10820.78358432827, 10837.295575787548, 10847.240693151403, 10897.727556811144, 10964.17768667353, 17127.914360428367, 17695.646087078185, 17766.0, 21542.56914861694, 22230.0, 5841.678707671119, 5876.676782776988, 6278.529110316745, 6317.336679648571, 6326.051092336186, 2893.8119022263486, 2948.1450379390167, 2959.5412711029826, 2963.777716671258, 2974.6579143398353, 3302.9174270643425, 3360.2943381890077, 3366.7811592246426, 3385.136790118504, 3396.847141878621, 703.2124021096405, 707.1620130145793, 708.5288283291553, 708.8369674974682, 710.7476845719798, 606.1332294818452, 609.762192744821, 615.6860001399318, 616.140484024783, 629.8425393651587, 8997.955010224907, 9852.901470985198, 9867.358621689567, 10074.546645400975, 10371.429571373646, 600.6756351570191, 605.8273392083236, 607.908813677943, 609.9969500152471, 625.8685676007998, 4349.151915376535, 4367.650587952956, 4422.115576884636, 4459.44256967879, 4464.129494748493, 62974.37025629777, 63059.0, 63211.36788632055, 63491.0, 64736.352636473035, 57916.0, 58131.41868581345, 58264.41735582675, 58364.12453813196, 58652.0, 52710.472895270555, 52884.73557632187, 52973.735131324866, 54198.0, 54428.183577246375, 8548.0, 8861.33539984491, 8883.644654213758, 8959.507227102571, 8962.372633915564, 28017.859910701132, 28026.579601305588, 28170.577441338806, 28343.716562834106, 29668.406631867674, 33159.83420082884, 33161.336773263916, 33232.1691957703, 33883.66116338805, 34023.82988085044, 11750.882491174978, 12018.519259229533, 12217.877821221675, 12272.81590776157, 12385.071119665881, 14122.152670839372, 14296.928515357356, 14776.33506492189, 14852.480163194236, 15082.321295541507, 12892.548760793326, 13052.738945221232, 13302.800457992944, 13489.730205395641, 13606.86393136056, 13191.868081319064, 13668.24824634615, 13808.0, 13934.58196254114, 14103.224322662352, 12923.806142907675, 13314.93342533281, 13329.933350333185, 13381.130226535244, 13386.933065334611, 8690.087540808125, 8776.605052772513, 9270.907290927275, 9715.9028409715, 9773.462459564793, 10268.178545716473, 10390.480475976019, 10797.406142661916, 10940.288881222696, 10964.0], "value": 6614.968339454921, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 115.0, 114.0, 111.0, 114.0, 112.0, 111.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 123.0, 170.0, 129.0, 126.0, 124.0, 125.0, 144.0, 125.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 163.0, 166.0, 167.0, 169.0, 174.0, 164.0, 164.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 121.0, 76.0, 77.0, 75.0, 75.0, 96.0, 79.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 106.0, 84.0, 84.0, 83.0, 98.0, 84.0, 83.0, 105.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 119.0, 114.0, 113.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 153.0, 150.0, 151.0, 151.0, 151.0, 151.0, 151.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 55.0, 57.0, 54.0, 54.0, 53.0, 54.0, 59.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 58.0, 55.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 90.0, 82.0, 82.0, 82.0, 83.0, 82.0, 84.0, 81.0, 83.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 133.0, 132.0, 132.0, 140.0, 144.0, 136.0, 186.0, 142.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 186.0, 193.0, 193.0, 195.0, 190.0, 188.0, 194.0, 184.0, 193.0], "value": 190.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 76.0, 73.0, 73.0, 72.0, 73.0, 70.0, 70.0, 70.0], "value": 72.3, "unit": "score"}]}]} 14:31:19 INFO - Return code: 0 14:31:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:19 INFO - # TBPL SUCCESS # 14:31:19 INFO - Running post-action listener: _resource_record_post_action 14:31:19 INFO - [mozharness: 2017-05-03 21:31:19.521635Z] Finished run-tests step (success) 14:31:19 INFO - Running post-run listener: _resource_record_post_run 14:31:19 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 364429312; Read time: 0; Write time: 298404 14:31:19 INFO - TinderboxPrint: CPU usage
13.3% 14:31:19 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:31:19 INFO - TinderboxPrint: I/O write bytes / time
364,429,312 / 298,404 14:31:19 INFO - TinderboxPrint: CPU idle
8,304.3 (86.7%) 14:31:19 INFO - TinderboxPrint: CPU user
1,214.9 (12.7%) 14:31:19 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:19 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 22487040; Read time: 0; Write time: 8264 14:31:19 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 247156736; Read time: 0; Write time: 179300 14:31:20 INFO - Running post-run listener: _upload_blobber_files 14:31:20 INFO - Blob upload gear active. 14:31:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:20 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 14:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:31:20 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:31:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:21 INFO - (blobuploader) - INFO - Done attempting. 14:31:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:24 INFO - (blobuploader) - INFO - Done attempting. 14:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:25 INFO - (blobuploader) - INFO - Done attempting. 14:31:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:31:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:26 INFO - (blobuploader) - INFO - Done attempting. 14:31:26 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:26 INFO - Return code: 0 14:31:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15e7740621bf167f1f094dc4bee543fdebfd500e5a4bb4da4a0ed719691404eaa6ad17585dd539182cd44272f6e5dda782d31c1eff0cf6c8f79c9baadf21e265", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa4f2a8928c9e7a4bb930f74df6a9526b5d8cbe7d3faaea0e86ad461aa0289112b4e8fb00fdf5e044393c6fb7f89cf17bba06def78a8284b499e6221f3462584", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e25a43be570216d97c62c8665f1688cb7008000c9a5eb0e13bf947786c5b609b99feed4853612ff3bedac38d9f469890d00c666962eb6ee4580fa62c9cbc159", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd432c502d4fe18bea653801d42a32e9b573d4afef05ffc6307c796b2a9307207394e7735811be98703fa3ceb21b2fe5917af0175614ab186d393be9b3253417"} 14:31:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:26 INFO - Contents: 14:31:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15e7740621bf167f1f094dc4bee543fdebfd500e5a4bb4da4a0ed719691404eaa6ad17585dd539182cd44272f6e5dda782d31c1eff0cf6c8f79c9baadf21e265", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa4f2a8928c9e7a4bb930f74df6a9526b5d8cbe7d3faaea0e86ad461aa0289112b4e8fb00fdf5e044393c6fb7f89cf17bba06def78a8284b499e6221f3462584", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e25a43be570216d97c62c8665f1688cb7008000c9a5eb0e13bf947786c5b609b99feed4853612ff3bedac38d9f469890d00c666962eb6ee4580fa62c9cbc159", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd432c502d4fe18bea653801d42a32e9b573d4afef05ffc6307c796b2a9307207394e7735811be98703fa3ceb21b2fe5917af0175614ab186d393be9b3253417"} 14:31:26 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:26 INFO - Copying logs to upload dir... 14:31:26 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.456215 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-03 14:31:26.172887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 14:31:26.179189) ========= 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=4300f881736b422476174874000001bc-1493845831.145161-1757739917 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-Non-PGO/sha512/15e7740621bf167f1f094dc4bee543fdebfd500e5a4bb4da4a0ed719691404eaa6ad17585dd539182cd44272f6e5dda782d31c1eff0cf6c8f79c9baadf21e265", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa4f2a8928c9e7a4bb930f74df6a9526b5d8cbe7d3faaea0e86ad461aa0289112b4e8fb00fdf5e044393c6fb7f89cf17bba06def78a8284b499e6221f3462584", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e25a43be570216d97c62c8665f1688cb7008000c9a5eb0e13bf947786c5b609b99feed4853612ff3bedac38d9f469890d00c666962eb6ee4580fa62c9cbc159", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd432c502d4fe18bea653801d42a32e9b573d4afef05ffc6307c796b2a9307207394e7735811be98703fa3ceb21b2fe5917af0175614ab186d393be9b3253417"} build_url:https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/TvuxwbEGQQy1e81Ga9u2Lg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15e7740621bf167f1f094dc4bee543fdebfd500e5a4bb4da4a0ed719691404eaa6ad17585dd539182cd44272f6e5dda782d31c1eff0cf6c8f79c9baadf21e265", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa4f2a8928c9e7a4bb930f74df6a9526b5d8cbe7d3faaea0e86ad461aa0289112b4e8fb00fdf5e044393c6fb7f89cf17bba06def78a8284b499e6221f3462584", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e25a43be570216d97c62c8665f1688cb7008000c9a5eb0e13bf947786c5b609b99feed4853612ff3bedac38d9f469890d00c666962eb6ee4580fa62c9cbc159", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd432c502d4fe18bea653801d42a32e9b573d4afef05ffc6307c796b2a9307207394e7735811be98703fa3ceb21b2fe5917af0175614ab186d393be9b3253417"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 14:31:26.206475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:31:26.206789) ========= 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=4300f881736b422476174874000001bc-1493845831.145161-1757739917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:31:26.290573) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 14:31:26.292911) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 14:31:26.293205) ========= ========= Total master_lag: 0.35 =========