builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1493993336.14 results: success (0) revision: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:56.140319) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:56.140799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:56.141069) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:56.155594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:56.155860) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 07:08:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-05-05 07:08:56 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127291 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:56.300443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:56.300811) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017444 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:56.350128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:56.353515) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 --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 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 --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=9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 07:08:56,986 truncating revision to first 12 chars 2017-05-05 07:08:56,986 Setting DEBUG logging. 2017-05-05 07:08:56,986 attempt 1/10 2017-05-05 07:08:56,986 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8872ad4d52b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 07:08:57,572 unpacking tar archive at: mozilla-central-8872ad4d52b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.845212 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:57.212104) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:57.215443) ========= script_repo_revision: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:57.215820) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:57.216081) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 07:08:57.226477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-05-05 07:08:57.226747) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:57 INFO - MultiFileLogger online at 20170505 07:08:57 in /builds/slave/test 07:08:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:08:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:57 INFO - {'append_to_log': False, 07:08:57 INFO - 'base_work_dir': '/builds/slave/test', 07:08:57 INFO - 'blob_upload_branch': 'Firefox', 07:08:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:57 INFO - 'branch': 'Firefox', 07:08:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:57 INFO - 'config_files': ('talos/linux_config.py',), 07:08:57 INFO - 'default_actions': ('clobber', 07:08:57 INFO - 'read-buildbot-config', 07:08:57 INFO - 'download-and-extract', 07:08:57 INFO - 'populate-webroot', 07:08:57 INFO - 'create-virtualenv', 07:08:57 INFO - 'install', 07:08:57 INFO - 'run-tests'), 07:08:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:57 INFO - 'download_minidump_stackwalk': True, 07:08:57 INFO - 'download_symbols': 'ondemand', 07:08:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:57 INFO - 'gecko_profile': False, 07:08:57 INFO - 'gecko_profile_interval': 0, 07:08:57 INFO - 'installer_path': 'installer.exe', 07:08:57 INFO - 'log_level': 'info', 07:08:57 INFO - 'log_name': 'talos', 07:08:57 INFO - 'log_to_console': True, 07:08:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:57 INFO - 'opt_config_files': (), 07:08:57 INFO - 'pip_index': False, 07:08:57 INFO - 'suite': 'dromaeojs-e10s', 07:08:57 INFO - 'system_bits': '32', 07:08:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:57 INFO - 'title': 'talos-linux64-ix-013', 07:08:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:57 INFO - 'use_talos_json': True, 07:08:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:57 INFO - 'work_dir': 'build'} 07:08:57 INFO - [mozharness: 2017-05-05 14:08:57.961092Z] Running clobber step. 07:08:57 INFO - Running pre-action listener: _resource_record_pre_action 07:08:57 INFO - Running main action method: clobber 07:08:57 INFO - rmtree: /builds/slave/test/build 07:08:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:58 INFO - Running post-action listener: _resource_record_post_action 07:08:58 INFO - [mozharness: 2017-05-05 14:08:58.897424Z] Finished clobber step (success) 07:08:58 INFO - [mozharness: 2017-05-05 14:08:58.897523Z] Running read-buildbot-config step. 07:08:58 INFO - Running pre-action listener: _resource_record_pre_action 07:08:58 INFO - Running main action method: read_buildbot_config 07:08:58 INFO - Using buildbot properties: 07:08:58 INFO - { 07:08:58 INFO - "project": "", 07:08:58 INFO - "product": "firefox", 07:08:58 INFO - "who": "cbook@mozilla.com", 07:08:58 INFO - "installer_path": "public/build/target.tar.bz2", 07:08:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:08:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:08:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:08:58 INFO - "stage_platform": "linux64-pgo", 07:08:58 INFO - "basedir": "/builds/slave/test", 07:08:58 INFO - "buildnumber": 195, 07:08:58 INFO - "platform": "ubuntu64_hw", 07:08:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:08:58 INFO - "slavebuilddir": "test", 07:08:58 INFO - "taskId": "WgubR9meSGmv-WC1KujC1A", 07:08:58 INFO - "branch": "mozilla-central", 07:08:58 INFO - "script_repo_revision": "production", 07:08:58 INFO - "revision": "8872ad4d52b6b517dc9d2a9f62c5c75ceda18790", 07:08:58 INFO - "slavename": "talos-linux64-ix-013", 07:08:58 INFO - "repo_path": "mozilla-central" 07:08:58 INFO - } 07:08:58 INFO - Finding installer, test and symbols from parent task. 07:08:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgubR9meSGmv-WC1KujC1A'}, attempt #1 07:08:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgubR9meSGmv-WC1KujC1A'}, attempt #1 07:08:59 INFO - Task dependencies: eBanjAKoTzSO6ZvRvgOtZg 07:08:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg'}, attempt #1 07:09:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.tar.bz2 07:09:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/test_packages.json 07:09:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.crashreporter-symbols.zip 07:09:00 INFO - Running post-action listener: _resource_record_post_action 07:09:00 INFO - [mozharness: 2017-05-05 14:09:00.251997Z] Finished read-buildbot-config step (success) 07:09:00 INFO - [mozharness: 2017-05-05 14:09:00.252213Z] Running download-and-extract step. 07:09:00 INFO - Running pre-action listener: _resource_record_pre_action 07:09:00 INFO - Running main action method: download_and_extract 07:09:00 INFO - mkdir: /builds/slave/test/build/tests 07:09: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')]} 07:09:00 INFO - trying https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.test_packages.json 07:09:00 INFO - Downloading https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:09:00 INFO - Downloaded 986 bytes. 07:09:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:09:00 INFO - Using the following test package requirements: 07:09:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:09:00 INFO - u'common': [u'target.common.tests.zip'], 07:09:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:09:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:09:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:09:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:09:00 INFO - u'mozbase': [u'target.common.tests.zip'], 07:09:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:09:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:09:00 INFO - u'web-platform': [u'target.common.tests.zip', 07:09:00 INFO - u'target.web-platform.tests.zip'], 07:09:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:09:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:09:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.common.tests.zip 07:09:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:09:00 INFO - Fetch https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.common.tests.zip into memory 07:09:01 INFO - Content-Length response header: 60560012 07:09:01 INFO - Bytes received: 60560012 07:09:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:09:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.common.tests.zip 07:09:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:09:11 INFO - Fetch https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.common.tests.zip into memory 07:09:12 INFO - Content-Length response header: 60560012 07:09:12 INFO - Bytes received: 60560012 07:09:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.talos.tests.zip 07:09:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:09:23 INFO - Fetch https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.talos.tests.zip into memory 07:09:24 INFO - Content-Length response header: 14408809 07:09:24 INFO - Bytes received: 14408809 07:09:24 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')]} 07:09:24 INFO - trying https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.tar.bz2 07:09:24 INFO - Downloading https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:09:25 INFO - Downloaded 64023225 bytes. 07:09:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.tar.bz2 07:09:25 INFO - mkdir: /builds/slave/test/properties 07:09:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:25 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:25 INFO - Contents: 07:09:25 INFO - build_url:https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.tar.bz2 07:09:25 INFO - Running post-action listener: _resource_record_post_action 07:09:25 INFO - Running post-action listener: set_extra_try_arguments 07:09:25 INFO - [mozharness: 2017-05-05 14:09:25.597274Z] Finished download-and-extract step (success) 07:09:25 INFO - [mozharness: 2017-05-05 14:09:25.597371Z] Running populate-webroot step. 07:09:25 INFO - Running pre-action listener: _resource_record_pre_action 07:09:25 INFO - Running main action method: populate_webroot 07:09:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:25 INFO - '--tppagecycles', 07:09:25 INFO - '7'], 07:09:25 INFO - 'tests': ['tsvgm']}}, 07:09:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:09:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:09:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:09:25 INFO - 'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:09:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:09:25 INFO - 'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['damp', 'tps']}, 07:09:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:09:25 INFO - 'tests': ['damp', 'tps']}, 07:09:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['dromaeo_dom']}, 07:09:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:09:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:09:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['a11yr', 07:09:25 INFO - 'ts_paint', 07:09:25 INFO - 'tpaint', 07:09:25 INFO - 'sessionrestore', 07:09:25 INFO - 'sessionrestore_no_auto_restore', 07:09:25 INFO - 'tabpaint']}, 07:09:25 INFO - 'other-e10s': {'tests': ['a11yr', 07:09:25 INFO - 'ts_paint', 07:09:25 INFO - 'tpaint', 07:09:25 INFO - 'sessionrestore', 07:09:25 INFO - 'sessionrestore_no_auto_restore', 07:09:25 INFO - 'tabpaint']}, 07:09:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:09:25 INFO - 'ts_paint', 07:09:25 INFO - 'tpaint', 07:09:25 INFO - 'sessionrestore', 07:09:25 INFO - 'sessionrestore_no_auto_restore', 07:09:25 INFO - 'tabpaint']}, 07:09:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:09:25 INFO - 'ts_paint', 07:09:25 INFO - 'tpaint', 07:09:25 INFO - 'sessionrestore', 07:09:25 INFO - 'sessionrestore_no_auto_restore', 07:09:25 INFO - 'tabpaint']}, 07:09:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['a11yr', 07:09:25 INFO - 'ts_paint', 07:09:25 INFO - 'tpaint', 07:09:25 INFO - 'sessionrestore', 07:09:25 INFO - 'sessionrestore_no_auto_restore', 07:09:25 INFO - 'tabpaint']}, 07:09:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['a11yr', 07:09:25 INFO - 'ts_paint', 07:09:25 INFO - 'tpaint', 07:09:25 INFO - 'sessionrestore', 07:09:25 INFO - 'sessionrestore_no_auto_restore', 07:09:25 INFO - 'tabpaint']}, 07:09:25 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:09:25 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:09:25 INFO - 'bloom_basic_ref']}, 07:09:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['tsvgx', 07:09:25 INFO - 'tsvgr_opacity', 07:09:25 INFO - 'tart', 07:09:25 INFO - 'tscrollx', 07:09:25 INFO - 'cart', 07:09:25 INFO - 'tsvg_static']}, 07:09:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:09:25 INFO - 'tsvgr_opacity', 07:09:25 INFO - 'tart', 07:09:25 INFO - 'tscrollx', 07:09:25 INFO - 'cart', 07:09:25 INFO - 'tsvg_static']}, 07:09:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:09:25 INFO - 'talos_options': ['--disable-e10s'], 07:09:25 INFO - 'tests': ['tp5o']}, 07:09:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:09:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:09:25 INFO - 'talos_options': ['--disable-e10s', 07:09:25 INFO - '--xperf_path', 07:09:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:25 INFO - 'tests': ['tp5n']}, 07:09:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:09:25 INFO - 'talos_options': ['--xperf_path', 07:09:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:25 INFO - 'tests': ['tp5n']}}, 07:09:25 INFO - 'talos.zip': {'path': '', 07:09:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:25 INFO - Running post-action listener: _resource_record_post_action 07:09:25 INFO - [mozharness: 2017-05-05 14:09:25.611055Z] Finished populate-webroot step (success) 07:09:25 INFO - [mozharness: 2017-05-05 14:09:25.611144Z] Running create-virtualenv step. 07:09:25 INFO - Running pre-action listener: _resource_record_pre_action 07:09:25 INFO - Running main action method: create_virtualenv 07:09:25 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:25 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 07:09:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:25 INFO - Using real prefix '/usr' 07:09:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:26 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:28 INFO - Installing pip.................done. 07:09:28 INFO - Return code: 0 07:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:09:28 INFO - Reading from file tmpfile_stdout 07:09:28 INFO - Output received: 07:09:28 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) 07:09:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09:28 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')]} 07:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:28 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')]} 07:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:28 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 0x135f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, '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': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', '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 07:09:28 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 07:09:28 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 07:09:28 INFO - Using env: {'DISPLAY': ':0', 07:09:28 INFO - 'HOME': '/home/cltbld', 07:09:28 INFO - 'LANG': 'en_US.UTF-8', 07:09:28 INFO - 'LANGUAGE': 'en_US:en', 07:09:28 INFO - 'LOGNAME': 'cltbld', 07:09:28 INFO - 'MAIL': '/var/mail/cltbld', 07:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:28 INFO - 'MOZ_NO_REMOTE': '1', 07:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:28 INFO - 'NO_EM_RESTART': '1', 07:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:28 INFO - 'PWD': '/builds/slave/test', 07:09:28 INFO - 'SHELL': '/bin/bash', 07:09:28 INFO - 'SHLVL': '1', 07:09:28 INFO - 'TERM': 'linux', 07:09:28 INFO - 'TMOUT': '86400', 07:09:28 INFO - 'USER': 'cltbld', 07:09:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:28 INFO - '_': '/tools/buildbot/bin/python'} 07:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:28 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 07:09:28 INFO - Cleaning up... 07:09:28 INFO - Return code: 0 07:09:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:09:28 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')]} 07:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:28 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')]} 07:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:28 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 0x135f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, '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': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', '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 07:09:28 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 07:09:28 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 07:09:28 INFO - Using env: {'DISPLAY': ':0', 07:09:28 INFO - 'HOME': '/home/cltbld', 07:09:28 INFO - 'LANG': 'en_US.UTF-8', 07:09:28 INFO - 'LANGUAGE': 'en_US:en', 07:09:28 INFO - 'LOGNAME': 'cltbld', 07:09:28 INFO - 'MAIL': '/var/mail/cltbld', 07:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:28 INFO - 'MOZ_NO_REMOTE': '1', 07:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:28 INFO - 'NO_EM_RESTART': '1', 07:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:28 INFO - 'PWD': '/builds/slave/test', 07:09:28 INFO - 'SHELL': '/bin/bash', 07:09:28 INFO - 'SHLVL': '1', 07:09:28 INFO - 'TERM': 'linux', 07:09:28 INFO - 'TMOUT': '86400', 07:09:28 INFO - 'USER': 'cltbld', 07:09:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:28 INFO - '_': '/tools/buildbot/bin/python'} 07:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:28 INFO - Downloading/unpacking psutil>=3.1.1 07:09:28 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 07:09:28 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 07:09:28 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 07:09:28 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 07:09:28 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 07:09:28 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 07:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:30 INFO - Installing collected packages: psutil 07:09:30 INFO - Running setup.py install for psutil 07:09:30 INFO - building 'psutil._psutil_linux' extension 07:09:30 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 07:09:30 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 07:09:30 INFO - building 'psutil._psutil_posix' extension 07:09:30 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 07:09:30 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 07:09:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:30 INFO - Successfully installed psutil 07:09:30 INFO - Cleaning up... 07:09:30 INFO - Return code: 0 07:09:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:30 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 0x135f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, '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': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', '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 07:09:30 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 07:09:30 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 07:09:30 INFO - Using env: {'DISPLAY': ':0', 07:09:30 INFO - 'HOME': '/home/cltbld', 07:09:30 INFO - 'LANG': 'en_US.UTF-8', 07:09:30 INFO - 'LANGUAGE': 'en_US:en', 07:09:30 INFO - 'LOGNAME': 'cltbld', 07:09:30 INFO - 'MAIL': '/var/mail/cltbld', 07:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:30 INFO - 'MOZ_NO_REMOTE': '1', 07:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:30 INFO - 'NO_EM_RESTART': '1', 07:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:30 INFO - 'PWD': '/builds/slave/test', 07:09:30 INFO - 'SHELL': '/bin/bash', 07:09:30 INFO - 'SHLVL': '1', 07:09:30 INFO - 'TERM': 'linux', 07:09:30 INFO - 'TMOUT': '86400', 07:09:30 INFO - 'USER': 'cltbld', 07:09:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:30 INFO - '_': '/tools/buildbot/bin/python'} 07:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:09:30 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 07:09:30 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 07:09:30 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 07:09:30 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 07:09:30 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 07:09:30 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 07:09:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:09:32 INFO - Installing collected packages: mozsystemmonitor 07:09:32 INFO - Running setup.py install for mozsystemmonitor 07:09:32 INFO - Successfully installed mozsystemmonitor 07:09:32 INFO - Cleaning up... 07:09:32 INFO - Return code: 0 07:09:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:09:32 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')]} 07:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:32 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')]} 07:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:32 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 0x135f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, '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': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', '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 07:09:32 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 07:09:32 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 07:09:32 INFO - Using env: {'DISPLAY': ':0', 07:09:32 INFO - 'HOME': '/home/cltbld', 07:09:32 INFO - 'LANG': 'en_US.UTF-8', 07:09:32 INFO - 'LANGUAGE': 'en_US:en', 07:09:32 INFO - 'LOGNAME': 'cltbld', 07:09:32 INFO - 'MAIL': '/var/mail/cltbld', 07:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:32 INFO - 'MOZ_NO_REMOTE': '1', 07:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:32 INFO - 'NO_EM_RESTART': '1', 07:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:32 INFO - 'PWD': '/builds/slave/test', 07:09:32 INFO - 'SHELL': '/bin/bash', 07:09:32 INFO - 'SHLVL': '1', 07:09:32 INFO - 'TERM': 'linux', 07:09:32 INFO - 'TMOUT': '86400', 07:09:32 INFO - 'USER': 'cltbld', 07:09:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:32 INFO - '_': '/tools/buildbot/bin/python'} 07:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:32 INFO - Downloading/unpacking jsonschema==2.5.1 07:09:32 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 07:09:32 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 07:09:32 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 07:09:32 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 07:09:32 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 07:09:32 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 07:09:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:09:33 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 07:09:33 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 07:09:33 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 07:09:33 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 07:09:33 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 07:09:33 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 07:09:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:33 INFO - warning: no files found matching '*.txt' 07:09:33 INFO - no previously-included directories found matching 'build' 07:09:33 INFO - no previously-included directories found matching 'dist' 07:09:33 INFO - no previously-included directories found matching '.git*' 07:09:33 INFO - Installing collected packages: jsonschema, functools32 07:09:33 INFO - Running setup.py install for functools32 07:09:33 INFO - warning: no files found matching '*.txt' 07:09:33 INFO - no previously-included directories found matching 'build' 07:09:33 INFO - no previously-included directories found matching 'dist' 07:09:33 INFO - no previously-included directories found matching '.git*' 07:09:33 INFO - Successfully installed jsonschema functools32 07:09:33 INFO - Cleaning up... 07:09:33 INFO - Return code: 0 07:09:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:09:33 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')]} 07:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:33 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')]} 07:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:33 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 0x135f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, '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': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', '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 07:09:33 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 07:09:33 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 07:09:33 INFO - Using env: {'DISPLAY': ':0', 07:09:33 INFO - 'HOME': '/home/cltbld', 07:09:33 INFO - 'LANG': 'en_US.UTF-8', 07:09:33 INFO - 'LANGUAGE': 'en_US:en', 07:09:33 INFO - 'LOGNAME': 'cltbld', 07:09:33 INFO - 'MAIL': '/var/mail/cltbld', 07:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:33 INFO - 'MOZ_NO_REMOTE': '1', 07:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:33 INFO - 'NO_EM_RESTART': '1', 07:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:33 INFO - 'PWD': '/builds/slave/test', 07:09:33 INFO - 'SHELL': '/bin/bash', 07:09:33 INFO - 'SHLVL': '1', 07:09:33 INFO - 'TERM': 'linux', 07:09:33 INFO - 'TMOUT': '86400', 07:09:33 INFO - 'USER': 'cltbld', 07:09:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:33 INFO - '_': '/tools/buildbot/bin/python'} 07:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:09:34 INFO - Cleaning up... 07:09:34 INFO - Return code: 0 07:09:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:34 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 0x135f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, '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': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', '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 07:09:34 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 07:09:34 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 07:09:34 INFO - Using env: {'DISPLAY': ':0', 07:09:34 INFO - 'HOME': '/home/cltbld', 07:09:34 INFO - 'LANG': 'en_US.UTF-8', 07:09:34 INFO - 'LANGUAGE': 'en_US:en', 07:09:34 INFO - 'LOGNAME': 'cltbld', 07:09:34 INFO - 'MAIL': '/var/mail/cltbld', 07:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:34 INFO - 'MOZ_NO_REMOTE': '1', 07:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:34 INFO - 'NO_EM_RESTART': '1', 07:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:34 INFO - 'PWD': '/builds/slave/test', 07:09:34 INFO - 'SHELL': '/bin/bash', 07:09:34 INFO - 'SHLVL': '1', 07:09:34 INFO - 'TERM': 'linux', 07:09:34 INFO - 'TMOUT': '86400', 07:09:34 INFO - 'USER': 'cltbld', 07:09:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:34 INFO - '_': '/tools/buildbot/bin/python'} 07:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:34 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 07:09:34 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 07:09:34 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 07:09:34 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 07:09:34 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 07:09:34 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 07:09:35 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09:35 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 07:09:35 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 07:09:35 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 07:09:35 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 07:09:35 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 07:09:35 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 07:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:35 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 07:09:35 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 07:09:35 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 07:09:35 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 07:09:35 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 07:09:35 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 07:09:35 INFO - Downloading docopt-0.6.1.tar.gz 07:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:35 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:35 INFO - Running setup.py install for blobuploader 07:09:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:36 INFO - Running setup.py install for requests 07:09:36 INFO - Running setup.py install for docopt 07:09:36 INFO - Successfully installed blobuploader requests docopt 07:09:36 INFO - Cleaning up... 07:09:36 INFO - Return code: 0 07:09:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:36 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 0x135f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, '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': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', '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 07:09:36 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 07:09:36 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 07:09:36 INFO - Using env: {'DISPLAY': ':0', 07:09:36 INFO - 'HOME': '/home/cltbld', 07:09:36 INFO - 'LANG': 'en_US.UTF-8', 07:09:36 INFO - 'LANGUAGE': 'en_US:en', 07:09:36 INFO - 'LOGNAME': 'cltbld', 07:09:36 INFO - 'MAIL': '/var/mail/cltbld', 07:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:36 INFO - 'MOZ_NO_REMOTE': '1', 07:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:36 INFO - 'NO_EM_RESTART': '1', 07:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:36 INFO - 'PWD': '/builds/slave/test', 07:09:36 INFO - 'SHELL': '/bin/bash', 07:09:36 INFO - 'SHLVL': '1', 07:09:36 INFO - 'TERM': 'linux', 07:09:36 INFO - 'TMOUT': '86400', 07:09:36 INFO - 'USER': 'cltbld', 07:09:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:36 INFO - '_': '/tools/buildbot/bin/python'} 07:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:36 INFO - Running setup.py (path:/tmp/pip-UOgqFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:36 INFO - Running setup.py (path:/tmp/pip-TTqd8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:36 INFO - Running setup.py (path:/tmp/pip-_TJK4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:37 INFO - Running setup.py (path:/tmp/pip-6bEMN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:37 INFO - Running setup.py (path:/tmp/pip-54sLV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:37 INFO - Running setup.py (path:/tmp/pip-wtdbFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:37 INFO - Running setup.py (path:/tmp/pip-PfEwgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:37 INFO - Running setup.py (path:/tmp/pip-xwNVXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:37 INFO - Running setup.py (path:/tmp/pip-araVZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:37 INFO - Running setup.py (path:/tmp/pip-cPjvKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:37 INFO - Running setup.py (path:/tmp/pip-u7Isn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:37 INFO - Running setup.py (path:/tmp/pip-2fPqi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:37 INFO - Running setup.py (path:/tmp/pip-oCx_yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:37 INFO - Running setup.py (path:/tmp/pip-5jpTIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:37 INFO - Running setup.py (path:/tmp/pip-PnTNs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:37 INFO - Running setup.py (path:/tmp/pip-FRAQTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:37 INFO - Running setup.py (path:/tmp/pip-Wpnbki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:38 INFO - Running setup.py install for manifestparser 07:09:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:38 INFO - Running setup.py install for mozcrash 07:09:38 INFO - Running setup.py install for mozdebug 07:09:38 INFO - Running setup.py install for mozdevice 07:09:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:38 INFO - Running setup.py install for mozfile 07:09:38 INFO - Running setup.py install for mozhttpd 07:09:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:38 INFO - Running setup.py install for mozinfo 07:09:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:38 INFO - Running setup.py install for mozInstall 07:09:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:38 INFO - Running setup.py install for mozleak 07:09:38 INFO - Running setup.py install for mozlog 07:09:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:39 INFO - Running setup.py install for moznetwork 07:09:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:39 INFO - Running setup.py install for mozprocess 07:09:39 INFO - Running setup.py install for mozprofile 07:09:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:39 INFO - Running setup.py install for mozrunner 07:09:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:39 INFO - Running setup.py install for mozscreenshot 07:09:39 INFO - Running setup.py install for moztest 07:09:39 INFO - Running setup.py install for mozversion 07:09:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:39 INFO - Cleaning up... 07:09:39 INFO - Return code: 0 07:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:39 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')]} 07:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:39 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')]} 07:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:39 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 0x135f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, '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': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', '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 07:09:39 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 07:09:39 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 07:09:39 INFO - Using env: {'DISPLAY': ':0', 07:09:39 INFO - 'HOME': '/home/cltbld', 07:09:39 INFO - 'LANG': 'en_US.UTF-8', 07:09:39 INFO - 'LANGUAGE': 'en_US:en', 07:09:39 INFO - 'LOGNAME': 'cltbld', 07:09:39 INFO - 'MAIL': '/var/mail/cltbld', 07:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:39 INFO - 'MOZ_NO_REMOTE': '1', 07:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:39 INFO - 'NO_EM_RESTART': '1', 07:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:39 INFO - 'PWD': '/builds/slave/test', 07:09:39 INFO - 'SHELL': '/bin/bash', 07:09:39 INFO - 'SHLVL': '1', 07:09:39 INFO - 'TERM': 'linux', 07:09:39 INFO - 'TMOUT': '86400', 07:09:39 INFO - 'USER': 'cltbld', 07:09:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:39 INFO - '_': '/tools/buildbot/bin/python'} 07:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:40 INFO - Running setup.py (path:/tmp/pip-fwi36v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:40 INFO - Running setup.py (path:/tmp/pip-e8UDTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:40 INFO - Running setup.py (path:/tmp/pip-vaYHf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:40 INFO - Running setup.py (path:/tmp/pip-WnUpWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:40 INFO - Running setup.py (path:/tmp/pip-YI2YM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:40 INFO - Running setup.py (path:/tmp/pip-BiGZdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:40 INFO - Running setup.py (path:/tmp/pip-CECnNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:40 INFO - Running setup.py (path:/tmp/pip-PtEw7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:40 INFO - Running setup.py (path:/tmp/pip-QboCNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:40 INFO - Running setup.py (path:/tmp/pip-_K34_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:40 INFO - Running setup.py (path:/tmp/pip-0esDGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:40 INFO - Running setup.py (path:/tmp/pip-SQ8x16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:40 INFO - Running setup.py (path:/tmp/pip-_uR6Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:40 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)) 07:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:40 INFO - Running setup.py (path:/tmp/pip-SMs4Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:41 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)) 07:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:41 INFO - Running setup.py (path:/tmp/pip-7ZBjs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:41 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)) 07:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:41 INFO - Running setup.py (path:/tmp/pip-D747CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:41 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)) 07:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:41 INFO - Running setup.py (path:/tmp/pip-T_LAT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:41 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)) 07:09:41 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)) 07:09:41 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)) 07:09:41 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)) 07:09:41 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)) 07:09:41 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)) 07:09:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:41 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 07:09:41 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 07:09:41 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 07:09:41 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 07:09:41 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 07:09:41 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 07:09:42 INFO - Downloading blessings-1.6.tar.gz 07:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:42 INFO - Installing collected packages: blessings 07:09:42 INFO - Running setup.py install for blessings 07:09:42 INFO - Successfully installed blessings 07:09:42 INFO - Cleaning up... 07:09:42 INFO - Return code: 0 07:09:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:42 INFO - Reading from file tmpfile_stdout 07:09:42 INFO - Current package versions: 07:09:42 INFO - argparse == 1.2.1 07:09:42 INFO - blessings == 1.6 07:09:42 INFO - blobuploader == 1.2.4 07:09:42 INFO - docopt == 0.6.1 07:09:42 INFO - functools32 == 3.2.3-2 07:09:42 INFO - jsonschema == 2.5.1 07:09:42 INFO - manifestparser == 1.1 07:09:42 INFO - mozInstall == 1.12 07:09:42 INFO - mozcrash == 1.0 07:09:42 INFO - mozdebug == 0.1 07:09:42 INFO - mozdevice == 0.50 07:09:42 INFO - mozfile == 1.2 07:09:42 INFO - mozhttpd == 0.7 07:09:42 INFO - mozinfo == 0.9 07:09:42 INFO - mozleak == 0.1 07:09:42 INFO - mozlog == 3.4 07:09:42 INFO - moznetwork == 0.27 07:09:42 INFO - mozprocess == 0.25 07:09:42 INFO - mozprofile == 0.28 07:09:42 INFO - mozrunner == 6.13 07:09:42 INFO - mozscreenshot == 0.1 07:09:42 INFO - mozsystemmonitor == 0.3 07:09:42 INFO - moztest == 0.8 07:09:42 INFO - mozversion == 1.4 07:09:42 INFO - psutil == 3.1.1 07:09:42 INFO - requests == 1.2.3 07:09:42 INFO - wsgiref == 0.1.2 07:09:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:42 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')]} 07:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:42 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')]} 07:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:42 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 0x135f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, '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': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', '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 07:09:42 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 07:09:42 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 07:09:42 INFO - Using env: {'DISPLAY': ':0', 07:09:42 INFO - 'HOME': '/home/cltbld', 07:09:42 INFO - 'LANG': 'en_US.UTF-8', 07:09:42 INFO - 'LANGUAGE': 'en_US:en', 07:09:42 INFO - 'LOGNAME': 'cltbld', 07:09:42 INFO - 'MAIL': '/var/mail/cltbld', 07:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:42 INFO - 'MOZ_NO_REMOTE': '1', 07:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:42 INFO - 'NO_EM_RESTART': '1', 07:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:42 INFO - 'PWD': '/builds/slave/test', 07:09:42 INFO - 'SHELL': '/bin/bash', 07:09:42 INFO - 'SHLVL': '1', 07:09:42 INFO - 'TERM': 'linux', 07:09:42 INFO - 'TMOUT': '86400', 07:09:42 INFO - 'USER': 'cltbld', 07:09:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:42 INFO - '_': '/tools/buildbot/bin/python'} 07:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:42 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)) 07:09:42 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)) 07:09:42 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)) 07:09:42 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)) 07:09:42 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)) 07:09:42 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)) 07:09:42 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)) 07:09:42 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)) 07:09:42 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)) 07:09:42 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)) 07:09:42 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)) 07:09:42 INFO - Cleaning up... 07:09:43 INFO - Return code: 0 07:09:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09:43 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')]} 07:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:43 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')]} 07:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:43 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 0x135f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1457a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, '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': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', '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 07:09:43 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 07:09:43 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 07:09:43 INFO - Using env: {'DISPLAY': ':0', 07:09:43 INFO - 'HOME': '/home/cltbld', 07:09:43 INFO - 'LANG': 'en_US.UTF-8', 07:09:43 INFO - 'LANGUAGE': 'en_US:en', 07:09:43 INFO - 'LOGNAME': 'cltbld', 07:09:43 INFO - 'MAIL': '/var/mail/cltbld', 07:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:43 INFO - 'MOZ_NO_REMOTE': '1', 07:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:43 INFO - 'NO_EM_RESTART': '1', 07:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:43 INFO - 'PWD': '/builds/slave/test', 07:09:43 INFO - 'SHELL': '/bin/bash', 07:09:43 INFO - 'SHLVL': '1', 07:09:43 INFO - 'TERM': 'linux', 07:09:43 INFO - 'TMOUT': '86400', 07:09:43 INFO - 'USER': 'cltbld', 07:09:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:43 INFO - '_': '/tools/buildbot/bin/python'} 07:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:09:43 INFO - Cleaning up... 07:09:43 INFO - Return code: 0 07:09:43 INFO - Running post-action listener: _resource_record_post_action 07:09:43 INFO - Running post-action listener: _start_resource_monitoring 07:09:43 INFO - Starting resource monitoring. 07:09:43 INFO - [mozharness: 2017-05-05 14:09:43.261260Z] Finished create-virtualenv step (success) 07:09:43 INFO - [mozharness: 2017-05-05 14:09:43.261789Z] Running install step. 07:09:43 INFO - Running pre-action listener: _resource_record_pre_action 07:09:43 INFO - Running main action method: install 07:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:43 INFO - Reading from file tmpfile_stdout 07:09:43 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:43 INFO - Reading from file tmpfile_stdout 07:09:43 INFO - Output received: 07:09:43 INFO - Usage: mozinstall [options] installer 07:09:43 INFO - Options: 07:09:43 INFO - -h, --help show this help message and exit 07:09:43 INFO - -d DEST, --destination=DEST 07:09:43 INFO - Directory to install application into. [default: 07:09:43 INFO - "/builds/slave/test"] 07:09:43 INFO - --app=APP Application being installed. [default: firefox] 07:09:43 INFO - mkdir: /builds/slave/test/build/application 07:09:43 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'] 07:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:09:59 INFO - Reading from file tmpfile_stdout 07:09:59 INFO - Output received: 07:09:59 INFO - /builds/slave/test/build/application/firefox/firefox 07:09:59 INFO - Running post-action listener: _resource_record_post_action 07:09:59 INFO - [mozharness: 2017-05-05 14:09:59.737814Z] Finished install step (success) 07:09:59 INFO - [mozharness: 2017-05-05 14:09:59.738082Z] Running run-tests step. 07:09:59 INFO - Running pre-action listener: _resource_record_pre_action 07:09:59 INFO - Running main action method: run_tests 07:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:59 INFO - Python 2.7.3 07:09:59 INFO - Return code: 0 07:09:59 INFO - grabbing minidump binary from tooltool 07:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:59 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 0x15fa290>, '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 0x15fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fb040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:59 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 07:09:59 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 07:09:59 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 07:09:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:59 INFO - Return code: 0 07:09:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:09:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:59 INFO - ENV: RUST_BACKTRACE is now 1 07:09:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:09:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 07:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 07:09:59 INFO - Using env: {'DISPLAY': ':0', 07:09:59 INFO - 'HOME': '/home/cltbld', 07:09:59 INFO - 'LANG': 'en_US.UTF-8', 07:09:59 INFO - 'LANGUAGE': 'en_US:en', 07:09:59 INFO - 'LOGNAME': 'cltbld', 07:09:59 INFO - 'MAIL': '/var/mail/cltbld', 07:09:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:59 INFO - 'MOZ_NO_REMOTE': '1', 07:09:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:59 INFO - 'NO_EM_RESTART': '1', 07:09:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:59 INFO - 'PWD': '/builds/slave/test', 07:09:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:59 INFO - 'RUST_BACKTRACE': '1', 07:09:59 INFO - 'SHELL': '/bin/bash', 07:09:59 INFO - 'SHLVL': '1', 07:09:59 INFO - 'TERM': 'linux', 07:09:59 INFO - 'TMOUT': '86400', 07:09:59 INFO - 'USER': 'cltbld', 07:09:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178', 07:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:59 INFO - '_': '/tools/buildbot/bin/python'} 07:09:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 07:10:00 INFO - mozversion application_buildid: 20170505131936 07:10:00 INFO - mozversion application_changeset: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 07:10:00 INFO - mozversion application_display_name: Nightly 07:10:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:00 INFO - mozversion application_name: Firefox 07:10:00 INFO - mozversion application_remotingname: firefox 07:10:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:10:00 INFO - mozversion application_vendor: Mozilla 07:10:00 INFO - mozversion application_version: 55.0a1 07:10:00 INFO - mozversion platform_buildid: 20170505131936 07:10:00 INFO - mozversion platform_changeset: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 07:10:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:10:00 INFO - mozversion platform_version: 55.0a1 07:10:00 INFO - using testdate: 1493993400 07:10:00 INFO - actual date: 1493993400 07:10:00 INFO - starting webserver on 'localhost:55823' 07:10:00 INFO - SUITE-START | Running 2 tests 07:10:00 INFO - TEST-START | dromaeo_css 07:10:00 INFO - operating with platform_type : linux_ 07:10:00 INFO - Initialising browser for dromaeo_css test... 07:10:00 INFO - TEST-INFO | started process 32079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRJZdnK/profile http://localhost:55823/getInfo.html) 07:10:04 INFO - PID 32079 | __metrics Screen width/height:1600/1200 07:10:04 INFO - PID 32079 | colorDepth:24 07:10:04 INFO - PID 32079 | Browser inner width/height: 1024/695 07:10:04 INFO - PID 32079 | __metrics 07:10:06 INFO - TEST-INFO | 32079: exit 0 07:10:06 INFO - Browser initialized. 07:10:06 INFO - Running cycle 1/1 for dromaeo_css test... 07:10:06 INFO - TEST-INFO | started process 32250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRJZdnK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:18 INFO - PID 32250 | RSS: Main: 156254208 07:10:18 INFO - PID 32250 | 07:13:19 INFO - PID 32250 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55823/tests/dromaeo/cssquery-ext.html) 07:13:20 INFO - PID 32250 | RSS: Main: 161017856 07:13:20 INFO - PID 32250 | 07:16:22 INFO - PID 32250 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-ext.html (next: http://localhost:55823/tests/dromaeo/cssquery-jquery.html) 07:16:23 INFO - PID 32250 | RSS: Main: 156147712 07:16:23 INFO - PID 32250 | 07:19:24 INFO - PID 32250 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55823/tests/dromaeo/cssquery-mootools.html) 07:19:25 INFO - PID 32250 | RSS: Main: 164945920 07:19:25 INFO - PID 32250 | 07:22:27 INFO - PID 32250 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55823/tests/dromaeo/cssquery-prototype.html) 07:22:27 INFO - PID 32250 | RSS: Main: 156864512 07:22:27 INFO - PID 32250 | 07:25:30 INFO - PID 32250 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55823/tests/dromaeo/cssquery-yui.html) 07:25:30 INFO - PID 32250 | RSS: Main: 160972800 07:25:30 INFO - PID 32250 | 07:28:32 INFO - PID 32250 | Cycle 1(1): loaded http://localhost:55823/tests/dromaeo/cssquery-yui.html (next: http://localhost:55823/tests/dromaeo/cssquery-dojo.html) 07:28:32 INFO - PID 32250 | RSS: Main: 162402304 07:28:32 INFO - PID 32250 | 07:28:32 INFO - PID 32250 | __start_tp_report 07:28:32 INFO - PID 32250 | _x_x_mozilla_page_load 07:28:32 INFO - PID 32250 | _x_x_mozilla_page_load_details 07:28:32 INFO - PID 32250 | |i|pagename|runs| 07:28:32 INFO - PID 32250 | |0;dojo.html;3325.401427743006;3355.530225768391;3377.9831100844494;3397.1507123219194;3410.976706987903;5772.855678608037;5870.882582348356;5871.207387002753;5938.732757025933;5948.910766338508;5904.996150654389;5921.082232254007;5928.288605367351;6003.609765365248;6022.939770602293;5243.711595862226;5262;5285.339332583408;5297.761600727977;5305.867353316159;5324.068288049576;5391.541718953894;5391.56867450603;5393.029254734146;5416.241726158341;5260.526552610283;5310.9734451327495;5338;5339.22581225722;5342.626016178869;5297.708626025567;5305.204219367087;5309.256704061435;5316.255724198615;5335.893282134374;5289.814856480005;5294.57643388528;5302.098643230622;5307.867303317409;5316.202569614588;5774.335951365605;5782.797602083949;5796.304443466811;5831.979403604352;5840;6442.967785161091;6451.516136289797;6453.612783233021;6468.870622587522;6471.255805582371;6467.450266727334;6480.351964803529;6484.578502397329;6490.448311893495;6499.317571655003;5869.325027621793;5909.054551271776;5941.643501389931;5999.1901093351835;6030.276366835964;6561.40947314744;6594.604323740591;6598.8350291243105;6599.835004124935;6608.041833934149;6119.3197658210165;6134.4172303631085;6180.258368995749;6223.097650840603;6353.36466353361;6459.192600924885;6468.935310646927;6483.189601299838;6490.2536208335705;6494.318096599789;6201.410865967726;6273.749050037947;6280.874382512324;6383.872322553523;6452.354764523604;6411.262704789009;6443.903341449882;6459.644719540376;6470.547061705635;6481.319461456479;4878.512148785164;4889.633277504201;4892.143874821892;4896.706197628154;4923.507649235048;4305.763183024964;4309.245881970643;4338.436003319612;4361.5856493633055;4385.627221686193;6006.189164462829;6082.239720034996;6091.969540152271;6119.632822030603;6119.908201376983;6405.327440618761;6429.1320671709655;6457.192850893638;6461.127747753993;6488.902666460007;5856.94143058564;5987.79042733511;5988.101784732238;6075.058365953284;6082.422169893853;5507.284053073075;5520.199571062173;5540.501354878081;5543.251661025791;5549.1676248563035;6152.661603611755;6522;6573.408393244631;6612.966935165294;6623.701933413008;6441.355864413521;6456.7740129095255;6499.1876015498065;6499.967500162469;6511.609303441809;6745;6786.321367863175;6800.251972283144;6808.9659551701925;6809.080774095632;6133.76314253068;6211.844703882439;6235.438810507076;6296.0555916612875;6343.777967771106;6291.874162516816;6369.45859601939;6469.320721324381;6521.119648847345;6521.608703477807;6180.969095154675;6208.627482351073;6253.906191407224;6256.374362563707;6266;6204.100405441276;6206.162168107247;6214.968925155526;6215.627062376272;6227.844303892258;6112.235970503687;6117.632942023492;6136.120845438929;6203.038529028008;6246.469050130608;6307.495400368051;6363.7772677956045;6365.64988925595;6372.840678983062;6379.298277189599;6118.051701986199;6135;6147.231596050494;6183.659898705614;6190.102435146969 07:28:32 INFO - PID 32250 | |1;ext.html;690.5166383531526;743.0340557275542;763.7136073972263;1116.681745702475;1131.0273165078027;35922.461163082575;36708;36770.44844327337;36996.44505332419;37012.629873701255;38990.80504597473;39317.410238846365;39350.409743853794;39369;39380.409293860546;7160.534565253268;7249.238829922861;7345.706171753151;7365;7379.2620737926045;7318.81702957425;7331.816704582401;7398.963005184994;7400.11198656162;7400.592967386791;7398.519096258726;7400.70397184112;7424.25757424256;7427.777166684981;7437.219091995344;7385.446091543129;7385.667644955963;7406.185319614838;7407.481476296634;7422.740204092885;7297.087864016998;7300.671469783872;7303.744368947115;7348.485606007582;7364.77905662831;36637.633623663685;37091.443628345594;37140.44289335662;37292.813535932146;37338;3416.9487457688156;3466.30673865228;3471.1669199392218;3473.7394695397948;3483.954813555923;28981.13056608305;29173;29221.41557168845;29251.707482925325;29262.268443288875;3655.5613326400735;3671.0271777978855;3671.706263498914;3676.9448458273146;3678.9632103678887;167197;171143;177336;190412;191335;46179;46213;46476.767616161706;46551.76724116358;46806.5319346809;48387;48594;48679.269810952865;48700.5129948696;48779.51220487821;13777.104488208235;13797;13833.446662133401;13861.09902856311;13864.722705545833;11087.445627718582;11190.832137517944;11200.887991119984;11202.551897923991;11236.438178091063;14056.297185140702;14110.929445352707;14219.64450888736;14252;14331.570052898429;5819.388964158702;5823.417658234142;5839.795607153729;5846.941530584725;5938.436937837263;1072.871255449351;1106.6569363497342;1114.2311804854623;1121.556984990924;1123.4158237716342;26137.477250455264;26209.344766380993;26244;26269.605955910676;26331;1174.9347258485734;1176.5587904535798;1183.7928362536522;1183.8756930522343;1218.3725381428571;13285.66785830362;13492.59522214335;13733.587992360246;13850.861491384958;13864.514741983981;239854;240012;240996;243093;243632;53486;53510.464895351324;53795;54095.72952135214;54160.18759718607;1447.9348429320705;1470.5808844479486;1506.4200282890947;1516.7118247532933;1525.3898440623839;24344.391390215387;25513.362165946;25717.871410642827;25795.613065804402;26076.8696156518;38474.807625961694;38521.422178666784;38588.80705596454;38617.806910965264;38651.42022869603;192406;193589;193672;194104;195323;33666.326673465905;34040.23436718911;34150.65849341574;34215.486767699;34293.14267143242;42241.36637950494;42424.78787606042;43803.12393752171;43891.78054109709;44036.11927761491;31964.483906769772;32165.839170803996;32245.51631725573;32766.34467310688;33758.49362259519;31393.8430307847;32332.191695207806;33177.50233746447;33285.33429331448;33368.49947250744;36640;36729.08177295482;37439.81280093582;37705;37794.43308350432;31173.53239701361;31237.8438107808;32063;32296;32476;26170.214893553224;26242.868785655948;26265;26283.868580656974;26483 07:28:32 INFO - PID 32250 | |2;jquery.html;425.321612028814;427.7561789779827;433.2223658532934;433.33188889370365;450.7137967390708;18145.818541814595;19112;19852.60294794103;20022.799772002276;20057;21110.366688999315;22171.556568868615;22213.777862221374;22815.08739650412;23046.543018547225;4791.8562443126675;4913.8771530711665;4914.04176185644;4952.826651067214;4956.4547899731;5302.125149350371;5315.335583052119;5375;5394.946050539504;5461.508464238218;5371;5383.4616538346245;5383.784648614051;5386.2997810284805;5396.352437707461;5199.376074871002;5333.066713325153;5368;5384.623076384654;5400.540954018913;4860;4891.730954797485;4903.53416425439;4922.680025798348;4924.729139897304;24376;24459.87770061138;24476.14333498319;24524.264272071865;24796;2076.958460830775;2096.15105882118;2105.7367829021373;2107.5679485705396;2115.598036373084;16411.671766564723;16892.83107168925;16944.745828812578;17063.488095357035;17105.743413848802;2144.8820314882673;2151.34384012876;2212.7565967743535;2214.6235140026233;2215.2468160825238;109919.70240892786;113012.4349378256;113334.43332783366;113409.86590134076;113676;11725.530978760755;12085.879141208476;12192.634220973208;12205;12238.755224895453;15932;15987.360505579647;16036.471976165225;16057.598560036093;16079.35682572684;8243.422960392714;8425.4944703318;8453.957730211432;8681.739547813575;8689.348298877609;7827.726029588937;7883.842323153504;7931.603419828985;8012.959935200287;8095.919040809635;7658.693652253847;7668.539887606761;7687.6156192190165;7777.650005749755;7914.881276780853;2195.264586363586;2231.2079211879873;2248.718910136233;2252.966205506919;2406.89168987396;1031.489412740683;1062.9893701063045;1068.9679309620724;1070.7804899995483;1075.4404517249054;23596.230282728862;25875.870620646776;26609.201723948314;26609.201723948314;26728.59907101395;1074.140687450037;1075.381655548063;1086.21792309537;1100.0979197058496;1111.9610813621484;11162.823249466275;11607.76784464306;11634.6509604712;11761.411929403495;11873.940630296793;470592;484369;485481;488862;490059;98934;99631.50184249032;100914.49542752239;101762.4911875436;102916;1235.6478403655094;1282.3844554613838;1300.13540995239;1302.550620036086;1317.1833463252844;17972;18155.818441815412;18513.90743046276;18515.81484185195;18709.251629935196;45883.26459192601;46310;46789.76605116953;47539;47604.52395476001;59330.703346482995;60070.09894851668;60465.69767151136;60763;61511.6924415375;9407.764805879908;9453.574589143642;9627.711168664951;9676.27427942893;9811.411315321104;13933.442662293395;14768.556943291718;15060.472883449027;15157;15301.158436285667;11800.822987655363;12833.807492887801;13105.934470327587;13154.868451315364;13442.327883605976;11863.169578129447;11918.821217681569;12304.507819687113;12493.812592811297;12881.098323117292;13097;13109.672258193621;13225.206487610774;13490.932545337211;13520.18878867271;9311.37051016083;9476.241900647794;9524.476153811329;9717.271204659537;9837.458939758095;12657.556985505464;12700;12892.935535322264;13028.283444410648;13308.401121949342 07:28:32 INFO - PID 32250 | |3;mootools.html;1339.256712524549;1386.216787515054;1395.2605119286782;1398.9580312590613;1403.4947418929187;10770.246082774209;11241.943790281048;11279.830802537968;11394.7151321217;11601.245919015259;11291.096712263019;11485.196036277464;11514.942425287862;11550.480228389722;11567.016803571685;2164.2316977473006;2187.9343619691435;2193.484531135182;2202.0751284460566;2202.581509513195;2036.3381900882273;2097.5595125023765;2098.9895050524724;2104.757952835428;2107.6100921329603;2143.732033495813;2158.3956492182215;2181;2189.310367234324;2190.616642087636;2037.3073155127329;2057.639913015224;2062.6596611559;2067.917283308666;2072.1607748861734;1961.6567100757452;2048.4264405966355;2073.481629592602;2119.109973811003;2124.617568837609;11531.48108335127;11604.593839215671;11615.419229038514;11626.476808543635;11628.825567616492;6134.96932515339;6324.3043265240785;6332.208473940757;6366.840828979266;6377.58545694533;3649.178934739689;3846.6538011578814;3910.7262491625597;3912.5304963404574;3924.0386105404073;1370.5819724983876;1390.0755997261808;1416.0441701851312;1417.5605562275728;1436.7629341158802;17448.563785905328;17456.91271543647;17516.562085947953;17577.91211043962;17604.823951760576;4879.5120487951635;4971.726555039435;5095.133827249377;5106.821261255838;5133.973205358943;12652;12671.7824380733;12679.302638354979;12692.80960785589;12713.427895744713;6273;6327.968360158262;6342.873142537216;6345.524085693499;6366.6180029198395;5838.562107841929;5896.115582662549;5956.344802071769;5973.074173503114;6043.8791224175275;4385.736855788663;4401.295792673157;4424.137293227854;4452.465704115527;4458.197524445631;1345.9461621535224;1391.3947432866735;1394.0938390046551;1405.9156450612995;1412.1950488221614;831.9750407487785;854.9871751923727;860.9182127697859;872.0363997782359;894.342658146262;5928.970355148197;5961.344252132262;6003.399660034049;6084.178635884099;6197.628142311476;584.5037395403962;610.4140025575497;612.6446660936646;614.9477294429934;619.9380061993854;3999.300122478555;4161.459010328698;4211.642010429148;4255.446791917031;4262.531121576624;14875.33061012257;15392.538223853302;15400.22998850053;15400.691986160215;15410.691786164214;14488.34802433893;14753.778693319395;14830.110193388215;15095;15120.319585618674;9333.719988400358;9366.859497107549;9372.718818435458;9442.244620430349;9445.952770236105;6410.1025856381075;6417.614943103429;6481.449076828522;6483.610983341015;6609.603423794395;12952.676183095498;13229.140105893086;13410.787220108572;13562.440319363004;13591.592252232052;13611.727765444833;13877.306134693023;13939.16365018102;14225.857741422453;14460;9603;9689.370190937567;9754.365966212174;9867.901320986986;9887.703368898945;11090.778184436427;11153.944230279121;11154.27497212711;11156.44217789091;11172.050375718154;9391;9467.289953253672;9543.9045609543;9585.520723963913;9755.463449510062;9266.860997085185;9331.86002209981;9461.526923653928;9564.33049686543;9666.130048295407;8396.664133434595;8523;8589.098144694717;8599.52702601363;8603.956980215058;5579.916301255404;5583.860403489783;5620.887582248414;5667.291588551431;5807.535397168301;5846.444587764156;5888.617239879394;5955.791547295824;5957.165996760544;6073.726682299219 07:28:32 INFO - PID 32250 | |4;prototype.html;420.9095044565418;421.82494264880074;424.28719750818624;424.9043965107851;427.8160391031855;5912.911306330398;6036.909446358308;6040.395960403957;6067.696615169246;6077.665728384937;5793;5867.530597552196;5880.794172203974;5906.143609176666;5911.88176236475;4403.757793321366;4478.507364189928;4512.503624601291;4533.523979982104;4536.841210557631;4485.932711009321;4523.479799823013;4530.592246697796;4536.795844187003;4544.636429085665;4509.985253317994;4517.141743068806;4523.253663145577;4524.796384162721;4533.795979180944;4419.889502762425;4478.1116180064;4481.462224533045;4511.774411279423;4518.43519560055;3928;3928.8428462861452;3932.8623498177712;3934.547527034399;3946.3685810270217;5755.30936287644;5787.8553036174435;5816.738246778905;5817.941820581782;5819.010768169422;5115.641905066647;5211.029713063555;5224.451432599561;5247.737613119329;5260.289860868772;6173.660448675321;6196.535259855529;6217.191765070557;6251.249850017982;6254.968725156391;4347.5652434756585;4398.868033958986;4408.531222515369;4416.293393057128;4416.911661766779;6369.235691717024;6478.255000674935;6531.8693626127215;6556.934430655728;6600.801975940682;4450.866474005785;4473.501377038729;4480.775961201927;4515.729056256635;4522.66080043998;4540.591346778806;4545.0909818036525;4550.931736023962;4562.1560011398;4570.588647021784;5136.332276803992;5219;5224.216367544823;5262.158054711228;5263.473652634706;6287.736414890635;6319.58922670025;6343.731253749269;6345.777897773648;6357.936420635734;1554.6268895465007;1559.204805549178;1560.3134620766825;1565.6164239761104;1574.38598946411;1038.2265212416798;1050.4275170032197;1051.3113910388554;1062.5696592879897;1063.5852017713098;5996.4603185713495;6027.7287522061615;6045.818625441244;6047.213862197887;6064.363241859542;6363.713632886531;6466.838329041718;6515.156057925847;6517.804465866032;6547.476201903836;5968.432998865101;5996;6043.305019922677;6045.153678485016;6049.395060494004;3419.9658003420145;3445.155936795501;3464.9307013860084;3468.5317482140094;3472.201393679468;6612.7354905804195;6743.460523158135;6743.865122697519;6754.6284954327;6754.966225168941;6630.734770609121;6632.502562307846;6646.169228846395;6653.671215074782;6680.826607361561;6558.1802274715665;6742.865142697118;6765.1205343305055;6791.0153027811675;6801.727930882808;6496.805095847132;6521.380468855451;6524.706388212637;6528.445082168069;6536.8365790855605;6320.494360451061;6373.3945275198785;6403.815294170593;6443.613383197023;6476.676166191766;6716.3955244028275;6799.932000680128;6819.5908245505425;6824.317568243136;6838.418734407631;4480.6415486760325;4523.819047238074;4524.932126018047;4538.183127037165;4544.7045942013665;6403.6798160090875;6462.289148193789;6507.642079685663;6510.44661203784;6528.608283503005;6302.716377763103;6314.179156709598;6326.33573474797;6330.272018717907;6335.461485773761;6159.6612186330185;6284.151639528605;6295.213098362705;6304.464120549621;6359.49124070064;6245.125682404558;6279.30927597973;6305.792972459602;6321.1782468278825;6329.651869147241;6235.750569977332;6326.398992095744;6341.143945567289;6354.506690927536;6372.36276372359;6193.1329613855;6198.442140207403;6201.782937597162;6212.658303793154;6226.782062627786 07:28:32 INFO - PID 32250 | |5;yui.html;860.6740457636373;878.0517041595078;883.3507372081519;883.3551507399599;890.3322508118911;14494.202818844959;15197.620059498518;15427.922860385697;16154.596135096628;16229;17215.397461088865;17802.109894505287;17962.82037179628;18072;18429.262829486805;1000.8390267289927;1024.3188279793928;1030.8350663893777;1030.8659874216378;1031.2111234905303;1002.8194924913513;1006.6527048168371;1015.735908663749;1019.8623185869924;1022.6625213679505;1043.3844032021107;1065.9946700266487;1067.4555976451988;1067.7223921780314;1070.978580428391;1034.3070143004168;1051.9684409467727;1054.1724746074333;1056.5404049238568;1059.9152067834555;754.3098065270271;772.8067983004249;775.0350813237555;777.3547955197173;778.0313509680427;15491.225438728019;15504.922475387551;15529.145896975662;15604.29780659873;15649.217539122998;18060.819391806046;18569.90715046416;18764.62470750591;18791.812081879143;18830.152643131092;14614.342354593962;14638.853611463855;14930.701385972328;14949.02831315961;15015.699686006219;3298.960827339404;3332.100332910125;3365.444701624229;3365.96634033659;3368.8652453901814;90915;91546.08453915443;91819;92647.53676231643;95142.52428737881;13029.218246905217;13291.800622990662;14433.278336083154;14892.627684307763;15051.473198438001;26641.733582664314;26807.463850723267;27020;27121.321966950985;27121.728782712315;8247.752567422987;8398.328133749286;8404.159584041547;8444.662213511514;8471.872921906177;4115;4168.874933751992;4181.728187667792;4191.706580539394;4200.768957707355;4272.209641216385;4332.783360831946;4341.544137865541;4383.254846676073;4384.0355121873135;840.8822764812932;869.6782190589396;876.1545108969875;880.8986966498807;888.1207604471526;733.4865594084163;742.076115236534;746.220199891115;755.2183490087733;782.0263771604389;11545.095059315287;12822.9358853207;12873.871261287455;13168.144070635379;13510;722.3462766196601;731.934125928669;733.7431898835472;742.2206682982846;744.4464296349188;5646.887062258814;6328.335524769925;6543.705533251015;6683.565568238147;6763.688832499918;75473;76738;79031.60484197657;80810.59594701989;83870.58064709637;73128;73250.63374683092;74490.5101897959;74778;77119;63609.36390636034;64634;64901.999999999054;66813.33186668168;67196.6640166796;12630;13640.522581709592;13706.24615646149;13764.17414955106;13789.379477923718;33207.16982075467;33445.33109337751;33990;34049.65950340465;35395.64604353924;41295.38056929209;42462.5753742471;42778;42827.78586107049;43758.56241437672;17408.47774566765;17617.295308187528;17676.2045707946;17691.469255922344;18105.818941810412;19139.23443062262;19148.329808456638;19196.424107276805;19236.03819808976;19506;17168.914155429142;17288.827111729224;17392;17471.126443677513;17596.73604895953;16643.41748038813;17104.486865394058;17198.570035749206;17228.310867565157;17721.291148354438;17525.561860953578;17578.384756533458;17747.46757597274;17792.733109003115;18234.45296641103;13154.73690526165;13159.342032898125;13171.868281317064;13405.329733513481;13531.511533731478;14455.641256140098;14535.345909434312;14620.122792632475;14726.263686815402;14756 07:28:32 INFO - PID 32250 | __end_tp_report 07:28:32 INFO - PID 32250 | __start_cc_report 07:28:32 INFO - PID 32250 | _x_x_mozilla_cycle_collect,337 07:28:32 INFO - PID 32250 | __end_cc_report 07:28:32 INFO - PID 32250 | __startTimestamp1493994512842__endTimestamp 07:28:32 INFO - PID 32250 | 07:28:32 INFO - PID 32250 | ------- Summary: start ------- 07:28:32 INFO - PID 32250 | Number of tests: 6 07:28:32 INFO - PID 32250 | 07:28:32 INFO - PID 32250 | [#0] dojo.html Cycles:165 Average:5921.73 Median:6136.12 stddev:710.83 (11.6%) stddev-sans-first:683.21 07:28:32 INFO - PID 32250 | Values: 3325.4 3355.5 3378.0 3397.2 3411.0 5772.9 5870.9 5871.2 5938.7 5948.9 5905.0 5921.1 5928.3 6003.6 6022.9 5243.7 5262.0 5285.3 5297.8 5305.9 5324.1 5391.5 5391.6 5393.0 5416.2 5260.5 5311.0 5338.0 5339.2 5342.6 5297.7 5305.2 5309.3 5316.3 5335.9 5289.8 5294.6 5302.1 5307.9 5316.2 5774.3 5782.8 5796.3 5832.0 5840.0 6443.0 6451.5 6453.6 6468.9 6471.3 6467.5 6480.4 6484.6 6490.4 6499.3 5869.3 5909.1 5941.6 5999.2 6030.3 6561.4 6594.6 6598.8 6599.8 6608.0 6119.3 6134.4 6180.3 6223.1 6353.4 6459.2 6468.9 6483.2 6490.3 6494.3 6201.4 6273.7 6280.9 6383.9 6452.4 6411.3 6443.9 6459.6 6470.5 6481.3 4878.5 4889.6 4892.1 4896.7 4923.5 4305.8 4309.2 4338.4 4361.6 4385.6 6006.2 6082.2 6092.0 6119.6 6119.9 6405.3 6429.1 6457.2 6461.1 6488.9 5856.9 5987.8 5988.1 6075.1 6082.4 5507.3 5520.2 5540.5 5543.3 5549.2 6152.7 6522.0 6573.4 6613.0 6623.7 6441.4 6456.8 6499.2 6500.0 6511.6 6745.0 6786.3 6800.3 6809.0 6809.1 6133.8 6211.8 6235.4 6296.1 6343.8 6291.9 6369.5 6469.3 6521.1 6521.6 6181.0 6208.6 6253.9 6256.4 6266.0 6204.1 6206.2 6215.0 6215.6 6227.8 6112.2 6117.6 6136.1 6203.0 6246.5 6307.5 6363.8 6365.6 6372.8 6379.3 6118.1 6135.0 6147.2 6183.7 6190.1 07:28:32 INFO - PID 32250 | 07:28:32 INFO - PID 32250 | [#1] ext.html Cycles:180 Average:37267.08 Median:18816.22 stddev:53606.23 (284.9%) stddev-sans-first:53686.26 07:28:32 INFO - PID 32250 | Values: 690.5 743.0 763.7 1116.7 1131.0 35922.5 36708.0 36770.4 36996.4 37012.6 38990.8 39317.4 39350.4 39369.0 39380.4 7160.5 7249.2 7345.7 7365.0 7379.3 7318.8 7331.8 7399.0 7400.1 7400.6 7398.5 7400.7 7424.3 7427.8 7437.2 7385.4 7385.7 7406.2 7407.5 7422.7 7297.1 7300.7 7303.7 7348.5 7364.8 36637.6 37091.4 37140.4 37292.8 37338.0 3416.9 3466.3 3471.2 3473.7 3484.0 28981.1 29173.0 29221.4 29251.7 29262.3 3655.6 3671.0 3671.7 3676.9 3679.0 167197.0 171143.0 177336.0 190412.0 191335.0 46179.0 46213.0 46476.8 46551.8 46806.5 48387.0 48594.0 48679.3 48700.5 48779.5 13777.1 13797.0 13833.4 13861.1 13864.7 11087.4 11190.8 11200.9 11202.6 11236.4 14056.3 14110.9 14219.6 14252.0 14331.6 5819.4 5823.4 5839.8 5846.9 5938.4 1072.9 1106.7 1114.2 1121.6 1123.4 26137.5 26209.3 26244.0 26269.6 26331.0 1174.9 1176.6 1183.8 1183.9 1218.4 13285.7 13492.6 13733.6 13850.9 13864.5 239854.0 240012.0 240996.0 243093.0 243632.0 53486.0 53510.5 53795.0 54095.7 54160.2 1447.9 1470.6 1506.4 1516.7 1525.4 24344.4 25513.4 25717.9 25795.6 26076.9 38474.8 38521.4 38588.8 38617.8 38651.4 192406.0 193589.0 193672.0 194104.0 195323.0 33666.3 34040.2 34150.7 34215.5 34293.1 42241.4 42424.8 43803.1 43891.8 44036.1 31964.5 32165.8 32245.5 32766.3 33758.5 31393.8 32332.2 33177.5 33285.3 33368.5 36640.0 36729.1 37439.8 37705.0 37794.4 31173.5 31237.8 32063.0 32296.0 32476.0 26170.2 26242.9 26265.0 26283.9 26483.0 07:28:32 INFO - PID 32250 | 07:28:32 INFO - PID 32250 | [#2] jquery.html Cycles:180 Average:31044.90 Median:22192.67 stddev:80660.20 (363.5%) stddev-sans-first:80853.70 07:28:32 INFO - PID 32250 | Values: 425.3 427.8 433.2 433.3 450.7 18145.8 19112.0 19852.6 20022.8 20057.0 21110.4 22171.6 22213.8 22815.1 23046.5 4791.9 4913.9 4914.0 4952.8 4956.5 5302.1 5315.3 5375.0 5394.9 5461.5 5371.0 5383.5 5383.8 5386.3 5396.4 5199.4 5333.1 5368.0 5384.6 5400.5 4860.0 4891.7 4903.5 4922.7 4924.7 24376.0 24459.9 24476.1 24524.3 24796.0 2077.0 2096.2 2105.7 2107.6 2115.6 16411.7 16892.8 16944.7 17063.5 17105.7 2144.9 2151.3 2212.8 2214.6 2215.2 109919.7 113012.4 113334.4 113409.9 113676.0 11725.5 12085.9 12192.6 12205.0 12238.8 15932.0 15987.4 16036.5 16057.6 16079.4 8243.4 8425.5 8454.0 8681.7 8689.3 7827.7 7883.8 7931.6 8013.0 8095.9 7658.7 7668.5 7687.6 7777.7 7914.9 2195.3 2231.2 2248.7 2253.0 2406.9 1031.5 1063.0 1069.0 1070.8 1075.4 23596.2 25875.9 26609.2 26609.2 26728.6 1074.1 1075.4 1086.2 1100.1 1112.0 11162.8 11607.8 11634.7 11761.4 11873.9 470592.0 484369.0 485481.0 488862.0 490059.0 98934.0 99631.5 100914.5 101762.5 102916.0 1235.6 1282.4 1300.1 1302.6 1317.2 17972.0 18155.8 18513.9 18515.8 18709.3 45883.3 46310.0 46789.8 47539.0 47604.5 59330.7 60070.1 60465.7 60763.0 61511.7 9407.8 9453.6 9627.7 9676.3 9811.4 13933.4 14768.6 15060.5 15157.0 15301.2 11800.8 12833.8 13105.9 13154.9 13442.3 11863.2 11918.8 12304.5 12493.8 12881.1 13097.0 13109.7 13225.2 13490.9 13520.2 9311.4 9476.2 9524.5 9717.3 9837.5 12657.6 12700.0 12892.9 13028.3 13308.4 07:28:32 INFO - PID 32250 | 07:28:32 INFO - PID 32250 | [#3] mootools.html Cycles:180 Average:7120.16 Median:3747.92 stddev:4711.32 (125.7%) stddev-sans-first:4704.51 07:28:32 INFO - PID 32250 | Values: 1339.3 1386.2 1395.3 1399.0 1403.5 10770.2 11241.9 11279.8 11394.7 11601.2 11291.1 11485.2 11514.9 11550.5 11567.0 2164.2 2187.9 2193.5 2202.1 2202.6 2036.3 2097.6 2099.0 2104.8 2107.6 2143.7 2158.4 2181.0 2189.3 2190.6 2037.3 2057.6 2062.7 2067.9 2072.2 1961.7 2048.4 2073.5 2119.1 2124.6 11531.5 11604.6 11615.4 11626.5 11628.8 6135.0 6324.3 6332.2 6366.8 6377.6 3649.2 3846.7 3910.7 3912.5 3924.0 1370.6 1390.1 1416.0 1417.6 1436.8 17448.6 17456.9 17516.6 17577.9 17604.8 4879.5 4971.7 5095.1 5106.8 5134.0 12652.0 12671.8 12679.3 12692.8 12713.4 6273.0 6328.0 6342.9 6345.5 6366.6 5838.6 5896.1 5956.3 5973.1 6043.9 4385.7 4401.3 4424.1 4452.5 4458.2 1345.9 1391.4 1394.1 1405.9 1412.2 832.0 855.0 860.9 872.0 894.3 5929.0 5961.3 6003.4 6084.2 6197.6 584.5 610.4 612.6 614.9 619.9 3999.3 4161.5 4211.6 4255.4 4262.5 14875.3 15392.5 15400.2 15400.7 15410.7 14488.3 14753.8 14830.1 15095.0 15120.3 9333.7 9366.9 9372.7 9442.2 9446.0 6410.1 6417.6 6481.4 6483.6 6609.6 12952.7 13229.1 13410.8 13562.4 13591.6 13611.7 13877.3 13939.2 14225.9 14460.0 9603.0 9689.4 9754.4 9867.9 9887.7 11090.8 11153.9 11154.3 11156.4 11172.1 9391.0 9467.3 9543.9 9585.5 9755.5 9266.9 9331.9 9461.5 9564.3 9666.1 8396.7 8523.0 8589.1 8599.5 8604.0 5579.9 5583.9 5620.9 5667.3 5807.5 5846.4 5888.6 5955.8 5957.2 6073.7 07:28:32 INFO - PID 32250 | 07:28:32 INFO - PID 32250 | [#4] prototype.html Cycles:180 Average:5274.46 Median:6038.65 stddev:1588.28 (26.3%) stddev-sans-first:1550.39 07:28:32 INFO - PID 32250 | Values: 420.9 421.8 424.3 424.9 427.8 5912.9 6036.9 6040.4 6067.7 6077.7 5793.0 5867.5 5880.8 5906.1 5911.9 4403.8 4478.5 4512.5 4533.5 4536.8 4485.9 4523.5 4530.6 4536.8 4544.6 4510.0 4517.1 4523.3 4524.8 4533.8 4419.9 4478.1 4481.5 4511.8 4518.4 3928.0 3928.8 3932.9 3934.5 3946.4 5755.3 5787.9 5816.7 5817.9 5819.0 5115.6 5211.0 5224.5 5247.7 5260.3 6173.7 6196.5 6217.2 6251.2 6255.0 4347.6 4398.9 4408.5 4416.3 4416.9 6369.2 6478.3 6531.9 6556.9 6600.8 4450.9 4473.5 4480.8 4515.7 4522.7 4540.6 4545.1 4550.9 4562.2 4570.6 5136.3 5219.0 5224.2 5262.2 5263.5 6287.7 6319.6 6343.7 6345.8 6357.9 1554.6 1559.2 1560.3 1565.6 1574.4 1038.2 1050.4 1051.3 1062.6 1063.6 5996.5 6027.7 6045.8 6047.2 6064.4 6363.7 6466.8 6515.2 6517.8 6547.5 5968.4 5996.0 6043.3 6045.2 6049.4 3420.0 3445.2 3464.9 3468.5 3472.2 6612.7 6743.5 6743.9 6754.6 6755.0 6630.7 6632.5 6646.2 6653.7 6680.8 6558.2 6742.9 6765.1 6791.0 6801.7 6496.8 6521.4 6524.7 6528.4 6536.8 6320.5 6373.4 6403.8 6443.6 6476.7 6716.4 6799.9 6819.6 6824.3 6838.4 4480.6 4523.8 4524.9 4538.2 4544.7 6403.7 6462.3 6507.6 6510.4 6528.6 6302.7 6314.2 6326.3 6330.3 6335.5 6159.7 6284.2 6295.2 6304.5 6359.5 6245.1 6279.3 6305.8 6321.2 6329.7 6235.8 6326.4 6341.1 6354.5 6372.4 6193.1 6198.4 6201.8 6212.7 6226.8 07:28:32 INFO - PID 32250 | 07:28:32 INFO - PID 32250 | [#5] yui.html Cycles:180 Average:19166.04 Median:19143.78 stddev:23165.83 (121.0%) stddev-sans-first:23190.03 07:28:32 INFO - PID 32250 | Values: 860.7 878.1 883.4 883.4 890.3 14494.2 15197.6 15427.9 16154.6 16229.0 17215.4 17802.1 17962.8 18072.0 18429.3 1000.8 1024.3 1030.8 1030.9 1031.2 1002.8 1006.7 1015.7 1019.9 1022.7 1043.4 1066.0 1067.5 1067.7 1071.0 1034.3 1052.0 1054.2 1056.5 1059.9 754.3 772.8 775.0 777.4 778.0 15491.2 15504.9 15529.1 15604.3 15649.2 18060.8 18569.9 18764.6 18791.8 18830.2 14614.3 14638.9 14930.7 14949.0 15015.7 3299.0 3332.1 3365.4 3366.0 3368.9 90915.0 91546.1 91819.0 92647.5 95142.5 13029.2 13291.8 14433.3 14892.6 15051.5 26641.7 26807.5 27020.0 27121.3 27121.7 8247.8 8398.3 8404.2 8444.7 8471.9 4115.0 4168.9 4181.7 4191.7 4200.8 4272.2 4332.8 4341.5 4383.3 4384.0 840.9 869.7 876.2 880.9 888.1 733.5 742.1 746.2 755.2 782.0 11545.1 12822.9 12873.9 13168.1 13510.0 722.3 731.9 733.7 742.2 744.4 5646.9 6328.3 6543.7 6683.6 6763.7 75473.0 76738.0 79031.6 80810.6 83870.6 73128.0 73250.6 74490.5 74778.0 77119.0 63609.4 64634.0 64902.0 66813.3 67196.7 12630.0 13640.5 13706.2 13764.2 13789.4 33207.2 33445.3 33990.0 34049.7 35395.6 41295.4 42462.6 42778.0 42827.8 43758.6 17408.5 17617.3 17676.2 17691.5 18105.8 19139.2 19148.3 19196.4 19236.0 19506.0 17168.9 17288.8 17392.0 17471.1 17596.7 16643.4 17104.5 17198.6 17228.3 17721.3 17525.6 17578.4 17747.5 17792.7 18234.5 13154.7 13159.3 13171.9 13405.3 13531.5 14455.6 14535.3 14620.1 14726.3 14756.0 07:28:32 INFO - PID 32250 | -------- Summary: end -------- 07:28:32 INFO - PID 32250 | 07:28:33 INFO - TEST-INFO | 32250: exit 0 07:28:33 INFO - TEST-OK | dromaeo_css | took 1113585ms 07:28:33 INFO - TEST-START | kraken 07:28:33 INFO - operating with platform_type : linux_ 07:28:33 INFO - Initialising browser for kraken test... 07:28:33 INFO - TEST-INFO | started process 32670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYeEgMO/profile http://localhost:55823/getInfo.html) 07:28:37 INFO - PID 32670 | __metrics Screen width/height:1600/1200 07:28:37 INFO - PID 32670 | colorDepth:24 07:28:37 INFO - PID 32670 | Browser inner width/height: 1024/695 07:28:37 INFO - PID 32670 | __metrics 07:28:39 INFO - TEST-INFO | 32670: exit 0 07:28:39 INFO - Browser initialized. 07:28:39 INFO - Running cycle 1/1 for kraken test... 07:28:39 INFO - TEST-INFO | started process 378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYeEgMO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:51 INFO - PID 378 | RSS: Main: 156565504 07:28:51 INFO - PID 378 | 07:28:53 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55823/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:54 INFO - PID 378 | RSS: Main: 163004416 07:28:54 INFO - PID 378 | 07:28:57 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55823/tests/kraken/driver.html?testName=audio-dft) 07:28:57 INFO - PID 378 | RSS: Main: 160907264 07:28:57 INFO - PID 378 | 07:29:00 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55823/tests/kraken/driver.html?testName=audio-fft) 07:29:01 INFO - PID 378 | RSS: Main: 157061120 07:29:01 INFO - PID 378 | 07:29:03 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55823/tests/kraken/driver.html?testName=audio-oscillator) 07:29:04 INFO - PID 378 | RSS: Main: 158191616 07:29:04 INFO - PID 378 | 07:29:06 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:29:06 INFO - PID 378 | RSS: Main: 158285824 07:29:06 INFO - PID 378 | 07:29:09 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55823/tests/kraken/driver.html?testName=imaging-darkroom) 07:29:10 INFO - PID 378 | RSS: Main: 163729408 07:29:10 INFO - PID 378 | 07:29:13 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55823/tests/kraken/driver.html?testName=imaging-desaturate) 07:29:14 INFO - PID 378 | RSS: Main: 165531648 07:29:14 INFO - PID 378 | 07:29:17 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55823/tests/kraken/driver.html?testName=json-parse-financial) 07:29:17 INFO - PID 378 | RSS: Main: 165031936 07:29:17 INFO - PID 378 | 07:29:19 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:29:19 INFO - PID 378 | RSS: Main: 164474880 07:29:19 INFO - PID 378 | 07:29:21 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:29:22 INFO - PID 378 | RSS: Main: 164679680 07:29:22 INFO - PID 378 | 07:29:24 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:24 INFO - PID 378 | RSS: Main: 164962304 07:29:24 INFO - PID 378 | 07:29:27 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:28 INFO - PID 378 | RSS: Main: 164470784 07:29:28 INFO - PID 378 | 07:29:31 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:31 INFO - PID 378 | RSS: Main: 164835328 07:29:31 INFO - PID 378 | 07:29:33 INFO - PID 378 | Cycle 1(1): loaded http://localhost:55823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55823/tests/kraken/driver.html?testName=ai-astar) 07:29:33 INFO - PID 378 | RSS: Main: 167124992 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | __start_tp_report 07:29:33 INFO - PID 378 | _x_x_mozilla_page_load 07:29:33 INFO - PID 378 | _x_x_mozilla_page_load_details 07:29:33 INFO - PID 378 | |i|pagename|runs| 07:29:33 INFO - PID 378 | |0;ai-astar;103;110;112;110;109;110;110;109;111;112 07:29:33 INFO - PID 378 | |1;audio-beat-detection;159;118;118;165;118;123;121;119;142;120 07:29:33 INFO - PID 378 | |2;audio-dft;165;164;164;163;163;166;167;170;169;164 07:29:33 INFO - PID 378 | |3;audio-fft;73;77;75;91;75;76;76;77;90;75 07:29:33 INFO - PID 378 | |4;audio-oscillator;82;82;98;81;82;82;98;83;82;107 07:29:33 INFO - PID 378 | |5;imaging-gaussian-blur;114;115;114;114;114;113;113;113;114;113 07:29:33 INFO - PID 378 | |6;imaging-darkroom;148;148;148;148;148;148;149;149;148;148 07:29:33 INFO - PID 378 | |7;imaging-desaturate;95;96;95;94;94;95;95;94;97;94 07:29:33 INFO - PID 378 | |8;json-parse-financial;46;45;49;46;47;46;50;53;46;46 07:29:33 INFO - PID 378 | |9;json-stringify-tinderbox;57;57;57;56;57;56;57;57;57;57 07:29:33 INFO - PID 378 | |10;stanford-crypto-aes;83;82;83;80;81;88;82;81;80;82 07:29:33 INFO - PID 378 | |11;stanford-crypto-ccm;135;128;123;125;125;132;124;125;174;140 07:29:33 INFO - PID 378 | |12;stanford-crypto-pbkdf2;180;177;182;175;196;185;181;190;173;181 07:29:33 INFO - PID 378 | |13;stanford-crypto-sha256-iterative;70;67;70;70;66;66;66;66;67;71 07:29:33 INFO - PID 378 | __end_tp_report 07:29:33 INFO - PID 378 | __start_cc_report 07:29:33 INFO - PID 378 | _x_x_mozilla_cycle_collect,749 07:29:33 INFO - PID 378 | __end_cc_report 07:29:33 INFO - PID 378 | __startTimestamp1493994573750__endTimestamp 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | ------- Summary: start ------- 07:29:33 INFO - PID 378 | Number of tests: 14 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.55 (2.3%) stddev-sans-first:1.12 07:29:33 INFO - PID 378 | Values: 103.0 110.0 112.0 110.0 109.0 110.0 110.0 109.0 111.0 112.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:122.00 stddev:18.23 (14.9%) stddev-sans-first:16.11 07:29:33 INFO - PID 378 | Values: 159.0 118.0 118.0 165.0 118.0 123.0 121.0 119.0 142.0 120.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:2.46 (1.5%) stddev-sans-first:2.60 07:29:33 INFO - PID 378 | Values: 165.0 164.0 164.0 163.0 163.0 166.0 167.0 170.0 169.0 164.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#3] audio-fft Cycles:10 Average:78.50 Median:76.50 stddev:6.43 (8.4%) stddev-sans-first:6.51 07:29:33 INFO - PID 378 | Values: 73.0 77.0 75.0 91.0 75.0 76.0 76.0 77.0 90.0 75.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:82.00 stddev:9.51 (11.6%) stddev-sans-first:9.86 07:29:33 INFO - PID 378 | Values: 82.0 82.0 98.0 81.0 82.0 82.0 98.0 83.0 82.0 107.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:29:33 INFO - PID 378 | Values: 114.0 115.0 114.0 114.0 114.0 113.0 113.0 113.0 114.0 113.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 07:29:33 INFO - PID 378 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 149.0 149.0 148.0 148.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.99 (1.0%) stddev-sans-first:1.05 07:29:33 INFO - PID 378 | Values: 95.0 96.0 95.0 94.0 94.0 95.0 95.0 94.0 97.0 94.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#8] json-parse-financial Cycles:10 Average:47.40 Median:46.50 stddev:2.50 (5.4%) stddev-sans-first:2.60 07:29:33 INFO - PID 378 | Values: 46.0 45.0 49.0 46.0 47.0 46.0 50.0 53.0 46.0 46.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 07:29:33 INFO - PID 378 | Values: 57.0 57.0 57.0 56.0 57.0 56.0 57.0 57.0 57.0 57.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:2.30 (2.8%) stddev-sans-first:2.42 07:29:33 INFO - PID 378 | Values: 83.0 82.0 83.0 80.0 81.0 88.0 82.0 81.0 80.0 82.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:130.00 stddev:15.39 (11.8%) stddev-sans-first:16.31 07:29:33 INFO - PID 378 | Values: 135.0 128.0 123.0 125.0 125.0 132.0 124.0 125.0 174.0 140.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:181.50 stddev:6.91 (3.8%) stddev-sans-first:7.29 07:29:33 INFO - PID 378 | Values: 180.0 177.0 182.0 175.0 196.0 185.0 181.0 190.0 173.0 181.0 07:29:33 INFO - PID 378 | 07:29:33 INFO - PID 378 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:2.08 (3.0%) stddev-sans-first:2.06 07:29:33 INFO - PID 378 | Values: 70.0 67.0 70.0 70.0 66.0 66.0 66.0 66.0 67.0 71.0 07:29:33 INFO - PID 378 | -------- Summary: end -------- 07:29:33 INFO - PID 378 | 07:29:34 INFO - TEST-INFO | 378: exit 0 07:29:34 INFO - TEST-OK | kraken | took 61391ms 07:29:34 INFO - SUITE-END | took 1174s 07:29:35 INFO - Completed test suite (00:19:35) 07:29:35 INFO - javascript benchmark 07:29:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7714.33992897798, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.401427743006, 3355.530225768391, 3377.9831100844494, 3397.1507123219194, 3410.976706987903, 5772.855678608037, 5870.882582348356, 5871.207387002753, 5938.732757025933, 5948.910766338508, 5904.996150654389, 5921.082232254007, 5928.288605367351, 6003.609765365248, 6022.939770602293, 5243.711595862226, 5262.0, 5285.339332583408, 5297.761600727977, 5305.867353316159, 5324.068288049576, 5391.541718953894, 5391.56867450603, 5393.029254734146, 5416.241726158341, 5260.526552610283, 5310.9734451327495, 5338.0, 5339.22581225722, 5342.626016178869, 5297.708626025567, 5305.204219367087, 5309.256704061435, 5316.255724198615, 5335.893282134374, 5289.814856480005, 5294.57643388528, 5302.098643230622, 5307.867303317409, 5316.202569614588, 5774.335951365605, 5782.797602083949, 5796.304443466811, 5831.979403604352, 5840.0, 6442.967785161091, 6451.516136289797, 6453.612783233021, 6468.870622587522, 6471.255805582371, 6467.450266727334, 6480.351964803529, 6484.578502397329, 6490.448311893495, 6499.317571655003, 5869.325027621793, 5909.054551271776, 5941.643501389931, 5999.1901093351835, 6030.276366835964, 6561.40947314744, 6594.604323740591, 6598.8350291243105, 6599.835004124935, 6608.041833934149, 6119.3197658210165, 6134.4172303631085, 6180.258368995749, 6223.097650840603, 6353.36466353361, 6459.192600924885, 6468.935310646927, 6483.189601299838, 6490.2536208335705, 6494.318096599789, 6201.410865967726, 6273.749050037947, 6280.874382512324, 6383.872322553523, 6452.354764523604, 6411.262704789009, 6443.903341449882, 6459.644719540376, 6470.547061705635, 6481.319461456479, 4878.512148785164, 4889.633277504201, 4892.143874821892, 4896.706197628154, 4923.507649235048, 4305.763183024964, 4309.245881970643, 4338.436003319612, 4361.5856493633055, 4385.627221686193, 6006.189164462829, 6082.239720034996, 6091.969540152271, 6119.632822030603, 6119.908201376983, 6405.327440618761, 6429.1320671709655, 6457.192850893638, 6461.127747753993, 6488.902666460007, 5856.94143058564, 5987.79042733511, 5988.101784732238, 6075.058365953284, 6082.422169893853, 5507.284053073075, 5520.199571062173, 5540.501354878081, 5543.251661025791, 5549.1676248563035, 6152.661603611755, 6522.0, 6573.408393244631, 6612.966935165294, 6623.701933413008, 6441.355864413521, 6456.7740129095255, 6499.1876015498065, 6499.967500162469, 6511.609303441809, 6745.0, 6786.321367863175, 6800.251972283144, 6808.9659551701925, 6809.080774095632, 6133.76314253068, 6211.844703882439, 6235.438810507076, 6296.0555916612875, 6343.777967771106, 6291.874162516816, 6369.45859601939, 6469.320721324381, 6521.119648847345, 6521.608703477807, 6180.969095154675, 6208.627482351073, 6253.906191407224, 6256.374362563707, 6266.0, 6204.100405441276, 6206.162168107247, 6214.968925155526, 6215.627062376272, 6227.844303892258, 6112.235970503687, 6117.632942023492, 6136.120845438929, 6203.038529028008, 6246.469050130608, 6307.495400368051, 6363.7772677956045, 6365.64988925595, 6372.840678983062, 6379.298277189599, 6118.051701986199, 6135.0, 6147.231596050494, 6183.659898705614, 6190.102435146969], "value": 5871.178218241498, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.5166383531526, 743.0340557275542, 763.7136073972263, 1116.681745702475, 1131.0273165078027, 35922.461163082575, 36708.0, 36770.44844327337, 36996.44505332419, 37012.629873701255, 38990.80504597473, 39317.410238846365, 39350.409743853794, 39369.0, 39380.409293860546, 7160.534565253268, 7249.238829922861, 7345.706171753151, 7365.0, 7379.2620737926045, 7318.81702957425, 7331.816704582401, 7398.963005184994, 7400.11198656162, 7400.592967386791, 7398.519096258726, 7400.70397184112, 7424.25757424256, 7427.777166684981, 7437.219091995344, 7385.446091543129, 7385.667644955963, 7406.185319614838, 7407.481476296634, 7422.740204092885, 7297.087864016998, 7300.671469783872, 7303.744368947115, 7348.485606007582, 7364.77905662831, 36637.633623663685, 37091.443628345594, 37140.44289335662, 37292.813535932146, 37338.0, 3416.9487457688156, 3466.30673865228, 3471.1669199392218, 3473.7394695397948, 3483.954813555923, 28981.13056608305, 29173.0, 29221.41557168845, 29251.707482925325, 29262.268443288875, 3655.5613326400735, 3671.0271777978855, 3671.706263498914, 3676.9448458273146, 3678.9632103678887, 167197.0, 171143.0, 177336.0, 190412.0, 191335.0, 46179.0, 46213.0, 46476.767616161706, 46551.76724116358, 46806.5319346809, 48387.0, 48594.0, 48679.269810952865, 48700.5129948696, 48779.51220487821, 13777.104488208235, 13797.0, 13833.446662133401, 13861.09902856311, 13864.722705545833, 11087.445627718582, 11190.832137517944, 11200.887991119984, 11202.551897923991, 11236.438178091063, 14056.297185140702, 14110.929445352707, 14219.64450888736, 14252.0, 14331.570052898429, 5819.388964158702, 5823.417658234142, 5839.795607153729, 5846.941530584725, 5938.436937837263, 1072.871255449351, 1106.6569363497342, 1114.2311804854623, 1121.556984990924, 1123.4158237716342, 26137.477250455264, 26209.344766380993, 26244.0, 26269.605955910676, 26331.0, 1174.9347258485734, 1176.5587904535798, 1183.7928362536522, 1183.8756930522343, 1218.3725381428571, 13285.66785830362, 13492.59522214335, 13733.587992360246, 13850.861491384958, 13864.514741983981, 239854.0, 240012.0, 240996.0, 243093.0, 243632.0, 53486.0, 53510.464895351324, 53795.0, 54095.72952135214, 54160.18759718607, 1447.9348429320705, 1470.5808844479486, 1506.4200282890947, 1516.7118247532933, 1525.3898440623839, 24344.391390215387, 25513.362165946, 25717.871410642827, 25795.613065804402, 26076.8696156518, 38474.807625961694, 38521.422178666784, 38588.80705596454, 38617.806910965264, 38651.42022869603, 192406.0, 193589.0, 193672.0, 194104.0, 195323.0, 33666.326673465905, 34040.23436718911, 34150.65849341574, 34215.486767699, 34293.14267143242, 42241.36637950494, 42424.78787606042, 43803.12393752171, 43891.78054109709, 44036.11927761491, 31964.483906769772, 32165.839170803996, 32245.51631725573, 32766.34467310688, 33758.49362259519, 31393.8430307847, 32332.191695207806, 33177.50233746447, 33285.33429331448, 33368.49947250744, 36640.0, 36729.08177295482, 37439.81280093582, 37705.0, 37794.43308350432, 31173.53239701361, 31237.8438107808, 32063.0, 32296.0, 32476.0, 26170.214893553224, 26242.868785655948, 26265.0, 26283.868580656974, 26483.0], "value": 16929.22312871271, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.321612028814, 427.7561789779827, 433.2223658532934, 433.33188889370365, 450.7137967390708, 18145.818541814595, 19112.0, 19852.60294794103, 20022.799772002276, 20057.0, 21110.366688999315, 22171.556568868615, 22213.777862221374, 22815.08739650412, 23046.543018547225, 4791.8562443126675, 4913.8771530711665, 4914.04176185644, 4952.826651067214, 4956.4547899731, 5302.125149350371, 5315.335583052119, 5375.0, 5394.946050539504, 5461.508464238218, 5371.0, 5383.4616538346245, 5383.784648614051, 5386.2997810284805, 5396.352437707461, 5199.376074871002, 5333.066713325153, 5368.0, 5384.623076384654, 5400.540954018913, 4860.0, 4891.730954797485, 4903.53416425439, 4922.680025798348, 4924.729139897304, 24376.0, 24459.87770061138, 24476.14333498319, 24524.264272071865, 24796.0, 2076.958460830775, 2096.15105882118, 2105.7367829021373, 2107.5679485705396, 2115.598036373084, 16411.671766564723, 16892.83107168925, 16944.745828812578, 17063.488095357035, 17105.743413848802, 2144.8820314882673, 2151.34384012876, 2212.7565967743535, 2214.6235140026233, 2215.2468160825238, 109919.70240892786, 113012.4349378256, 113334.43332783366, 113409.86590134076, 113676.0, 11725.530978760755, 12085.879141208476, 12192.634220973208, 12205.0, 12238.755224895453, 15932.0, 15987.360505579647, 16036.471976165225, 16057.598560036093, 16079.35682572684, 8243.422960392714, 8425.4944703318, 8453.957730211432, 8681.739547813575, 8689.348298877609, 7827.726029588937, 7883.842323153504, 7931.603419828985, 8012.959935200287, 8095.919040809635, 7658.693652253847, 7668.539887606761, 7687.6156192190165, 7777.650005749755, 7914.881276780853, 2195.264586363586, 2231.2079211879873, 2248.718910136233, 2252.966205506919, 2406.89168987396, 1031.489412740683, 1062.9893701063045, 1068.9679309620724, 1070.7804899995483, 1075.4404517249054, 23596.230282728862, 25875.870620646776, 26609.201723948314, 26609.201723948314, 26728.59907101395, 1074.140687450037, 1075.381655548063, 1086.21792309537, 1100.0979197058496, 1111.9610813621484, 11162.823249466275, 11607.76784464306, 11634.6509604712, 11761.411929403495, 11873.940630296793, 470592.0, 484369.0, 485481.0, 488862.0, 490059.0, 98934.0, 99631.50184249032, 100914.49542752239, 101762.4911875436, 102916.0, 1235.6478403655094, 1282.3844554613838, 1300.13540995239, 1302.550620036086, 1317.1833463252844, 17972.0, 18155.818441815412, 18513.90743046276, 18515.81484185195, 18709.251629935196, 45883.26459192601, 46310.0, 46789.76605116953, 47539.0, 47604.52395476001, 59330.703346482995, 60070.09894851668, 60465.69767151136, 60763.0, 61511.6924415375, 9407.764805879908, 9453.574589143642, 9627.711168664951, 9676.27427942893, 9811.411315321104, 13933.442662293395, 14768.556943291718, 15060.472883449027, 15157.0, 15301.158436285667, 11800.822987655363, 12833.807492887801, 13105.934470327587, 13154.868451315364, 13442.327883605976, 11863.169578129447, 11918.821217681569, 12304.507819687113, 12493.812592811297, 12881.098323117292, 13097.0, 13109.672258193621, 13225.206487610774, 13490.932545337211, 13520.18878867271, 9311.37051016083, 9476.241900647794, 9524.476153811329, 9717.271204659537, 9837.458939758095, 12657.556985505464, 12700.0, 12892.935535322264, 13028.283444410648, 13308.401121949342], "value": 10103.811611356507, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.256712524549, 1386.216787515054, 1395.2605119286782, 1398.9580312590613, 1403.4947418929187, 10770.246082774209, 11241.943790281048, 11279.830802537968, 11394.7151321217, 11601.245919015259, 11291.096712263019, 11485.196036277464, 11514.942425287862, 11550.480228389722, 11567.016803571685, 2164.2316977473006, 2187.9343619691435, 2193.484531135182, 2202.0751284460566, 2202.581509513195, 2036.3381900882273, 2097.5595125023765, 2098.9895050524724, 2104.757952835428, 2107.6100921329603, 2143.732033495813, 2158.3956492182215, 2181.0, 2189.310367234324, 2190.616642087636, 2037.3073155127329, 2057.639913015224, 2062.6596611559, 2067.917283308666, 2072.1607748861734, 1961.6567100757452, 2048.4264405966355, 2073.481629592602, 2119.109973811003, 2124.617568837609, 11531.48108335127, 11604.593839215671, 11615.419229038514, 11626.476808543635, 11628.825567616492, 6134.96932515339, 6324.3043265240785, 6332.208473940757, 6366.840828979266, 6377.58545694533, 3649.178934739689, 3846.6538011578814, 3910.7262491625597, 3912.5304963404574, 3924.0386105404073, 1370.5819724983876, 1390.0755997261808, 1416.0441701851312, 1417.5605562275728, 1436.7629341158802, 17448.563785905328, 17456.91271543647, 17516.562085947953, 17577.91211043962, 17604.823951760576, 4879.5120487951635, 4971.726555039435, 5095.133827249377, 5106.821261255838, 5133.973205358943, 12652.0, 12671.7824380733, 12679.302638354979, 12692.80960785589, 12713.427895744713, 6273.0, 6327.968360158262, 6342.873142537216, 6345.524085693499, 6366.6180029198395, 5838.562107841929, 5896.115582662549, 5956.344802071769, 5973.074173503114, 6043.8791224175275, 4385.736855788663, 4401.295792673157, 4424.137293227854, 4452.465704115527, 4458.197524445631, 1345.9461621535224, 1391.3947432866735, 1394.0938390046551, 1405.9156450612995, 1412.1950488221614, 831.9750407487785, 854.9871751923727, 860.9182127697859, 872.0363997782359, 894.342658146262, 5928.970355148197, 5961.344252132262, 6003.399660034049, 6084.178635884099, 6197.628142311476, 584.5037395403962, 610.4140025575497, 612.6446660936646, 614.9477294429934, 619.9380061993854, 3999.300122478555, 4161.459010328698, 4211.642010429148, 4255.446791917031, 4262.531121576624, 14875.33061012257, 15392.538223853302, 15400.22998850053, 15400.691986160215, 15410.691786164214, 14488.34802433893, 14753.778693319395, 14830.110193388215, 15095.0, 15120.319585618674, 9333.719988400358, 9366.859497107549, 9372.718818435458, 9442.244620430349, 9445.952770236105, 6410.1025856381075, 6417.614943103429, 6481.449076828522, 6483.610983341015, 6609.603423794395, 12952.676183095498, 13229.140105893086, 13410.787220108572, 13562.440319363004, 13591.592252232052, 13611.727765444833, 13877.306134693023, 13939.16365018102, 14225.857741422453, 14460.0, 9603.0, 9689.370190937567, 9754.365966212174, 9867.901320986986, 9887.703368898945, 11090.778184436427, 11153.944230279121, 11154.27497212711, 11156.44217789091, 11172.050375718154, 9391.0, 9467.289953253672, 9543.9045609543, 9585.520723963913, 9755.463449510062, 9266.860997085185, 9331.86002209981, 9461.526923653928, 9564.33049686543, 9666.130048295407, 8396.664133434595, 8523.0, 8589.098144694717, 8599.52702601363, 8603.956980215058, 5579.916301255404, 5583.860403489783, 5620.887582248414, 5667.291588551431, 5807.535397168301, 5846.444587764156, 5888.617239879394, 5955.791547295824, 5957.165996760544, 6073.726682299219], "value": 5233.57303557468, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.9095044565418, 421.82494264880074, 424.28719750818624, 424.9043965107851, 427.8160391031855, 5912.911306330398, 6036.909446358308, 6040.395960403957, 6067.696615169246, 6077.665728384937, 5793.0, 5867.530597552196, 5880.794172203974, 5906.143609176666, 5911.88176236475, 4403.757793321366, 4478.507364189928, 4512.503624601291, 4533.523979982104, 4536.841210557631, 4485.932711009321, 4523.479799823013, 4530.592246697796, 4536.795844187003, 4544.636429085665, 4509.985253317994, 4517.141743068806, 4523.253663145577, 4524.796384162721, 4533.795979180944, 4419.889502762425, 4478.1116180064, 4481.462224533045, 4511.774411279423, 4518.43519560055, 3928.0, 3928.8428462861452, 3932.8623498177712, 3934.547527034399, 3946.3685810270217, 5755.30936287644, 5787.8553036174435, 5816.738246778905, 5817.941820581782, 5819.010768169422, 5115.641905066647, 5211.029713063555, 5224.451432599561, 5247.737613119329, 5260.289860868772, 6173.660448675321, 6196.535259855529, 6217.191765070557, 6251.249850017982, 6254.968725156391, 4347.5652434756585, 4398.868033958986, 4408.531222515369, 4416.293393057128, 4416.911661766779, 6369.235691717024, 6478.255000674935, 6531.8693626127215, 6556.934430655728, 6600.801975940682, 4450.866474005785, 4473.501377038729, 4480.775961201927, 4515.729056256635, 4522.66080043998, 4540.591346778806, 4545.0909818036525, 4550.931736023962, 4562.1560011398, 4570.588647021784, 5136.332276803992, 5219.0, 5224.216367544823, 5262.158054711228, 5263.473652634706, 6287.736414890635, 6319.58922670025, 6343.731253749269, 6345.777897773648, 6357.936420635734, 1554.6268895465007, 1559.204805549178, 1560.3134620766825, 1565.6164239761104, 1574.38598946411, 1038.2265212416798, 1050.4275170032197, 1051.3113910388554, 1062.5696592879897, 1063.5852017713098, 5996.4603185713495, 6027.7287522061615, 6045.818625441244, 6047.213862197887, 6064.363241859542, 6363.713632886531, 6466.838329041718, 6515.156057925847, 6517.804465866032, 6547.476201903836, 5968.432998865101, 5996.0, 6043.305019922677, 6045.153678485016, 6049.395060494004, 3419.9658003420145, 3445.155936795501, 3464.9307013860084, 3468.5317482140094, 3472.201393679468, 6612.7354905804195, 6743.460523158135, 6743.865122697519, 6754.6284954327, 6754.966225168941, 6630.734770609121, 6632.502562307846, 6646.169228846395, 6653.671215074782, 6680.826607361561, 6558.1802274715665, 6742.865142697118, 6765.1205343305055, 6791.0153027811675, 6801.727930882808, 6496.805095847132, 6521.380468855451, 6524.706388212637, 6528.445082168069, 6536.8365790855605, 6320.494360451061, 6373.3945275198785, 6403.815294170593, 6443.613383197023, 6476.676166191766, 6716.3955244028275, 6799.932000680128, 6819.5908245505425, 6824.317568243136, 6838.418734407631, 4480.6415486760325, 4523.819047238074, 4524.932126018047, 4538.183127037165, 4544.7045942013665, 6403.6798160090875, 6462.289148193789, 6507.642079685663, 6510.44661203784, 6528.608283503005, 6302.716377763103, 6314.179156709598, 6326.33573474797, 6330.272018717907, 6335.461485773761, 6159.6612186330185, 6284.151639528605, 6295.213098362705, 6304.464120549621, 6359.49124070064, 6245.125682404558, 6279.30927597973, 6305.792972459602, 6321.1782468278825, 6329.651869147241, 6235.750569977332, 6326.398992095744, 6341.143945567289, 6354.506690927536, 6372.36276372359, 6193.1329613855, 6198.442140207403, 6201.782937597162, 6212.658303793154, 6226.782062627786], "value": 4781.69893808401, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [860.6740457636373, 878.0517041595078, 883.3507372081519, 883.3551507399599, 890.3322508118911, 14494.202818844959, 15197.620059498518, 15427.922860385697, 16154.596135096628, 16229.0, 17215.397461088865, 17802.109894505287, 17962.82037179628, 18072.0, 18429.262829486805, 1000.8390267289927, 1024.3188279793928, 1030.8350663893777, 1030.8659874216378, 1031.2111234905303, 1002.8194924913513, 1006.6527048168371, 1015.735908663749, 1019.8623185869924, 1022.6625213679505, 1043.3844032021107, 1065.9946700266487, 1067.4555976451988, 1067.7223921780314, 1070.978580428391, 1034.3070143004168, 1051.9684409467727, 1054.1724746074333, 1056.5404049238568, 1059.9152067834555, 754.3098065270271, 772.8067983004249, 775.0350813237555, 777.3547955197173, 778.0313509680427, 15491.225438728019, 15504.922475387551, 15529.145896975662, 15604.29780659873, 15649.217539122998, 18060.819391806046, 18569.90715046416, 18764.62470750591, 18791.812081879143, 18830.152643131092, 14614.342354593962, 14638.853611463855, 14930.701385972328, 14949.02831315961, 15015.699686006219, 3298.960827339404, 3332.100332910125, 3365.444701624229, 3365.96634033659, 3368.8652453901814, 90915.0, 91546.08453915443, 91819.0, 92647.53676231643, 95142.52428737881, 13029.218246905217, 13291.800622990662, 14433.278336083154, 14892.627684307763, 15051.473198438001, 26641.733582664314, 26807.463850723267, 27020.0, 27121.321966950985, 27121.728782712315, 8247.752567422987, 8398.328133749286, 8404.159584041547, 8444.662213511514, 8471.872921906177, 4115.0, 4168.874933751992, 4181.728187667792, 4191.706580539394, 4200.768957707355, 4272.209641216385, 4332.783360831946, 4341.544137865541, 4383.254846676073, 4384.0355121873135, 840.8822764812932, 869.6782190589396, 876.1545108969875, 880.8986966498807, 888.1207604471526, 733.4865594084163, 742.076115236534, 746.220199891115, 755.2183490087733, 782.0263771604389, 11545.095059315287, 12822.9358853207, 12873.871261287455, 13168.144070635379, 13510.0, 722.3462766196601, 731.934125928669, 733.7431898835472, 742.2206682982846, 744.4464296349188, 5646.887062258814, 6328.335524769925, 6543.705533251015, 6683.565568238147, 6763.688832499918, 75473.0, 76738.0, 79031.60484197657, 80810.59594701989, 83870.58064709637, 73128.0, 73250.63374683092, 74490.5101897959, 74778.0, 77119.0, 63609.36390636034, 64634.0, 64901.999999999054, 66813.33186668168, 67196.6640166796, 12630.0, 13640.522581709592, 13706.24615646149, 13764.17414955106, 13789.379477923718, 33207.16982075467, 33445.33109337751, 33990.0, 34049.65950340465, 35395.64604353924, 41295.38056929209, 42462.5753742471, 42778.0, 42827.78586107049, 43758.56241437672, 17408.47774566765, 17617.295308187528, 17676.2045707946, 17691.469255922344, 18105.818941810412, 19139.23443062262, 19148.329808456638, 19196.424107276805, 19236.03819808976, 19506.0, 17168.914155429142, 17288.827111729224, 17392.0, 17471.126443677513, 17596.73604895953, 16643.41748038813, 17104.486865394058, 17198.570035749206, 17228.310867565157, 17721.291148354438, 17525.561860953578, 17578.384756533458, 17747.46757597274, 17792.733109003115, 18234.45296641103, 13154.73690526165, 13159.342032898125, 13171.868281317064, 13405.329733513481, 13531.511533731478, 14455.641256140098, 14535.345909434312, 14620.122792632475, 14726.263686815402, 14756.0], "value": 8385.600464054734, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 112.0, 110.0, 109.0, 110.0, 110.0, 109.0, 111.0, 112.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 118.0, 118.0, 165.0, 118.0, 123.0, 121.0, 119.0, 142.0, 120.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 163.0, 163.0, 166.0, 167.0, 170.0, 169.0, 164.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 75.0, 91.0, 75.0, 76.0, 76.0, 77.0, 90.0, 75.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 98.0, 81.0, 82.0, 82.0, 98.0, 83.0, 82.0, 107.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 97.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 49.0, 46.0, 47.0, 46.0, 50.0, 53.0, 46.0, 46.0], "value": 47.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 80.0, 81.0, 88.0, 82.0, 81.0, 80.0, 82.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 128.0, 123.0, 125.0, 125.0, 132.0, 124.0, 125.0, 174.0, 140.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 182.0, 175.0, 196.0, 185.0, 181.0, 190.0, 173.0, 181.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 70.0, 66.0, 66.0, 66.0, 66.0, 67.0, 71.0], "value": 67.9, "unit": "score"}]}]} 07:29:35 INFO - Return code: 0 07:29:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:29:35 INFO - # TBPL SUCCESS # 07:29:35 INFO - Running post-action listener: _resource_record_post_action 07:29:35 INFO - [mozharness: 2017-05-05 14:29:35.583041Z] Finished run-tests step (success) 07:29:35 INFO - Running post-run listener: _resource_record_post_run 07:29:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355713024; Read time: 12; Write time: 254600 07:29:35 INFO - TinderboxPrint: CPU usage
13.2% 07:29:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:29:35 INFO - TinderboxPrint: I/O write bytes / time
355,713,024 / 254,600 07:29:35 INFO - TinderboxPrint: CPU idle
8,256.1 (86.8%) 07:29:35 INFO - TinderboxPrint: CPU user
1,200.1 (12.6%) 07:29:35 INFO - TinderboxPrint: Swap in / out
0 / 0 07:29:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100683776; Read time: 0; Write time: 95572 07:29:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 255029248; Read time: 0; Write time: 159028 07:29:36 INFO - Running post-run listener: _upload_blobber_files 07:29:36 INFO - Blob upload gear active. 07:29:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29:36 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 07:29:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:29:36 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:37 INFO - (blobuploader) - INFO - Done attempting. 07:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:38 INFO - (blobuploader) - INFO - Done attempting. 07:29:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:29:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:29:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:42 INFO - (blobuploader) - INFO - Done attempting. 07:29:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:29:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:43 INFO - (blobuploader) - INFO - Done attempting. 07:29:43 INFO - (blobuploader) - INFO - Iteration through files over. 07:29:43 INFO - Return code: 0 07:29:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:29:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:29:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/046390264f8ef1dc5c9460fabd196b8f938b8834b2ffcb25130f9f182adb9d5a3eec2590b8376b1dd15efe67f1b43c83d1d3bee30c0c479c0aeca3d1147ebfc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46c71aef651ac6bc54bd81829f74c03a6173905360207a0454b2d1fa109fe53c69dc44b555c816380489603c302df0c327b1b83f19caca6307832ded718ed658", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/813ef7a2255e10f6de431d9236aa5b08435099620224fe5b2b3eaae88660e2574bc8a345bbd6546e4a179ce13091a767ed9bb9f75fb420390f4fc7ccaa130aa2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77f463d5a0a3aec789062828c4478fbe20bc63090289c82e1b2900e11072db99e4dd1e227c1db9c61fbab7b23742fce0019fed7c52e69165bee81e45b7304a1b"} 07:29:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:29:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:29:43 INFO - Contents: 07:29:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/046390264f8ef1dc5c9460fabd196b8f938b8834b2ffcb25130f9f182adb9d5a3eec2590b8376b1dd15efe67f1b43c83d1d3bee30c0c479c0aeca3d1147ebfc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46c71aef651ac6bc54bd81829f74c03a6173905360207a0454b2d1fa109fe53c69dc44b555c816380489603c302df0c327b1b83f19caca6307832ded718ed658", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/813ef7a2255e10f6de431d9236aa5b08435099620224fe5b2b3eaae88660e2574bc8a345bbd6546e4a179ce13091a767ed9bb9f75fb420390f4fc7ccaa130aa2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77f463d5a0a3aec789062828c4478fbe20bc63090289c82e1b2900e11072db99e4dd1e227c1db9c61fbab7b23742fce0019fed7c52e69165bee81e45b7304a1b"} 07:29:43 INFO - Running post-run listener: copy_logs_to_upload_dir 07:29:43 INFO - Copying logs to upload dir... 07:29:43 INFO - mkdir: /builds/slave/test/build/upload/logs 07:29:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.365262 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-05-05 07:29:42.621486) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:29:42.625863) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/046390264f8ef1dc5c9460fabd196b8f938b8834b2ffcb25130f9f182adb9d5a3eec2590b8376b1dd15efe67f1b43c83d1d3bee30c0c479c0aeca3d1147ebfc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46c71aef651ac6bc54bd81829f74c03a6173905360207a0454b2d1fa109fe53c69dc44b555c816380489603c302df0c327b1b83f19caca6307832ded718ed658", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/813ef7a2255e10f6de431d9236aa5b08435099620224fe5b2b3eaae88660e2574bc8a345bbd6546e4a179ce13091a767ed9bb9f75fb420390f4fc7ccaa130aa2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77f463d5a0a3aec789062828c4478fbe20bc63090289c82e1b2900e11072db99e4dd1e227c1db9c61fbab7b23742fce0019fed7c52e69165bee81e45b7304a1b"} build_url:https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/eBanjAKoTzSO6ZvRvgOtZg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/046390264f8ef1dc5c9460fabd196b8f938b8834b2ffcb25130f9f182adb9d5a3eec2590b8376b1dd15efe67f1b43c83d1d3bee30c0c479c0aeca3d1147ebfc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46c71aef651ac6bc54bd81829f74c03a6173905360207a0454b2d1fa109fe53c69dc44b555c816380489603c302df0c327b1b83f19caca6307832ded718ed658", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/813ef7a2255e10f6de431d9236aa5b08435099620224fe5b2b3eaae88660e2574bc8a345bbd6546e4a179ce13091a767ed9bb9f75fb420390f4fc7ccaa130aa2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77f463d5a0a3aec789062828c4478fbe20bc63090289c82e1b2900e11072db99e4dd1e227c1db9c61fbab7b23742fce0019fed7c52e69165bee81e45b7304a1b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:29:42.654211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:29:42.654574) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1493993335.845906-433265178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:29:42.738685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:29:42.739135) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:29:42.739539) ========= ========= Total master_lag: 0.19 =========