builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1494280371.14 results: success (0) revision: bab7046ee2d82345d7d5b33b8ae4009c7e365176 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:51.144666) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:51.145148) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:51.145423) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:51.160558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:51.160955) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-08 14:52:51-- 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% 46.2M=0s 2017-05-08 14:52:51 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:51.268293) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:51.271693) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016145 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:51.321400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 14:52:51.324896) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bab7046ee2d82345d7d5b33b8ae4009c7e365176 --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 bab7046ee2d82345d7d5b33b8ae4009c7e365176 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-08 14:52:51,906 truncating revision to first 12 chars 2017-05-08 14:52:51,907 Setting DEBUG logging. 2017-05-08 14:52:51,907 attempt 1/10 2017-05-08 14:52:51,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bab7046ee2d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 14:52:52,862 unpacking tar archive at: mozilla-central-bab7046ee2d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.268796 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 14:52:52.607473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:52.610577) ========= script_repo_revision: bab7046ee2d82345d7d5b33b8ae4009c7e365176 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:52.610968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:52.611229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:52.621703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-05-08 14:52:52.622095) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:52:53 INFO - MultiFileLogger online at 20170508 14:52:53 in /builds/slave/test 14:52:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:52:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:52:53 INFO - {'append_to_log': False, 14:52:53 INFO - 'base_work_dir': '/builds/slave/test', 14:52:53 INFO - 'blob_upload_branch': 'Firefox', 14:52:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:52:53 INFO - 'branch': 'Firefox', 14:52:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:52:53 INFO - 'config_files': ('talos/linux_config.py',), 14:52:53 INFO - 'default_actions': ('clobber', 14:52:53 INFO - 'read-buildbot-config', 14:52:53 INFO - 'download-and-extract', 14:52:53 INFO - 'populate-webroot', 14:52:53 INFO - 'create-virtualenv', 14:52:53 INFO - 'install', 14:52:53 INFO - 'run-tests'), 14:52:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:52:53 INFO - 'download_minidump_stackwalk': True, 14:52:53 INFO - 'download_symbols': 'ondemand', 14:52:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:52:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:52:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:52:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:52:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:52:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:52:53 INFO - 'gecko_profile': False, 14:52:53 INFO - 'gecko_profile_interval': 0, 14:52:53 INFO - 'installer_path': 'installer.exe', 14:52:53 INFO - 'log_level': 'info', 14:52:53 INFO - 'log_name': 'talos', 14:52:53 INFO - 'log_to_console': True, 14:52:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:52:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:52:53 INFO - 'opt_config_files': (), 14:52:53 INFO - 'pip_index': False, 14:52:53 INFO - 'suite': 'dromaeojs', 14:52:53 INFO - 'system_bits': '32', 14:52:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:52:53 INFO - 'title': 'talos-linux64-ix-026', 14:52:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:52:53 INFO - 'use_talos_json': True, 14:52:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:52:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:52:53 INFO - 'work_dir': 'build'} 14:52:53 INFO - [mozharness: 2017-05-08 21:52:53.297024Z] Running clobber step. 14:52:53 INFO - Running pre-action listener: _resource_record_pre_action 14:52:53 INFO - Running main action method: clobber 14:52:53 INFO - rmtree: /builds/slave/test/build 14:52:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:52:54 INFO - Running post-action listener: _resource_record_post_action 14:52:54 INFO - [mozharness: 2017-05-08 21:52:54.753084Z] Finished clobber step (success) 14:52:54 INFO - [mozharness: 2017-05-08 21:52:54.753184Z] Running read-buildbot-config step. 14:52:54 INFO - Running pre-action listener: _resource_record_pre_action 14:52:54 INFO - Running main action method: read_buildbot_config 14:52:54 INFO - Using buildbot properties: 14:52:54 INFO - { 14:52:54 INFO - "project": "", 14:52:54 INFO - "product": "firefox", 14:52:54 INFO - "who": "kwierso@gmail.com", 14:52:54 INFO - "installer_path": "public/build/target.tar.bz2", 14:52:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:52:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:52:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 14:52:54 INFO - "stage_platform": "linux64-pgo", 14:52:54 INFO - "basedir": "/builds/slave/test", 14:52:54 INFO - "buildnumber": 186, 14:52:54 INFO - "platform": "ubuntu64_hw", 14:52:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:52:54 INFO - "slavebuilddir": "test", 14:52:54 INFO - "taskId": "TZdwlq_ERYudjpTE2nfSsA", 14:52:54 INFO - "branch": "mozilla-central", 14:52:54 INFO - "script_repo_revision": "production", 14:52:54 INFO - "revision": "bab7046ee2d82345d7d5b33b8ae4009c7e365176", 14:52:54 INFO - "slavename": "talos-linux64-ix-026", 14:52:54 INFO - "repo_path": "mozilla-central" 14:52:54 INFO - } 14:52:54 INFO - Finding installer, test and symbols from parent task. 14:52:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TZdwlq_ERYudjpTE2nfSsA'}, attempt #1 14:52:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TZdwlq_ERYudjpTE2nfSsA'}, attempt #1 14:52:55 INFO - Task dependencies: WZGSa1juRl6ql6NFpC4WSA 14:52:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA'}, attempt #1 14:52:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.tar.bz2 14:52:56 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/test_packages.json 14:52:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.crashreporter-symbols.zip 14:52:56 INFO - Running post-action listener: _resource_record_post_action 14:52:56 INFO - [mozharness: 2017-05-08 21:52:56.211471Z] Finished read-buildbot-config step (success) 14:52:56 INFO - [mozharness: 2017-05-08 21:52:56.211691Z] Running download-and-extract step. 14:52:56 INFO - Running pre-action listener: _resource_record_pre_action 14:52:56 INFO - Running main action method: download_and_extract 14:52:56 INFO - mkdir: /builds/slave/test/build/tests 14:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:56 INFO - trying https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.test_packages.json 14:52:56 INFO - Downloading https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:52:56 INFO - Downloaded 986 bytes. 14:52:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:52:56 INFO - Using the following test package requirements: 14:52:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:52:56 INFO - u'common': [u'target.common.tests.zip'], 14:52:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:52:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:52:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:52:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:52:56 INFO - u'mozbase': [u'target.common.tests.zip'], 14:52:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:52:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:52:56 INFO - u'web-platform': [u'target.common.tests.zip', 14:52:56 INFO - u'target.web-platform.tests.zip'], 14:52:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:52:56 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:52:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.common.tests.zip 14:52:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:52:56 INFO - Fetch https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.common.tests.zip into memory 14:52:57 INFO - Content-Length response header: 60564776 14:52:57 INFO - Bytes received: 60564776 14:53:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:53:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.common.tests.zip 14:53:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:53:07 INFO - Fetch https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.common.tests.zip into memory 14:53:08 INFO - Content-Length response header: 60564776 14:53:08 INFO - Bytes received: 60564776 14:53:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.talos.tests.zip 14:53:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:53:19 INFO - Fetch https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.talos.tests.zip into memory 14:53:20 INFO - Content-Length response header: 14409362 14:53:20 INFO - Bytes received: 14409362 14:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:20 INFO - trying https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.tar.bz2 14:53:20 INFO - Downloading https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:53:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:53:21 INFO - Downloaded 64095250 bytes. 14:53:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.tar.bz2 14:53:21 INFO - mkdir: /builds/slave/test/properties 14:53:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:53:21 INFO - Writing to file /builds/slave/test/properties/build_url 14:53:21 INFO - Contents: 14:53:21 INFO - build_url:https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.tar.bz2 14:53:21 INFO - Running post-action listener: _resource_record_post_action 14:53:21 INFO - Running post-action listener: set_extra_try_arguments 14:53:21 INFO - [mozharness: 2017-05-08 21:53:21.876230Z] Finished download-and-extract step (success) 14:53:21 INFO - [mozharness: 2017-05-08 21:53:21.876327Z] Running populate-webroot step. 14:53:21 INFO - Running pre-action listener: _resource_record_pre_action 14:53:21 INFO - Running main action method: populate_webroot 14:53:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:53:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:53:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:53:21 INFO - '--tppagecycles', 14:53:21 INFO - '7'], 14:53:21 INFO - 'tests': ['tsvgm']}}, 14:53:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:53:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:53:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:53:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:53:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:53:21 INFO - 'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:53:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:53:21 INFO - 'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['damp', 'tps']}, 14:53:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:53:21 INFO - 'tests': ['damp', 'tps']}, 14:53:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['dromaeo_dom']}, 14:53:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:53:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:53:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:53:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['a11yr', 14:53:21 INFO - 'ts_paint', 14:53:21 INFO - 'tpaint', 14:53:21 INFO - 'sessionrestore', 14:53:21 INFO - 'sessionrestore_no_auto_restore', 14:53:21 INFO - 'tabpaint']}, 14:53:21 INFO - 'other-e10s': {'tests': ['a11yr', 14:53:21 INFO - 'ts_paint', 14:53:21 INFO - 'tpaint', 14:53:21 INFO - 'sessionrestore', 14:53:21 INFO - 'sessionrestore_no_auto_restore', 14:53:21 INFO - 'tabpaint']}, 14:53:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:53:21 INFO - 'ts_paint', 14:53:21 INFO - 'tpaint', 14:53:21 INFO - 'sessionrestore', 14:53:21 INFO - 'sessionrestore_no_auto_restore', 14:53:21 INFO - 'tabpaint']}, 14:53:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:53:21 INFO - 'ts_paint', 14:53:21 INFO - 'tpaint', 14:53:21 INFO - 'sessionrestore', 14:53:21 INFO - 'sessionrestore_no_auto_restore', 14:53:21 INFO - 'tabpaint']}, 14:53:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['a11yr', 14:53:21 INFO - 'ts_paint', 14:53:21 INFO - 'tpaint', 14:53:21 INFO - 'sessionrestore', 14:53:21 INFO - 'sessionrestore_no_auto_restore', 14:53:21 INFO - 'tabpaint']}, 14:53:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['a11yr', 14:53:21 INFO - 'ts_paint', 14:53:21 INFO - 'tpaint', 14:53:21 INFO - 'sessionrestore', 14:53:21 INFO - 'sessionrestore_no_auto_restore', 14:53:21 INFO - 'tabpaint']}, 14:53:21 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:53:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:53:21 INFO - 'bloom_basic_ref']}, 14:53:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['tsvgx', 14:53:21 INFO - 'tsvgr_opacity', 14:53:21 INFO - 'tart', 14:53:21 INFO - 'tscrollx', 14:53:21 INFO - 'cart', 14:53:21 INFO - 'tsvg_static']}, 14:53:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:53:21 INFO - 'tsvgr_opacity', 14:53:21 INFO - 'tart', 14:53:21 INFO - 'tscrollx', 14:53:21 INFO - 'cart', 14:53:21 INFO - 'tsvg_static']}, 14:53:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:53:21 INFO - 'talos_options': ['--disable-e10s'], 14:53:21 INFO - 'tests': ['tp5o']}, 14:53:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:53:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:53:21 INFO - 'talos_options': ['--disable-e10s', 14:53:21 INFO - '--xperf_path', 14:53:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:21 INFO - 'tests': ['tp5n']}, 14:53:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:53:21 INFO - 'talos_options': ['--xperf_path', 14:53:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:21 INFO - 'tests': ['tp5n']}}, 14:53:21 INFO - 'talos.zip': {'path': '', 14:53:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:53:21 INFO - Running post-action listener: _resource_record_post_action 14:53:21 INFO - [mozharness: 2017-05-08 21:53:21.890033Z] Finished populate-webroot step (success) 14:53:21 INFO - [mozharness: 2017-05-08 21:53:21.890122Z] Running create-virtualenv step. 14:53:21 INFO - Running pre-action listener: _resource_record_pre_action 14:53:21 INFO - Running main action method: create_virtualenv 14:53:21 INFO - Creating virtualenv /builds/slave/test/build/venv 14:53:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:53:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:53:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:53:21 INFO - Using real prefix '/usr' 14:53:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:53:22 INFO - Installing distribute.............................................................................................................................................................................................done. 14:53:24 INFO - Installing pip.................done. 14:53:24 INFO - Return code: 0 14:53:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:53:24 INFO - Reading from file tmpfile_stdout 14:53:24 INFO - Output received: 14:53:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:53:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:24 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 0x1f9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2311770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:53:24 INFO - Using env: {'DISPLAY': ':0', 14:53:24 INFO - 'HOME': '/home/cltbld', 14:53:24 INFO - 'LANG': 'en_US.UTF-8', 14:53:24 INFO - 'LANGUAGE': 'en_US:en', 14:53:24 INFO - 'LOGNAME': 'cltbld', 14:53:24 INFO - 'MAIL': '/var/mail/cltbld', 14:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:24 INFO - 'MOZ_NO_REMOTE': '1', 14:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:24 INFO - 'NO_EM_RESTART': '1', 14:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:24 INFO - 'PWD': '/builds/slave/test', 14:53:24 INFO - 'SHELL': '/bin/bash', 14:53:24 INFO - 'SHLVL': '1', 14:53:24 INFO - 'TERM': 'linux', 14:53:24 INFO - 'TMOUT': '86400', 14:53:24 INFO - 'USER': 'cltbld', 14:53:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:24 INFO - '_': '/tools/buildbot/bin/python'} 14:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:53:24 INFO - Cleaning up... 14:53:24 INFO - Return code: 0 14:53:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:24 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 0x1f9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2311770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:53:24 INFO - Using env: {'DISPLAY': ':0', 14:53:24 INFO - 'HOME': '/home/cltbld', 14:53:24 INFO - 'LANG': 'en_US.UTF-8', 14:53:24 INFO - 'LANGUAGE': 'en_US:en', 14:53:24 INFO - 'LOGNAME': 'cltbld', 14:53:24 INFO - 'MAIL': '/var/mail/cltbld', 14:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:24 INFO - 'MOZ_NO_REMOTE': '1', 14:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:24 INFO - 'NO_EM_RESTART': '1', 14:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:24 INFO - 'PWD': '/builds/slave/test', 14:53:24 INFO - 'SHELL': '/bin/bash', 14:53:24 INFO - 'SHLVL': '1', 14:53:24 INFO - 'TERM': 'linux', 14:53:24 INFO - 'TMOUT': '86400', 14:53:24 INFO - 'USER': 'cltbld', 14:53:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:24 INFO - '_': '/tools/buildbot/bin/python'} 14:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:25 INFO - Downloading/unpacking psutil>=3.1.1 14:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:53:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:26 INFO - Installing collected packages: psutil 14:53:26 INFO - Running setup.py install for psutil 14:53:26 INFO - building 'psutil._psutil_linux' extension 14:53:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:53:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:53:26 INFO - building 'psutil._psutil_posix' extension 14:53:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:53:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:53:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:26 INFO - Successfully installed psutil 14:53:26 INFO - Cleaning up... 14:53:26 INFO - Return code: 0 14:53:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:26 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 0x1f9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2311770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:53:26 INFO - Using env: {'DISPLAY': ':0', 14:53:26 INFO - 'HOME': '/home/cltbld', 14:53:26 INFO - 'LANG': 'en_US.UTF-8', 14:53:26 INFO - 'LANGUAGE': 'en_US:en', 14:53:26 INFO - 'LOGNAME': 'cltbld', 14:53:26 INFO - 'MAIL': '/var/mail/cltbld', 14:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:26 INFO - 'MOZ_NO_REMOTE': '1', 14:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:26 INFO - 'NO_EM_RESTART': '1', 14:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:26 INFO - 'PWD': '/builds/slave/test', 14:53:26 INFO - 'SHELL': '/bin/bash', 14:53:26 INFO - 'SHLVL': '1', 14:53:26 INFO - 'TERM': 'linux', 14:53:26 INFO - 'TMOUT': '86400', 14:53:26 INFO - 'USER': 'cltbld', 14:53:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:26 INFO - '_': '/tools/buildbot/bin/python'} 14:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:53:28 INFO - Installing collected packages: mozsystemmonitor 14:53:28 INFO - Running setup.py install for mozsystemmonitor 14:53:28 INFO - Successfully installed mozsystemmonitor 14:53:28 INFO - Cleaning up... 14:53:28 INFO - Return code: 0 14:53:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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', '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 0x1f9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2311770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:53: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 jsonschema==2.5.1 14:53:28 INFO - Using env: {'DISPLAY': ':0', 14:53:28 INFO - 'HOME': '/home/cltbld', 14:53:28 INFO - 'LANG': 'en_US.UTF-8', 14:53:28 INFO - 'LANGUAGE': 'en_US:en', 14:53:28 INFO - 'LOGNAME': 'cltbld', 14:53:28 INFO - 'MAIL': '/var/mail/cltbld', 14:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:28 INFO - 'MOZ_NO_REMOTE': '1', 14:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:28 INFO - 'NO_EM_RESTART': '1', 14:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:28 INFO - 'PWD': '/builds/slave/test', 14:53:28 INFO - 'SHELL': '/bin/bash', 14:53:28 INFO - 'SHLVL': '1', 14:53:28 INFO - 'TERM': 'linux', 14:53:28 INFO - 'TMOUT': '86400', 14:53:28 INFO - 'USER': 'cltbld', 14:53:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:28 INFO - '_': '/tools/buildbot/bin/python'} 14:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:28 INFO - Downloading/unpacking jsonschema==2.5.1 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:53:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:53:30 INFO - warning: no files found matching '*.txt' 14:53:30 INFO - no previously-included directories found matching 'build' 14:53:30 INFO - no previously-included directories found matching 'dist' 14:53:30 INFO - no previously-included directories found matching '.git*' 14:53:30 INFO - Installing collected packages: jsonschema, functools32 14:53:30 INFO - Running setup.py install for functools32 14:53:30 INFO - warning: no files found matching '*.txt' 14:53:30 INFO - no previously-included directories found matching 'build' 14:53:30 INFO - no previously-included directories found matching 'dist' 14:53:30 INFO - no previously-included directories found matching '.git*' 14:53:30 INFO - Successfully installed jsonschema functools32 14:53:30 INFO - Cleaning up... 14:53:30 INFO - Return code: 0 14:53:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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', '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 0x1f9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2311770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:53: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 functools32==3.2.3-2 14:53:30 INFO - Using env: {'DISPLAY': ':0', 14:53:30 INFO - 'HOME': '/home/cltbld', 14:53:30 INFO - 'LANG': 'en_US.UTF-8', 14:53:30 INFO - 'LANGUAGE': 'en_US:en', 14:53:30 INFO - 'LOGNAME': 'cltbld', 14:53:30 INFO - 'MAIL': '/var/mail/cltbld', 14:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:30 INFO - 'MOZ_NO_REMOTE': '1', 14:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:30 INFO - 'NO_EM_RESTART': '1', 14:53:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:30 INFO - 'PWD': '/builds/slave/test', 14:53:30 INFO - 'SHELL': '/bin/bash', 14:53:30 INFO - 'SHLVL': '1', 14:53:30 INFO - 'TERM': 'linux', 14:53:30 INFO - 'TMOUT': '86400', 14:53:30 INFO - 'USER': 'cltbld', 14:53:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:30 INFO - '_': '/tools/buildbot/bin/python'} 14:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:53:30 INFO - Cleaning up... 14:53:30 INFO - Return code: 0 14:53:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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', '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 0x1f9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2311770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:53: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 blobuploader==1.2.4 14:53:30 INFO - Using env: {'DISPLAY': ':0', 14:53:30 INFO - 'HOME': '/home/cltbld', 14:53:30 INFO - 'LANG': 'en_US.UTF-8', 14:53:30 INFO - 'LANGUAGE': 'en_US:en', 14:53:30 INFO - 'LOGNAME': 'cltbld', 14:53:30 INFO - 'MAIL': '/var/mail/cltbld', 14:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:30 INFO - 'MOZ_NO_REMOTE': '1', 14:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:30 INFO - 'NO_EM_RESTART': '1', 14:53:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:30 INFO - 'PWD': '/builds/slave/test', 14:53:30 INFO - 'SHELL': '/bin/bash', 14:53:30 INFO - 'SHLVL': '1', 14:53:30 INFO - 'TERM': 'linux', 14:53:30 INFO - 'TMOUT': '86400', 14:53:30 INFO - 'USER': 'cltbld', 14:53:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:30 INFO - '_': '/tools/buildbot/bin/python'} 14:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:53:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:53:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53:33 INFO - Downloading docopt-0.6.1.tar.gz 14:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:53:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:53:33 INFO - Running setup.py install for blobuploader 14:53:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:53:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:53:33 INFO - Running setup.py install for requests 14:53:34 INFO - Running setup.py install for docopt 14:53:34 INFO - Successfully installed blobuploader requests docopt 14:53:34 INFO - Cleaning up... 14:53:34 INFO - Return code: 0 14:53:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:34 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 0x1f9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2311770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:53:34 INFO - Using env: {'DISPLAY': ':0', 14:53:34 INFO - 'HOME': '/home/cltbld', 14:53:34 INFO - 'LANG': 'en_US.UTF-8', 14:53:34 INFO - 'LANGUAGE': 'en_US:en', 14:53:34 INFO - 'LOGNAME': 'cltbld', 14:53:34 INFO - 'MAIL': '/var/mail/cltbld', 14:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:34 INFO - 'MOZ_NO_REMOTE': '1', 14:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:34 INFO - 'NO_EM_RESTART': '1', 14:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:34 INFO - 'PWD': '/builds/slave/test', 14:53:34 INFO - 'SHELL': '/bin/bash', 14:53:34 INFO - 'SHLVL': '1', 14:53:34 INFO - 'TERM': 'linux', 14:53:34 INFO - 'TMOUT': '86400', 14:53:34 INFO - 'USER': 'cltbld', 14:53:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:34 INFO - '_': '/tools/buildbot/bin/python'} 14:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:53:34 INFO - Running setup.py (path:/tmp/pip-KX4xtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:53:34 INFO - Running setup.py (path:/tmp/pip-Jcbocg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:53:34 INFO - Running setup.py (path:/tmp/pip-OFHdct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:53:34 INFO - Running setup.py (path:/tmp/pip-Im6HLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:53:34 INFO - Running setup.py (path:/tmp/pip-BTFrQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:53:34 INFO - Running setup.py (path:/tmp/pip-wvcN8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:53:34 INFO - Running setup.py (path:/tmp/pip-CdWZEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:53:35 INFO - Running setup.py (path:/tmp/pip-lpNzVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:53:35 INFO - Running setup.py (path:/tmp/pip-R06FvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:53:35 INFO - Running setup.py (path:/tmp/pip-QN1jIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:53:35 INFO - Running setup.py (path:/tmp/pip-JY8qqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:53:35 INFO - Running setup.py (path:/tmp/pip-I24Vbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:53:35 INFO - Running setup.py (path:/tmp/pip-9pKwqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:53:35 INFO - Running setup.py (path:/tmp/pip-WUBB6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:35 INFO - Running setup.py (path:/tmp/pip-7PRM4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:53:35 INFO - Running setup.py (path:/tmp/pip-LYSPyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:53:35 INFO - Running setup.py (path:/tmp/pip-4vBF23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:53:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:53:35 INFO - Running setup.py install for manifestparser 14:53:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:53:35 INFO - Running setup.py install for mozcrash 14:53:35 INFO - Running setup.py install for mozdebug 14:53:36 INFO - Running setup.py install for mozdevice 14:53:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:53:36 INFO - Running setup.py install for mozfile 14:53:36 INFO - Running setup.py install for mozhttpd 14:53:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:53:36 INFO - Running setup.py install for mozinfo 14:53:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:53:36 INFO - Running setup.py install for mozInstall 14:53:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:53:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:53:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:53:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:53:36 INFO - Running setup.py install for mozleak 14:53:36 INFO - Running setup.py install for mozlog 14:53:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:53:36 INFO - Running setup.py install for moznetwork 14:53:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:53:36 INFO - Running setup.py install for mozprocess 14:53:36 INFO - Running setup.py install for mozprofile 14:53:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:53:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:53:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:53:37 INFO - Running setup.py install for mozrunner 14:53:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:53:37 INFO - Running setup.py install for mozscreenshot 14:53:37 INFO - Running setup.py install for moztest 14:53:37 INFO - Running setup.py install for mozversion 14:53:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:53:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:53:37 INFO - Cleaning up... 14:53:37 INFO - Return code: 0 14:53:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:37 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 0x1f9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2311770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:53:37 INFO - Using env: {'DISPLAY': ':0', 14:53:37 INFO - 'HOME': '/home/cltbld', 14:53:37 INFO - 'LANG': 'en_US.UTF-8', 14:53:37 INFO - 'LANGUAGE': 'en_US:en', 14:53:37 INFO - 'LOGNAME': 'cltbld', 14:53:37 INFO - 'MAIL': '/var/mail/cltbld', 14:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:37 INFO - 'MOZ_NO_REMOTE': '1', 14:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:37 INFO - 'NO_EM_RESTART': '1', 14:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:37 INFO - 'PWD': '/builds/slave/test', 14:53:37 INFO - 'SHELL': '/bin/bash', 14:53:37 INFO - 'SHLVL': '1', 14:53:37 INFO - 'TERM': 'linux', 14:53:37 INFO - 'TMOUT': '86400', 14:53:37 INFO - 'USER': 'cltbld', 14:53:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:37 INFO - '_': '/tools/buildbot/bin/python'} 14:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:53:37 INFO - Running setup.py (path:/tmp/pip-5BQak9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:53:37 INFO - Running setup.py (path:/tmp/pip-RRB83A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:53:37 INFO - Running setup.py (path:/tmp/pip-Whm0gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:53:37 INFO - Running setup.py (path:/tmp/pip-rSqopu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:53:38 INFO - Running setup.py (path:/tmp/pip-tGncih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:53:38 INFO - Running setup.py (path:/tmp/pip-DSVAu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:53:38 INFO - Running setup.py (path:/tmp/pip-cl8De9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:53:38 INFO - Running setup.py (path:/tmp/pip-kFDemc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:53:38 INFO - Running setup.py (path:/tmp/pip-vUfpKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:53:38 INFO - Running setup.py (path:/tmp/pip-bxxKEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:53:38 INFO - Running setup.py (path:/tmp/pip-pNbahg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:53:38 INFO - Running setup.py (path:/tmp/pip-s3FyoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:53:38 INFO - Running setup.py (path:/tmp/pip-pWVXym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:53:38 INFO - Running setup.py (path:/tmp/pip-aymwVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:38 INFO - Running setup.py (path:/tmp/pip-WwkvZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:53:38 INFO - Running setup.py (path:/tmp/pip-2PK6IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:53:38 INFO - Running setup.py (path:/tmp/pip-e4ekNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:40 INFO - Downloading blessings-1.6.tar.gz 14:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:53:40 INFO - Installing collected packages: blessings 14:53:40 INFO - Running setup.py install for blessings 14:53:40 INFO - Successfully installed blessings 14:53:40 INFO - Cleaning up... 14:53:40 INFO - Return code: 0 14:53:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:53:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:53:40 INFO - Reading from file tmpfile_stdout 14:53:40 INFO - Current package versions: 14:53:40 INFO - argparse == 1.2.1 14:53:40 INFO - blessings == 1.6 14:53:40 INFO - blobuploader == 1.2.4 14:53:40 INFO - docopt == 0.6.1 14:53:40 INFO - functools32 == 3.2.3-2 14:53:40 INFO - jsonschema == 2.5.1 14:53:40 INFO - manifestparser == 1.1 14:53:40 INFO - mozInstall == 1.12 14:53:40 INFO - mozcrash == 1.0 14:53:40 INFO - mozdebug == 0.1 14:53:40 INFO - mozdevice == 0.50 14:53:40 INFO - mozfile == 1.2 14:53:40 INFO - mozhttpd == 0.7 14:53:40 INFO - mozinfo == 0.9 14:53:40 INFO - mozleak == 0.1 14:53:40 INFO - mozlog == 3.4 14:53:40 INFO - moznetwork == 0.27 14:53:40 INFO - mozprocess == 0.25 14:53:40 INFO - mozprofile == 0.28 14:53:40 INFO - mozrunner == 6.13 14:53:40 INFO - mozscreenshot == 0.1 14:53:40 INFO - mozsystemmonitor == 0.3 14:53:40 INFO - moztest == 0.8 14:53:40 INFO - mozversion == 1.4 14:53:40 INFO - psutil == 3.1.1 14:53:40 INFO - requests == 1.2.3 14:53:40 INFO - wsgiref == 0.1.2 14:53:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:40 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 0x1f9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2311770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:53:40 INFO - Using env: {'DISPLAY': ':0', 14:53:40 INFO - 'HOME': '/home/cltbld', 14:53:40 INFO - 'LANG': 'en_US.UTF-8', 14:53:40 INFO - 'LANGUAGE': 'en_US:en', 14:53:40 INFO - 'LOGNAME': 'cltbld', 14:53:40 INFO - 'MAIL': '/var/mail/cltbld', 14:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:40 INFO - 'MOZ_NO_REMOTE': '1', 14:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:40 INFO - 'NO_EM_RESTART': '1', 14:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:40 INFO - 'PWD': '/builds/slave/test', 14:53:40 INFO - 'SHELL': '/bin/bash', 14:53:40 INFO - 'SHLVL': '1', 14:53:40 INFO - 'TERM': 'linux', 14:53:40 INFO - 'TMOUT': '86400', 14:53:40 INFO - 'USER': 'cltbld', 14:53:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:40 INFO - '_': '/tools/buildbot/bin/python'} 14:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:53:40 INFO - Cleaning up... 14:53:40 INFO - Return code: 0 14:53:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:40 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 0x1f9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2311770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:53:40 INFO - Using env: {'DISPLAY': ':0', 14:53:40 INFO - 'HOME': '/home/cltbld', 14:53:40 INFO - 'LANG': 'en_US.UTF-8', 14:53:40 INFO - 'LANGUAGE': 'en_US:en', 14:53:40 INFO - 'LOGNAME': 'cltbld', 14:53:40 INFO - 'MAIL': '/var/mail/cltbld', 14:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:40 INFO - 'MOZ_NO_REMOTE': '1', 14:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:40 INFO - 'NO_EM_RESTART': '1', 14:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:40 INFO - 'PWD': '/builds/slave/test', 14:53:40 INFO - 'SHELL': '/bin/bash', 14:53:40 INFO - 'SHLVL': '1', 14:53:40 INFO - 'TERM': 'linux', 14:53:40 INFO - 'TMOUT': '86400', 14:53:40 INFO - 'USER': 'cltbld', 14:53:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:40 INFO - '_': '/tools/buildbot/bin/python'} 14:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:53:41 INFO - Cleaning up... 14:53:41 INFO - Return code: 0 14:53:41 INFO - Running post-action listener: _resource_record_post_action 14:53:41 INFO - Running post-action listener: _start_resource_monitoring 14:53:41 INFO - Starting resource monitoring. 14:53:41 INFO - [mozharness: 2017-05-08 21:53:41.043139Z] Finished create-virtualenv step (success) 14:53:41 INFO - [mozharness: 2017-05-08 21:53:41.043659Z] Running install step. 14:53:41 INFO - Running pre-action listener: _resource_record_pre_action 14:53:41 INFO - Running main action method: install 14:53:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:53:41 INFO - Reading from file tmpfile_stdout 14:53:41 INFO - Detecting whether we're running mozinstall >=1.0... 14:53:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:53:41 INFO - Reading from file tmpfile_stdout 14:53:41 INFO - Output received: 14:53:41 INFO - Usage: mozinstall [options] installer 14:53:41 INFO - Options: 14:53:41 INFO - -h, --help show this help message and exit 14:53:41 INFO - -d DEST, --destination=DEST 14:53:41 INFO - Directory to install application into. [default: 14:53:41 INFO - "/builds/slave/test"] 14:53:41 INFO - --app=APP Application being installed. [default: firefox] 14:53:41 INFO - mkdir: /builds/slave/test/build/application 14:53:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:53:57 INFO - Reading from file tmpfile_stdout 14:53:57 INFO - Output received: 14:53:57 INFO - /builds/slave/test/build/application/firefox/firefox 14:53:57 INFO - Running post-action listener: _resource_record_post_action 14:53:57 INFO - [mozharness: 2017-05-08 21:53:57.504137Z] Finished install step (success) 14:53:57 INFO - [mozharness: 2017-05-08 21:53:57.504285Z] Running run-tests step. 14:53:57 INFO - Running pre-action listener: _resource_record_pre_action 14:53:57 INFO - Running main action method: run_tests 14:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:53:57 INFO - Python 2.7.3 14:53:57 INFO - Return code: 0 14:53:57 INFO - grabbing minidump binary from tooltool 14:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:57 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 0x230ea30>, '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 0x230f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230fca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:53:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:53:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:53:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:53:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:53:57 INFO - Return code: 0 14:53:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:53:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:53:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:53:57 INFO - ENV: RUST_BACKTRACE is now 1 14:53:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:53:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:53:57 INFO - Using env: {'DISPLAY': ':0', 14:53:57 INFO - 'HOME': '/home/cltbld', 14:53:57 INFO - 'LANG': 'en_US.UTF-8', 14:53:57 INFO - 'LANGUAGE': 'en_US:en', 14:53:57 INFO - 'LOGNAME': 'cltbld', 14:53:57 INFO - 'MAIL': '/var/mail/cltbld', 14:53:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:53:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:57 INFO - 'MOZ_NO_REMOTE': '1', 14:53:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:57 INFO - 'NO_EM_RESTART': '1', 14:53:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:57 INFO - 'PWD': '/builds/slave/test', 14:53:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:53:57 INFO - 'RUST_BACKTRACE': '1', 14:53:57 INFO - 'SHELL': '/bin/bash', 14:53:57 INFO - 'SHLVL': '1', 14:53:57 INFO - 'TERM': 'linux', 14:53:57 INFO - 'TMOUT': '86400', 14:53:57 INFO - 'USER': 'cltbld', 14:53:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130', 14:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:57 INFO - '_': '/tools/buildbot/bin/python'} 14:53:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:53:57 INFO - mozversion application_buildid: 20170508203447 14:53:57 INFO - mozversion application_changeset: bab7046ee2d82345d7d5b33b8ae4009c7e365176 14:53:57 INFO - mozversion application_display_name: Nightly 14:53:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:53:57 INFO - mozversion application_name: Firefox 14:53:57 INFO - mozversion application_remotingname: firefox 14:53:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:53:57 INFO - mozversion application_vendor: Mozilla 14:53:57 INFO - mozversion application_version: 55.0a1 14:53:57 INFO - mozversion platform_buildid: 20170508203447 14:53:57 INFO - mozversion platform_changeset: bab7046ee2d82345d7d5b33b8ae4009c7e365176 14:53:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:53:57 INFO - mozversion platform_version: 55.0a1 14:53:57 INFO - using testdate: 1494280437 14:53:57 INFO - actual date: 1494280437 14:53:57 INFO - starting webserver on 'localhost:58530' 14:53:57 INFO - SUITE-START | Running 2 tests 14:53:57 INFO - TEST-START | dromaeo_css 14:53:57 INFO - operating with platform_type : linux_ 14:53:57 INFO - Initialising browser for dromaeo_css test... 14:53:57 INFO - TEST-INFO | started process 9964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb7tQwE/profile http://localhost:58530/getInfo.html) 14:54:01 INFO - PID 9964 | __metrics Screen width/height:1600/1200 14:54:01 INFO - PID 9964 | colorDepth:24 14:54:01 INFO - PID 9964 | Browser inner width/height: 1024/695 14:54:01 INFO - PID 9964 | __metrics 14:54:02 INFO - PID 9964 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:54:02 INFO - PID 9964 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:54:03 INFO - TEST-INFO | 9964: exit 0 14:54:03 INFO - Browser initialized. 14:54:03 INFO - Running cycle 1/1 for dromaeo_css test... 14:54:03 INFO - TEST-INFO | started process 10064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb7tQwE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:15 INFO - PID 10064 | RSS: Main: 149655552 14:54:15 INFO - PID 10064 | 14:57:18 INFO - PID 10064 | Cycle 1(1): loaded http://localhost:58530/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58530/tests/dromaeo/cssquery-ext.html) 14:57:19 INFO - PID 10064 | RSS: Main: 298086400 14:57:19 INFO - PID 10064 | 15:00:21 INFO - PID 10064 | Cycle 1(1): loaded http://localhost:58530/tests/dromaeo/cssquery-ext.html (next: http://localhost:58530/tests/dromaeo/cssquery-jquery.html) 15:00:22 INFO - PID 10064 | RSS: Main: 219996160 15:00:22 INFO - PID 10064 | 15:03:24 INFO - PID 10064 | Cycle 1(1): loaded http://localhost:58530/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58530/tests/dromaeo/cssquery-mootools.html) 15:03:24 INFO - PID 10064 | RSS: Main: 207093760 15:03:24 INFO - PID 10064 | 15:06:26 INFO - PID 10064 | Cycle 1(1): loaded http://localhost:58530/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58530/tests/dromaeo/cssquery-prototype.html) 15:06:27 INFO - PID 10064 | RSS: Main: 173330432 15:06:27 INFO - PID 10064 | 15:09:29 INFO - PID 10064 | Cycle 1(1): loaded http://localhost:58530/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58530/tests/dromaeo/cssquery-yui.html) 15:09:30 INFO - PID 10064 | RSS: Main: 177029120 15:09:30 INFO - PID 10064 | 15:12:32 INFO - PID 10064 | Cycle 1(1): loaded http://localhost:58530/tests/dromaeo/cssquery-yui.html (next: http://localhost:58530/tests/dromaeo/cssquery-dojo.html) 15:12:32 INFO - PID 10064 | RSS: Main: 268451840 15:12:32 INFO - PID 10064 | 15:12:32 INFO - PID 10064 | __start_tp_report 15:12:32 INFO - PID 10064 | _x_x_mozilla_page_load 15:12:32 INFO - PID 10064 | _x_x_mozilla_page_load_details 15:12:32 INFO - PID 10064 | |i|pagename|runs| 15:12:32 INFO - PID 10064 | |0;dojo.html;3317.883874064407;3358.7816791908526;3372.8482218300164;3398.4732366483204;3418.299248654026;5752.137179423089;5897.1743955846105;5919.5856290059655;5949.672767997753;5951.285845698517;5849.766009359631;5919.85200369991;5935.673537955411;5979.551533634973;5995.3405125436275;5085.389753229599;5239.895202095975;5255.159174532076;5265.183896496049;5268.868278293055;5274.81538146165;5294.338207724035;5327.893442131155;5335.626506144552;5346.198070289449;5171;5209;5223.033738758342;5254.894902101936;5290;5311.707856067915;5322.946770532322;5334.119870221409;5335.253064570963;5343.492368225013;5196.090684130262;5236.371635403776;5245.606579506552;5250.05499010178;5312.814051508218;5922.5558083143505;5931.347551769302;5943.435373639497;5959.046552551571;5962.314333851619;6207.937920620781;6310;6316.589421687621;6421.967890160566;6445.2265728112925;6495.902561461582;6515.153030106103;6522.5760325578685;6528.0534322523445;6532.281449040602;5928.733207005609;6029.939700602981;6035.969820150871;6038.064100064497;6041.939580604182;6366.522510811707;6452.774152904626;6458;6616.073749675049;6621.5364924454825;6102.73853564067;6160.10678451622;6185.134081228632;6310.810675679737;6345.238571371373;6401.423871851555;6436.903446448307;6455.7417703292285;6456.031595260749;6463.418292353616;6300.873982520324;6419.1334169887405;6429.710663020175;6432.0351947207355;6433.646149461824;6191.071339299051;6209.223847019122;6310.242770867525;6411.455026322721;6413.45485633717;4846.7818948147415;4849.539293767087;4873.80504779812;4887.413510378707;4887.926681099786;4302.440682711227;4307.246231909403;4312.676549258818;4341.37050127736;4343.326784348431;5939.821805345847;6018.548608854353;6030.4572588467245;6047.78832740852;6056.3338032816355;6362.650054247061;6460.612363258219;6471.029345598198;6480.643564603898;6481;6043.123747056652;6081.6351018939;6096.908546371808;6100;6101.60339577926;5483.533899618577;5503.174523821459;5562.833115006556;5619.044762390404;5669.489745922887;6565.671716414256;6683.732650693918;6683.832904177434;6697.229818570927;6734.292899245705;6464.741410343534;6481.351864813481;6493.902591461227;6500.122483464861;6535.967320163369;6537.8692426150255;6576.967115164393;6806.659667016728;6808.5914845109455;6816.727330906709;6181.474574661204;6270.372962703693;6294.339094395023;6319.083732858618;6340.778072767431;6491.740330386731;6493.415592596689;6493.870122597427;6494.967525162533;6504.73981040772;6009.759609615567;6153.230846144232;6285.214348206474;6289.056641503811;6294.5279104068295;6153.538484613582;6179.81460556184;6296.401841825019;6297.055441683784;6311.431971122621;6285.96857015712;6311.368863113652;6313.810585682437;6320.810375688737;6327.209098862642;6258.812235632939;6367.331430199948;6371.904421433775;6372.490200784019;6376.52176086786;5997.82006539787;6050;6087.299960504599;6121.296050954019;6133.05924499315 15:12:32 INFO - PID 10064 | |1;ext.html;704.7357241034612;758.8785794272917;779.5907148746909;1137.4653912661047;1158.8551431071116;29560.556591651115;30214.12965768254;30301.393972120546;30333;34726.13184670384;39426.408603870965;39833.8008309958;39834.40248396277;39921.40117898234;39923.40114898279;7153.964230178842;7264.346208841203;7287.781366559012;7288.3076107769675;7292.161401438823;5609.691466969315;5752.82741517753;6716.966415167917;7226.132864056321;7335.926640733578;7340.5595664260045;7385.113786345646;7402.111746590416;7405.666744996488;7408.073990751156;7296.270372962715;7334.376577990904;7344.375728063068;7345.522541034816;7357.521761085566;5673.347565030033;5812.593118481708;7226.638668066628;7274.236205198431;7286.927130728678;35288;35357.46963795545;35579.4663080054;35642.28715425703;35671.4649280261;3526.3828829954914;3542.6988705960025;3550.2899420115823;3554.413521768905;3555.9466608000644;29869.850650746823;29876.103716888527;29919.401611967856;29985.850070749508;30003.399932001237;3765.3410653135593;3803.1823158021157;3808.1622043150464;3822;3858.8649397271242;189312;190650;191233;191712.0414397933;191758;48652;48813;48932.51067489351;48956.51043489519;49017.304048277685;51249.487505124474;51356;51545.48454515482;51561.48438515642;51591;14464.421423143167;14581.125132492085;14600.12399256048;14609.488667896572;14619.707605847823;11695.415229238504;11698.47356868943;11709.238899471507;11714.414279286002;11717.765644687059;11923.701907452383;12246.081543884244;13035.543755968496;13567.52513662017;13908.513202038082;5309.33633295838;5354.11657076578;5379.596530260246;5418.214358917935;5422.15956526739;1045.9633912813015;1077.989220107789;1081.6106201767357;1081.810683130449;1083.9403832789271;25606.48787024249;25634.743652563237;25672.871635641703;25713;26287.73712262891;1152.4986630815622;1160.4255893332854;1166.032193279576;1170.6371024982284;1175.5767923547517;13146.4084116215;13436.395362208725;13470.79793803074;13718.451261949609;17313.3074677014;226566;226703;227501;227504;227718;53989.1901621476;54158.45841541613;54159.18761218585;54211.18683219755;54264.45735542673;1401.4184113592744;1438.3311760031636;1453.5058080252766;1453.731059753949;1455.4251070827177;28249.717502824707;28854.567181492715;29235;29590.852045739633;30144.397112058075;38156.42765358577;38199.2360152801;38253.2349353017;38272.85181444561;38281.4257786139;188038;188831;189424;189502;190042;32565.67434325721;33124.33751324912;33185;33204;33230.33539329248;37190.62809371872;37405.438918415704;37545.43681844829;41825;42922;30077.699223008367;30980.380392392475;31430;32422;32927.835360824;31165.844170779;31530.684693152776;31538.211544711565;31830.522542161423;32085.679143209203;37633;37664.43503347507;37746.245075098894;37809.810950945066;37837.81081094577;30142.641516977932;32702.509462357608;32818.50772238466;33361.666383335854;33623.83188084142;25663.230103096936;26778.330541736614;26973.516456595076;26984.32539186536;27007.1897843065 15:12:32 INFO - PID 10064 | |2;jquery.html;425.91514536344596;438.92538268494354;444.7109378903712;455.687853820133;466.785278771765;18742;19706.704399434002;20457.693134602956;20483;20605.38183854487;20446.386608401735;23117.653235201484;23312;23372.76627233727;23594;5442.619016668825;5630.971845140789;5631.60578759487;5633.859153521174;5646.802361917334;5323.467653234665;5475.534579560742;5478.506934375905;5490.231367608538;5559;5430.049741295257;5431.967926094029;5433.918491222635;5436.238926550286;5444.074507333763;5388.272583201277;5409.648372855771;5427.592930530226;5566.137248726453;5571;5047.268146118829;5075.238714192864;5080.441151473372;5081.669691470042;5084.46613105626;25005.62491562628;25401;25409.364765881;25610;26087.73912260872;2146.2809958663865;2171.6633921742155;2178.673199020144;2179.0194412514434;2179.2808373236794;16851.74722379165;16986.40547580841;17460.30158793647;17614.823851761448;17648.205830737646;2027.3613811649284;2079.625667379871;2082.7084208210863;2109.2617583845686;2111.5460176062065;114538.42730786376;115959.42020289929;116685;117486.99999999914;121311.3934430331;12428.192167509264;12718.872811271955;12854.357282135856;12910.870891290966;13131.671708207181;18275.543111422056;18320.26718931228;18367.54081147982;18376.264949402143;18387.26450941974;8474.449160804528;8822.426542274732;8885.511296878605;8967.103289671111;9009.054049324857;8029.379434395946;8066.395020373378;8104.797380065545;8203.384746144064;8260.958695206486;8058.798530036796;8088.797780055545;8125.9187408126345;8203.872579637726;8252.133525979685;2119.8198153156845;2172.1528603844513;2202.5044365017743;2225.243417238147;2256.729192496911;1008.6469735592631;1038.4288641247283;1040.8290672992882;1051;1054.4938429553856;19375.90312048431;19391.418257452016;20736.792632073786;20770.896145519175;21230.78769212319;982.9115379615869;1056.3450660590483;1059.8251288537306;1082.7509672775307;1090.1769164280918;10784.460776961121;11100.500477478532;11307.94685434928;11372.31766094037;11412.600558980395;531083;537338;542570.7529483548;545018;548438.4139665357;83210;90586;96526.51736741271;97519.27287998314;97965;1101.1576144249655;1222.541546919905;1247.2267194339386;1254.103316128954;1262.1291308996763;20276.59446811085;20333.89833050825;20744.792552074287;20861.68707469359;21033.36899893006;47497.52502474931;48043.592371334176;48543;48652.27021594608;48681.756591216814;61479.692601536706;61882;62158.37841621707;62895.6855215721;63421.682891585246;9370.67202647904;13564.457421703022;13600.65998350049;14290.714185716435;14738.336774845373;15046.54860354191;15769;15830.129342885792;16045.27796249195;16559.337626495286;11088.944555277172;12637;12959.41682624303;13007.739845202854;13392.397342119822;12310;12671;12927.741445171232;13102.672433189247;13179.406926688514;13546.86453135456;13787.862121378657;13814.585562433143;13872.098313609584;13910.165390076629;13657.180569165881;13698.45206191741;13710.17738935667;13757.38091785852;13875.791863122264;12942.935285323512;13025;13029.739405212033;13260.469581216643;13302.733945321233 15:12:32 INFO - PID 10064 | |3;mootools.html;1371.403439503816;1392.7701929181685;1424.067235960446;1436.3392839293924;1437.4825062977334;10839.349639021655;11278.210525263235;11285.548578056867;11291.887081129196;11294.661160165198;11108.055815255713;11204.21570490066;11488.36813975231;11554.942225288862;11558.13314001449;2284.2690339091496;2304.320225533463;2319.814414846808;2321.6401457773986;2323.512062466884;1923.3172223860538;2230.553889222154;2280.874551899653;2291.86248825071;2293.0713061210154;2019.7475315585552;2238.3396897915154;2326.6277395616703;2327.3134425344565;2328.860268383902;2196.3081629286726;2218.7115674962233;2223.299660606912;2225.343523660524;2234.4748983988748;2218.3123231798195;2243.719535058118;2244.5062086340977;2249.6513040478753;2254.2673631069806;11235.887641123565;11289.717757056058;11307.681925205314;11329.773404531945;11337.886621133766;6109.995905363988;6533.118029066063;6547.116139321179;6549.705263263165;6573.408393244631;3742.7005839533044;3989.3218152914073;4100.630943215095;4237.555056719031;4247.10810729744;1327.2832670357996;1351.3918736568583;1378.710470801133;1383.5503461374992;1411.0616440067342;17176.398826041153;17323.826761732347;17333.13334333278;17336;17342.999999999873;4999.425066117443;5020.146575082244;5117.641765076409;5128.820491282787;5211.843644690665;12343.814842777365;12346;12364.690882728004;12371.628851134481;12377.195482293622;6394.552381333262;6397.488200943913;6399.872002559922;6407.743690252338;6407.7757278495965;5842.561807864342;5857.88284234313;5870.7945221917025;5956.153592386374;6016.217891674054;4103.457718254486;4139.668826493934;4165.541790403053;4184.4141820145205;4196;1040.443362800913;1151.9251248668809;1160.4081918221768;1172.2146162071433;1203.3093503627417;722.9060222171189;831.910197641092;843.5799985095736;857.5540718826176;872.9869051964225;5972.25346831646;5985.281766188085;6092.695365231721;6101.735571469243;6253.937460625427;947.3747326764441;960.7886265021684;961.1925982175006;968.9467079310706;988.3476905242649;3820.7325487215626;3873.302805495038;3890.2414029264587;3906.4140378942816;3923.2545816295383;15119.470818521298;15239.923800380928;15498.225088745517;15503;15621.687566248838;15197.316120774592;15206;15238.238088095552;15241.23793810305;15243;9337.253019758404;9561.61753529851;9581.425114493153;9636.891757447844;9650.372725772802;6704.262531121475;6705.329467053451;6734.09089772894;6764.458843292623;6869.931300686929;13385;13479.39342729599;13773.793393098911;13792.724145517233;13828.239446830521;13718.17690938547;13775.931120344334;13889.236092015037;13906.374213160634;14018.369173387426;8585.484870907765;8648.091950345122;8666.263367613572;8667.956660216658;8672.913270867462;10967.780644387227;11386.032187264176;11446.427678616203;11462.82805757931;11475.081993440337;9454.810903782023;9526.856777186505;9577.904220957702;9614.759631009001;9785.902140978498;9103.453792772454;9294.209992150743;9307.441553506811;9319.394239374418;9446.669366572138;7631.427642926692;7642.235776422313;7720.652570634447;7723.613819309125;7726;5834.358220595816;5993.340732519332;6014.6391216527145;6189.133521306931;6236.906446403398;6087.726052327567;6200.410960958701;6200.441960223601;6294.937050629618;6364.713587888464 15:12:32 INFO - PID 10064 | |4;prototype.html;419.4945091165146;426.258310539661;426.31363504757337;431.84237753220043;434.66991007517;5767.855803604902;5903.114532820079;5904.704764761761;5925.2593425821715;5931.466168044875;5687.2606561147095;5768.942310576893;5771.595988280822;5783.913241301373;5805.477507024367;4303.419038429819;4363.912721745563;4410.404595379631;4426.490953540336;4435.911281774363;4386.802593883267;4426.114777044588;4426.313921342197;4430.158269928703;4439.2453282941815;4371.497277813044;4383.4739831220295;4391.846285380012;4397.626201772853;4402.647788176938;4291.399204111427;4349.195398851207;4400.251957167289;4409.272470042439;4419;3831.6934645228594;3839.596842331543;3852.9019229519454;3854.5759966403675;3857.40210267409;5632.127020311858;5644.887102257973;5652.604317697763;5696.857578560528;5712.22884910536;5046.318746969149;5181.611379146541;5189.299444574972;5218.895622087537;5226.9546090782;6109.205803245594;6186.9381306186815;6193;6205.503559715212;6219;4346.391505189276;4362.105768317488;4362.8691139265875;4367.10474352757;4370.781460926941;6152.630842149485;6248.4064013918605;6316.305206427335;6421.29365769765;6485.77299794505;4306.181825453154;4402.603765661106;4410.492793328808;4410.691251612357;4431.955680443219;4483.484399294058;4484.192845287879;4485.753283569435;4496.168208881368;4501.122281155209;5085.843538567353;5150.459201783834;5160.7935682573025;5161.587073034223;5184.844454666366;6147.708981114016;6167.229096362955;6185.226846644169;6187.3503282154725;6208.410201030895;1525.9694806103817;1537.4618883390947;1541.8149822021205;1542.506397952667;1542.7994360733258;995.2635050062902;1017.9389236645825;1031.783325501653;1041.6874937518714;1046.2414749306845;5944.197533333031;5962.766435830522;6003.459688627957;6013.872786151177;6020.969895150496;6331.240251169889;6376.681165941684;6383.202099737533;6400.51996100285;6413.551051426355;5855.677937713466;6031.638101713824;6056.454919057306;6067.7269522871575;6069.969650151721;3336.7831090979494;3345.1135449106005;3363.6636336366655;3368.2589830237307;3368.646292139339;6394.776182833672;6641.966790166115;6660.966695166493;6672.766453174116;6729.707723278652;6413.422791948747;6494.447971922439;6503.219613646298;6505.837354066186;6508.544401891917;6442.871142577123;6668.533202675766;6673.9666301668185;6674.432673222734;6737.59574425536;6365.681715914278;6403.9359606405205;6415.518836087405;6433.9678301610065;6440.677966101583;6247.375262473716;6292.996167056707;6304.558680892477;6323.620582765049;6355.777547785805;6328;6463.935360646334;6485.77299794505;6638.834029149117;6643.966780166068;4428.623566996841;4439.889002774957;4440.400545926388;4453.1761624099645;4455.108978204307;6253.187085678833;6379.138816259746;6384.329645387167;6397.6481293529305;6422.42198202164;6187.4222073371;6215;6222.128901953821;6223.96888015557;6225.595336303126;6066.423689749467;6101.389861013863;6151.753929842936;6209.751609935552;6219.844503887439;6140;6167.629942203482;6191.690415479118;6202.5658203925295;6206.348333424925;6253.249610046823;6260.436560709558;6262.091996660368;6264.843378915563;6265.530085243534;5892.145638882253;6017.308009578955;6066.726997285221;6075.27096748393;6093.786717464867 15:12:32 INFO - PID 10064 | |5;yui.html;867.7089033835721;869.4435561240807;885.2519620920324;885.4333226734886;888.1828717579828;16637.916810415933;16775.328986840526;17155.399561015336;17166;17182.054986975712;16261.837381626181;16686;16701.331946722115;16703.66592668146;16711.331546738114;1007.9092881640669;1012.3166862367909;1028.2236911132086;1028.2596530498029;1028.7325295423207;1040.5681642118511;1042.8957104289548;1043.4678314059847;1043.8642976413093;1044.0812085364905;1066.8559744434478;1073.2272763610226;1073.6295977887617;1073.693997210795;1075.0163600305711;1072.13157342552;1073.1843798712957;1074.0870260278778;1074.1997212077013;1075.6504136155781;776.9145394006712;784;786.6617354537547;787.2560430393281;787.7242964962275;17456.82543174565;17509.7373539397;17587.824121758746;18204.635907281914;18230;18316.908415457972;18455.815441845545;18978.240870365167;19155.808441915542;19194.520136996547;14428.422863085463;14838.554843354717;14994.250287485582;15031.624209394744;15034.699306013928;3376.9155771105675;3401.795892246473;3433.6738009889023;3454.222799870034;3496.108492334464;84682;85135.99999999937;86146.56926715389;86602;86822.56588717079;14774.26128693561;15143.697126057417;15158.545243642708;15183.392664293304;15207.163606001555;26670.19989400321;27149.59275610828;27210.86394568054;27674;27716.445671086465;8202.794930126674;8414.705485308108;8448.112948140357;8452.323814094858;8455.112213217646;4261.21167583998;4375.78121093944;4376.299792033323;4384.846530371422;4394.209042372339;4466.843660471868;4498.887527811766;4570.954290457119;4592.425946756655;4614.953850461452;857.8841856349313;858.5664239558982;874.6719980007497;875.8992715837633;876.6931573949067;738.5753191914671;745.5563939456015;748.4424104042523;752.8569571781344;782.5461232485259;11475.827862582068;12267.202631828903;12411.689707757198;13129.73740525184;13183.802242966363;728.9052423185058;750.1710609776119;750.598429840033;752.4958277953784;753.2128925273103;5558.110702287615;5657.010023245998;5715.199872017921;5757.193992841006;5827.737751801179;86505.5674721635;86792;87349.56325218333;87460.5626971861;88081;74215;74465;77143;77308.22691773123;78231.60884195543;65325;67365;67952.62165824173;68163.65918170377;68726.65636671784;11166.944165279121;11277.21059525858;11380.260283081574;11508.251963622337;11613.76772464563;36006.45990310095;36266;36656;37023.81488092542;38242.21972253468;43237.35143972906;43713;43817.123657526034;43914.341284880116;45475.31787023131;14539.927300363854;14756.704865902837;14827;14915.254237287874;15022.924885375503;15163.620909477351;15187;15299;15337.309821057856;15411.922940385226;14230.786538201728;14273;14306.785398218826;18223.362182323555;19063.618727625646;16807.663846722753;16837.663246735243;16909.408170713967;17434.651306974043;17493.475195744148;17754;17786.37747678825;18305.450836474927;18314.26742930321;18376.908115459337;12934.870651293366;13065.346732663138;13121.212727236396;13156.539521117098;13839.723205536035;13689.589312320646;14396.784048239075;15080.888675585646;15529.922350388175;15543.279926013129 15:12:32 INFO - PID 10064 | __end_tp_report 15:12:32 INFO - PID 10064 | __start_cc_report 15:12:32 INFO - PID 10064 | _x_x_mozilla_cycle_collect,1467 15:12:32 INFO - PID 10064 | __end_cc_report 15:12:32 INFO - PID 10064 | __startTimestamp1494281552443__endTimestamp 15:12:32 INFO - PID 10064 | 15:12:32 INFO - PID 10064 | ------- Summary: start ------- 15:12:32 INFO - PID 10064 | Number of tests: 6 15:12:32 INFO - PID 10064 | 15:12:32 INFO - PID 10064 | [#0] dojo.html Cycles:165 Average:5921.33 Median:6153.23 stddev:719.85 (11.7%) stddev-sans-first:692.47 15:12:32 INFO - PID 10064 | Values: 3317.9 3358.8 3372.8 3398.5 3418.3 5752.1 5897.2 5919.6 5949.7 5951.3 5849.8 5919.9 5935.7 5979.6 5995.3 5085.4 5239.9 5255.2 5265.2 5268.9 5274.8 5294.3 5327.9 5335.6 5346.2 5171.0 5209.0 5223.0 5254.9 5290.0 5311.7 5322.9 5334.1 5335.3 5343.5 5196.1 5236.4 5245.6 5250.1 5312.8 5922.6 5931.3 5943.4 5959.0 5962.3 6207.9 6310.0 6316.6 6422.0 6445.2 6495.9 6515.2 6522.6 6528.1 6532.3 5928.7 6029.9 6036.0 6038.1 6041.9 6366.5 6452.8 6458.0 6616.1 6621.5 6102.7 6160.1 6185.1 6310.8 6345.2 6401.4 6436.9 6455.7 6456.0 6463.4 6300.9 6419.1 6429.7 6432.0 6433.6 6191.1 6209.2 6310.2 6411.5 6413.5 4846.8 4849.5 4873.8 4887.4 4887.9 4302.4 4307.2 4312.7 4341.4 4343.3 5939.8 6018.5 6030.5 6047.8 6056.3 6362.7 6460.6 6471.0 6480.6 6481.0 6043.1 6081.6 6096.9 6100.0 6101.6 5483.5 5503.2 5562.8 5619.0 5669.5 6565.7 6683.7 6683.8 6697.2 6734.3 6464.7 6481.4 6493.9 6500.1 6536.0 6537.9 6577.0 6806.7 6808.6 6816.7 6181.5 6270.4 6294.3 6319.1 6340.8 6491.7 6493.4 6493.9 6495.0 6504.7 6009.8 6153.2 6285.2 6289.1 6294.5 6153.5 6179.8 6296.4 6297.1 6311.4 6286.0 6311.4 6313.8 6320.8 6327.2 6258.8 6367.3 6371.9 6372.5 6376.5 5997.8 6050.0 6087.3 6121.3 6133.1 15:12:32 INFO - PID 10064 | 15:12:32 INFO - PID 10064 | [#1] ext.html Cycles:180 Average:36938.41 Median:33154.67 stddev:52659.21 (158.8%) stddev-sans-first:52736.65 15:12:32 INFO - PID 10064 | Values: 704.7 758.9 779.6 1137.5 1158.9 29560.6 30214.1 30301.4 30333.0 34726.1 39426.4 39833.8 39834.4 39921.4 39923.4 7154.0 7264.3 7287.8 7288.3 7292.2 5609.7 5752.8 6717.0 7226.1 7335.9 7340.6 7385.1 7402.1 7405.7 7408.1 7296.3 7334.4 7344.4 7345.5 7357.5 5673.3 5812.6 7226.6 7274.2 7286.9 35288.0 35357.5 35579.5 35642.3 35671.5 3526.4 3542.7 3550.3 3554.4 3555.9 29869.9 29876.1 29919.4 29985.9 30003.4 3765.3 3803.2 3808.2 3822.0 3858.9 189312.0 190650.0 191233.0 191712.0 191758.0 48652.0 48813.0 48932.5 48956.5 49017.3 51249.5 51356.0 51545.5 51561.5 51591.0 14464.4 14581.1 14600.1 14609.5 14619.7 11695.4 11698.5 11709.2 11714.4 11717.8 11923.7 12246.1 13035.5 13567.5 13908.5 5309.3 5354.1 5379.6 5418.2 5422.2 1046.0 1078.0 1081.6 1081.8 1083.9 25606.5 25634.7 25672.9 25713.0 26287.7 1152.5 1160.4 1166.0 1170.6 1175.6 13146.4 13436.4 13470.8 13718.5 17313.3 226566.0 226703.0 227501.0 227504.0 227718.0 53989.2 54158.5 54159.2 54211.2 54264.5 1401.4 1438.3 1453.5 1453.7 1455.4 28249.7 28854.6 29235.0 29590.9 30144.4 38156.4 38199.2 38253.2 38272.9 38281.4 188038.0 188831.0 189424.0 189502.0 190042.0 32565.7 33124.3 33185.0 33204.0 33230.3 37190.6 37405.4 37545.4 41825.0 42922.0 30077.7 30980.4 31430.0 32422.0 32927.8 31165.8 31530.7 31538.2 31830.5 32085.7 37633.0 37664.4 37746.2 37809.8 37837.8 30142.6 32702.5 32818.5 33361.7 33623.8 25663.2 26778.3 26973.5 26984.3 27007.2 15:12:32 INFO - PID 10064 | 15:12:32 INFO - PID 10064 | [#2] jquery.html Cycles:180 Average:33005.51 Median:11571.32 stddev:89546.91 (773.9%) stddev-sans-first:89764.70 15:12:32 INFO - PID 10064 | Values: 425.9 438.9 444.7 455.7 466.8 18742.0 19706.7 20457.7 20483.0 20605.4 20446.4 23117.7 23312.0 23372.8 23594.0 5442.6 5631.0 5631.6 5633.9 5646.8 5323.5 5475.5 5478.5 5490.2 5559.0 5430.0 5432.0 5433.9 5436.2 5444.1 5388.3 5409.6 5427.6 5566.1 5571.0 5047.3 5075.2 5080.4 5081.7 5084.5 25005.6 25401.0 25409.4 25610.0 26087.7 2146.3 2171.7 2178.7 2179.0 2179.3 16851.7 16986.4 17460.3 17614.8 17648.2 2027.4 2079.6 2082.7 2109.3 2111.5 114538.4 115959.4 116685.0 117487.0 121311.4 12428.2 12718.9 12854.4 12910.9 13131.7 18275.5 18320.3 18367.5 18376.3 18387.3 8474.4 8822.4 8885.5 8967.1 9009.1 8029.4 8066.4 8104.8 8203.4 8261.0 8058.8 8088.8 8125.9 8203.9 8252.1 2119.8 2172.2 2202.5 2225.2 2256.7 1008.6 1038.4 1040.8 1051.0 1054.5 19375.9 19391.4 20736.8 20770.9 21230.8 982.9 1056.3 1059.8 1082.8 1090.2 10784.5 11100.5 11307.9 11372.3 11412.6 531083.0 537338.0 542570.8 545018.0 548438.4 83210.0 90586.0 96526.5 97519.3 97965.0 1101.2 1222.5 1247.2 1254.1 1262.1 20276.6 20333.9 20744.8 20861.7 21033.4 47497.5 48043.6 48543.0 48652.3 48681.8 61479.7 61882.0 62158.4 62895.7 63421.7 9370.7 13564.5 13600.7 14290.7 14738.3 15046.5 15769.0 15830.1 16045.3 16559.3 11088.9 12637.0 12959.4 13007.7 13392.4 12310.0 12671.0 12927.7 13102.7 13179.4 13546.9 13787.9 13814.6 13872.1 13910.2 13657.2 13698.5 13710.2 13757.4 13875.8 12942.9 13025.0 13029.7 13260.5 13302.7 15:12:32 INFO - PID 10064 | 15:12:32 INFO - PID 10064 | [#3] mootools.html Cycles:180 Average:7106.67 Median:3781.72 stddev:4665.71 (123.4%) stddev-sans-first:4658.90 15:12:32 INFO - PID 10064 | Values: 1371.4 1392.8 1424.1 1436.3 1437.5 10839.3 11278.2 11285.5 11291.9 11294.7 11108.1 11204.2 11488.4 11554.9 11558.1 2284.3 2304.3 2319.8 2321.6 2323.5 1923.3 2230.6 2280.9 2291.9 2293.1 2019.7 2238.3 2326.6 2327.3 2328.9 2196.3 2218.7 2223.3 2225.3 2234.5 2218.3 2243.7 2244.5 2249.7 2254.3 11235.9 11289.7 11307.7 11329.8 11337.9 6110.0 6533.1 6547.1 6549.7 6573.4 3742.7 3989.3 4100.6 4237.6 4247.1 1327.3 1351.4 1378.7 1383.6 1411.1 17176.4 17323.8 17333.1 17336.0 17343.0 4999.4 5020.1 5117.6 5128.8 5211.8 12343.8 12346.0 12364.7 12371.6 12377.2 6394.6 6397.5 6399.9 6407.7 6407.8 5842.6 5857.9 5870.8 5956.2 6016.2 4103.5 4139.7 4165.5 4184.4 4196.0 1040.4 1151.9 1160.4 1172.2 1203.3 722.9 831.9 843.6 857.6 873.0 5972.3 5985.3 6092.7 6101.7 6253.9 947.4 960.8 961.2 968.9 988.3 3820.7 3873.3 3890.2 3906.4 3923.3 15119.5 15239.9 15498.2 15503.0 15621.7 15197.3 15206.0 15238.2 15241.2 15243.0 9337.3 9561.6 9581.4 9636.9 9650.4 6704.3 6705.3 6734.1 6764.5 6869.9 13385.0 13479.4 13773.8 13792.7 13828.2 13718.2 13775.9 13889.2 13906.4 14018.4 8585.5 8648.1 8666.3 8668.0 8672.9 10967.8 11386.0 11446.4 11462.8 11475.1 9454.8 9526.9 9577.9 9614.8 9785.9 9103.5 9294.2 9307.4 9319.4 9446.7 7631.4 7642.2 7720.7 7723.6 7726.0 5834.4 5993.3 6014.6 6189.1 6236.9 6087.7 6200.4 6200.4 6294.9 6364.7 15:12:32 INFO - PID 10064 | 15:12:32 INFO - PID 10064 | [#4] prototype.html Cycles:180 Average:5176.29 Median:5937.83 stddev:1559.36 (26.3%) stddev-sans-first:1522.31 15:12:32 INFO - PID 10064 | Values: 419.5 426.3 426.3 431.8 434.7 5767.9 5903.1 5904.7 5925.3 5931.5 5687.3 5768.9 5771.6 5783.9 5805.5 4303.4 4363.9 4410.4 4426.5 4435.9 4386.8 4426.1 4426.3 4430.2 4439.2 4371.5 4383.5 4391.8 4397.6 4402.6 4291.4 4349.2 4400.3 4409.3 4419.0 3831.7 3839.6 3852.9 3854.6 3857.4 5632.1 5644.9 5652.6 5696.9 5712.2 5046.3 5181.6 5189.3 5218.9 5227.0 6109.2 6186.9 6193.0 6205.5 6219.0 4346.4 4362.1 4362.9 4367.1 4370.8 6152.6 6248.4 6316.3 6421.3 6485.8 4306.2 4402.6 4410.5 4410.7 4432.0 4483.5 4484.2 4485.8 4496.2 4501.1 5085.8 5150.5 5160.8 5161.6 5184.8 6147.7 6167.2 6185.2 6187.4 6208.4 1526.0 1537.5 1541.8 1542.5 1542.8 995.3 1017.9 1031.8 1041.7 1046.2 5944.2 5962.8 6003.5 6013.9 6021.0 6331.2 6376.7 6383.2 6400.5 6413.6 5855.7 6031.6 6056.5 6067.7 6070.0 3336.8 3345.1 3363.7 3368.3 3368.6 6394.8 6642.0 6661.0 6672.8 6729.7 6413.4 6494.4 6503.2 6505.8 6508.5 6442.9 6668.5 6674.0 6674.4 6737.6 6365.7 6403.9 6415.5 6434.0 6440.7 6247.4 6293.0 6304.6 6323.6 6355.8 6328.0 6463.9 6485.8 6638.8 6644.0 4428.6 4439.9 4440.4 4453.2 4455.1 6253.2 6379.1 6384.3 6397.6 6422.4 6187.4 6215.0 6222.1 6224.0 6225.6 6066.4 6101.4 6151.8 6209.8 6219.8 6140.0 6167.6 6191.7 6202.6 6206.3 6253.2 6260.4 6262.1 6264.8 6265.5 5892.1 6017.3 6066.7 6075.3 6093.8 15:12:32 INFO - PID 10064 | 15:12:32 INFO - PID 10064 | [#5] yui.html Cycles:180 Average:19254.82 Median:18717.03 stddev:23590.59 (126.0%) stddev-sans-first:23616.36 15:12:32 INFO - PID 10064 | Values: 867.7 869.4 885.3 885.4 888.2 16637.9 16775.3 17155.4 17166.0 17182.1 16261.8 16686.0 16701.3 16703.7 16711.3 1007.9 1012.3 1028.2 1028.3 1028.7 1040.6 1042.9 1043.5 1043.9 1044.1 1066.9 1073.2 1073.6 1073.7 1075.0 1072.1 1073.2 1074.1 1074.2 1075.7 776.9 784.0 786.7 787.3 787.7 17456.8 17509.7 17587.8 18204.6 18230.0 18316.9 18455.8 18978.2 19155.8 19194.5 14428.4 14838.6 14994.3 15031.6 15034.7 3376.9 3401.8 3433.7 3454.2 3496.1 84682.0 85136.0 86146.6 86602.0 86822.6 14774.3 15143.7 15158.5 15183.4 15207.2 26670.2 27149.6 27210.9 27674.0 27716.4 8202.8 8414.7 8448.1 8452.3 8455.1 4261.2 4375.8 4376.3 4384.8 4394.2 4466.8 4498.9 4571.0 4592.4 4615.0 857.9 858.6 874.7 875.9 876.7 738.6 745.6 748.4 752.9 782.5 11475.8 12267.2 12411.7 13129.7 13183.8 728.9 750.2 750.6 752.5 753.2 5558.1 5657.0 5715.2 5757.2 5827.7 86505.6 86792.0 87349.6 87460.6 88081.0 74215.0 74465.0 77143.0 77308.2 78231.6 65325.0 67365.0 67952.6 68163.7 68726.7 11166.9 11277.2 11380.3 11508.3 11613.8 36006.5 36266.0 36656.0 37023.8 38242.2 43237.4 43713.0 43817.1 43914.3 45475.3 14539.9 14756.7 14827.0 14915.3 15022.9 15163.6 15187.0 15299.0 15337.3 15411.9 14230.8 14273.0 14306.8 18223.4 19063.6 16807.7 16837.7 16909.4 17434.7 17493.5 17754.0 17786.4 18305.5 18314.3 18376.9 12934.9 13065.3 13121.2 13156.5 13839.7 13689.6 14396.8 15080.9 15529.9 15543.3 15:12:32 INFO - PID 10064 | -------- Summary: end -------- 15:12:32 INFO - PID 10064 | 15:12:33 INFO - TEST-INFO | 10064: exit 0 15:12:33 INFO - TEST-OK | dromaeo_css | took 1115471ms 15:12:33 INFO - TEST-START | kraken 15:12:33 INFO - operating with platform_type : linux_ 15:12:33 INFO - Initialising browser for kraken test... 15:12:33 INFO - TEST-INFO | started process 10396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK88iwW/profile http://localhost:58530/getInfo.html) 15:12:36 INFO - PID 10396 | __metrics Screen width/height:1600/1200 15:12:36 INFO - PID 10396 | colorDepth:24 15:12:36 INFO - PID 10396 | Browser inner width/height: 1024/695 15:12:36 INFO - PID 10396 | __metrics 15:12:37 INFO - PID 10396 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:12:37 INFO - PID 10396 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:12:38 INFO - TEST-INFO | 10396: exit 0 15:12:38 INFO - Browser initialized. 15:12:38 INFO - Running cycle 1/1 for kraken test... 15:12:38 INFO - TEST-INFO | started process 10491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK88iwW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:12:50 INFO - PID 10491 | RSS: Main: 149757952 15:12:50 INFO - PID 10491 | 15:12:53 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58530/tests/kraken/driver.html?testName=audio-beat-detection) 15:12:54 INFO - PID 10491 | RSS: Main: 223322112 15:12:54 INFO - PID 10491 | 15:12:56 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58530/tests/kraken/driver.html?testName=audio-dft) 15:12:57 INFO - PID 10491 | RSS: Main: 184123392 15:12:57 INFO - PID 10491 | 15:13:00 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58530/tests/kraken/driver.html?testName=audio-fft) 15:13:00 INFO - PID 10491 | RSS: Main: 263925760 15:13:00 INFO - PID 10491 | 15:13:02 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58530/tests/kraken/driver.html?testName=audio-oscillator) 15:13:03 INFO - PID 10491 | RSS: Main: 176386048 15:13:03 INFO - PID 10491 | 15:13:05 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58530/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:13:06 INFO - PID 10491 | RSS: Main: 178700288 15:13:06 INFO - PID 10491 | 15:13:09 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58530/tests/kraken/driver.html?testName=imaging-darkroom) 15:13:09 INFO - PID 10491 | RSS: Main: 239316992 15:13:09 INFO - PID 10491 | 15:13:13 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58530/tests/kraken/driver.html?testName=imaging-desaturate) 15:13:13 INFO - PID 10491 | RSS: Main: 262082560 15:13:13 INFO - PID 10491 | 15:13:16 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58530/tests/kraken/driver.html?testName=json-parse-financial) 15:13:16 INFO - PID 10491 | RSS: Main: 279887872 15:13:16 INFO - PID 10491 | 15:13:18 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58530/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:13:18 INFO - PID 10491 | RSS: Main: 203005952 15:13:18 INFO - PID 10491 | 15:13:20 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58530/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:13:21 INFO - PID 10491 | RSS: Main: 209092608 15:13:21 INFO - PID 10491 | 15:13:23 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58530/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:13:23 INFO - PID 10491 | RSS: Main: 218398720 15:13:23 INFO - PID 10491 | 15:13:26 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:13:27 INFO - PID 10491 | RSS: Main: 226422784 15:13:27 INFO - PID 10491 | 15:13:30 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:13:30 INFO - PID 10491 | RSS: Main: 222175232 15:13:30 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | Cycle 1(1): loaded http://localhost:58530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58530/tests/kraken/driver.html?testName=ai-astar) 15:13:32 INFO - PID 10491 | RSS: Main: 272510976 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | __start_tp_report 15:13:32 INFO - PID 10491 | _x_x_mozilla_page_load 15:13:32 INFO - PID 10491 | _x_x_mozilla_page_load_details 15:13:32 INFO - PID 10491 | |i|pagename|runs| 15:13:32 INFO - PID 10491 | |0;ai-astar;108;109;109;108;116;109;109;109;109;111 15:13:32 INFO - PID 10491 | |1;audio-beat-detection;145;115;117;177;117;115;118;115;135;116 15:13:32 INFO - PID 10491 | |2;audio-dft;168;161;160;161;161;162;162;160;162;160 15:13:32 INFO - PID 10491 | |3;audio-fft;75;74;75;114;75;74;77;74;93;74 15:13:32 INFO - PID 10491 | |4;audio-oscillator;83;82;108;83;83;82;94;82;82;105 15:13:32 INFO - PID 10491 | |5;imaging-gaussian-blur;114;113;113;113;112;114;113;112;113;112 15:13:32 INFO - PID 10491 | |6;imaging-darkroom;147;167;146;147;147;148;147;147;147;147 15:13:32 INFO - PID 10491 | |7;imaging-desaturate;94;93;94;94;94;93;94;94;94;94 15:13:32 INFO - PID 10491 | |8;json-parse-financial;44;43;44;45;46;45;46;45;45;46 15:13:32 INFO - PID 10491 | |9;json-stringify-tinderbox;56;56;55;56;55;55;55;56;57;56 15:13:32 INFO - PID 10491 | |10;stanford-crypto-aes;81;89;89;81;82;89;81;80;79;82 15:13:32 INFO - PID 10491 | |11;stanford-crypto-ccm;126;126;124;125;140;122;123;122;168;132 15:13:32 INFO - PID 10491 | |12;stanford-crypto-pbkdf2;182;182;180;172;188;179;180;195;176;179 15:13:32 INFO - PID 10491 | |13;stanford-crypto-sha256-iterative;65;67;65;65;64;65;63;64;64;63 15:13:32 INFO - PID 10491 | __end_tp_report 15:13:32 INFO - PID 10491 | __start_cc_report 15:13:32 INFO - PID 10491 | _x_x_mozilla_cycle_collect,1664 15:13:32 INFO - PID 10491 | __end_cc_report 15:13:32 INFO - PID 10491 | __startTimestamp1494281612538__endTimestamp 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | ------- Summary: start ------- 15:13:32 INFO - PID 10491 | Number of tests: 14 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#0] ai-astar Cycles:10 Average:109.70 Median:109.00 stddev:2.36 (2.2%) stddev-sans-first:2.42 15:13:32 INFO - PID 10491 | Values: 108.0 109.0 109.0 108.0 116.0 109.0 109.0 109.0 109.0 111.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#1] audio-beat-detection Cycles:10 Average:127.00 Median:117.50 stddev:20.34 (17.3%) stddev-sans-first:20.50 15:13:32 INFO - PID 10491 | Values: 145.0 115.0 117.0 177.0 117.0 115.0 118.0 115.0 135.0 116.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:2.36 (1.5%) stddev-sans-first:0.87 15:13:32 INFO - PID 10491 | Values: 168.0 161.0 160.0 161.0 161.0 162.0 162.0 160.0 162.0 160.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:13.13 (17.5%) stddev-sans-first:13.77 15:13:32 INFO - PID 10491 | Values: 75.0 74.0 75.0 114.0 75.0 74.0 77.0 74.0 93.0 74.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:82.50 stddev:10.23 (12.4%) stddev-sans-first:10.67 15:13:32 INFO - PID 10491 | Values: 83.0 82.0 108.0 83.0 83.0 82.0 94.0 82.0 82.0 105.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 15:13:32 INFO - PID 10491 | Values: 114.0 113.0 113.0 113.0 112.0 114.0 113.0 112.0 113.0 112.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:147.00 stddev:6.34 (4.3%) stddev-sans-first:6.69 15:13:32 INFO - PID 10491 | Values: 147.0 167.0 146.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:13:32 INFO - PID 10491 | Values: 94.0 93.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:0.99 (2.2%) stddev-sans-first:1.00 15:13:32 INFO - PID 10491 | Values: 44.0 43.0 44.0 45.0 46.0 45.0 46.0 45.0 45.0 46.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 15:13:32 INFO - PID 10491 | Values: 56.0 56.0 55.0 56.0 55.0 55.0 55.0 56.0 57.0 56.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:4.03 (4.9%) stddev-sans-first:4.19 15:13:32 INFO - PID 10491 | Values: 81.0 89.0 89.0 81.0 82.0 89.0 81.0 80.0 79.0 82.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:126.00 stddev:14.19 (11.3%) stddev-sans-first:14.94 15:13:32 INFO - PID 10491 | Values: 126.0 126.0 124.0 125.0 140.0 122.0 123.0 122.0 168.0 132.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.30 Median:181.00 stddev:6.34 (3.5%) stddev-sans-first:6.72 15:13:32 INFO - PID 10491 | Values: 182.0 182.0 180.0 172.0 188.0 179.0 180.0 195.0 176.0 179.0 15:13:32 INFO - PID 10491 | 15:13:32 INFO - PID 10491 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 15:13:32 INFO - PID 10491 | Values: 65.0 67.0 65.0 65.0 64.0 65.0 63.0 64.0 64.0 63.0 15:13:32 INFO - PID 10491 | -------- Summary: end -------- 15:13:32 INFO - PID 10491 | 15:13:33 INFO - TEST-INFO | 10491: exit 0 15:13:33 INFO - TEST-OK | kraken | took 60433ms 15:13:33 INFO - SUITE-END | took 1175s 15:13:33 INFO - Completed test suite (00:19:35) 15:13:33 INFO - javascript benchmark 15:13:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7732.156094713482, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.883874064407, 3358.7816791908526, 3372.8482218300164, 3398.4732366483204, 3418.299248654026, 5752.137179423089, 5897.1743955846105, 5919.5856290059655, 5949.672767997753, 5951.285845698517, 5849.766009359631, 5919.85200369991, 5935.673537955411, 5979.551533634973, 5995.3405125436275, 5085.389753229599, 5239.895202095975, 5255.159174532076, 5265.183896496049, 5268.868278293055, 5274.81538146165, 5294.338207724035, 5327.893442131155, 5335.626506144552, 5346.198070289449, 5171.0, 5209.0, 5223.033738758342, 5254.894902101936, 5290.0, 5311.707856067915, 5322.946770532322, 5334.119870221409, 5335.253064570963, 5343.492368225013, 5196.090684130262, 5236.371635403776, 5245.606579506552, 5250.05499010178, 5312.814051508218, 5922.5558083143505, 5931.347551769302, 5943.435373639497, 5959.046552551571, 5962.314333851619, 6207.937920620781, 6310.0, 6316.589421687621, 6421.967890160566, 6445.2265728112925, 6495.902561461582, 6515.153030106103, 6522.5760325578685, 6528.0534322523445, 6532.281449040602, 5928.733207005609, 6029.939700602981, 6035.969820150871, 6038.064100064497, 6041.939580604182, 6366.522510811707, 6452.774152904626, 6458.0, 6616.073749675049, 6621.5364924454825, 6102.73853564067, 6160.10678451622, 6185.134081228632, 6310.810675679737, 6345.238571371373, 6401.423871851555, 6436.903446448307, 6455.7417703292285, 6456.031595260749, 6463.418292353616, 6300.873982520324, 6419.1334169887405, 6429.710663020175, 6432.0351947207355, 6433.646149461824, 6191.071339299051, 6209.223847019122, 6310.242770867525, 6411.455026322721, 6413.45485633717, 4846.7818948147415, 4849.539293767087, 4873.80504779812, 4887.413510378707, 4887.926681099786, 4302.440682711227, 4307.246231909403, 4312.676549258818, 4341.37050127736, 4343.326784348431, 5939.821805345847, 6018.548608854353, 6030.4572588467245, 6047.78832740852, 6056.3338032816355, 6362.650054247061, 6460.612363258219, 6471.029345598198, 6480.643564603898, 6481.0, 6043.123747056652, 6081.6351018939, 6096.908546371808, 6100.0, 6101.60339577926, 5483.533899618577, 5503.174523821459, 5562.833115006556, 5619.044762390404, 5669.489745922887, 6565.671716414256, 6683.732650693918, 6683.832904177434, 6697.229818570927, 6734.292899245705, 6464.741410343534, 6481.351864813481, 6493.902591461227, 6500.122483464861, 6535.967320163369, 6537.8692426150255, 6576.967115164393, 6806.659667016728, 6808.5914845109455, 6816.727330906709, 6181.474574661204, 6270.372962703693, 6294.339094395023, 6319.083732858618, 6340.778072767431, 6491.740330386731, 6493.415592596689, 6493.870122597427, 6494.967525162533, 6504.73981040772, 6009.759609615567, 6153.230846144232, 6285.214348206474, 6289.056641503811, 6294.5279104068295, 6153.538484613582, 6179.81460556184, 6296.401841825019, 6297.055441683784, 6311.431971122621, 6285.96857015712, 6311.368863113652, 6313.810585682437, 6320.810375688737, 6327.209098862642, 6258.812235632939, 6367.331430199948, 6371.904421433775, 6372.490200784019, 6376.52176086786, 5997.82006539787, 6050.0, 6087.299960504599, 6121.296050954019, 6133.05924499315], "value": 5869.571868700648, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.7357241034612, 758.8785794272917, 779.5907148746909, 1137.4653912661047, 1158.8551431071116, 29560.556591651115, 30214.12965768254, 30301.393972120546, 30333.0, 34726.13184670384, 39426.408603870965, 39833.8008309958, 39834.40248396277, 39921.40117898234, 39923.40114898279, 7153.964230178842, 7264.346208841203, 7287.781366559012, 7288.3076107769675, 7292.161401438823, 5609.691466969315, 5752.82741517753, 6716.966415167917, 7226.132864056321, 7335.926640733578, 7340.5595664260045, 7385.113786345646, 7402.111746590416, 7405.666744996488, 7408.073990751156, 7296.270372962715, 7334.376577990904, 7344.375728063068, 7345.522541034816, 7357.521761085566, 5673.347565030033, 5812.593118481708, 7226.638668066628, 7274.236205198431, 7286.927130728678, 35288.0, 35357.46963795545, 35579.4663080054, 35642.28715425703, 35671.4649280261, 3526.3828829954914, 3542.6988705960025, 3550.2899420115823, 3554.413521768905, 3555.9466608000644, 29869.850650746823, 29876.103716888527, 29919.401611967856, 29985.850070749508, 30003.399932001237, 3765.3410653135593, 3803.1823158021157, 3808.1622043150464, 3822.0, 3858.8649397271242, 189312.0, 190650.0, 191233.0, 191712.0414397933, 191758.0, 48652.0, 48813.0, 48932.51067489351, 48956.51043489519, 49017.304048277685, 51249.487505124474, 51356.0, 51545.48454515482, 51561.48438515642, 51591.0, 14464.421423143167, 14581.125132492085, 14600.12399256048, 14609.488667896572, 14619.707605847823, 11695.415229238504, 11698.47356868943, 11709.238899471507, 11714.414279286002, 11717.765644687059, 11923.701907452383, 12246.081543884244, 13035.543755968496, 13567.52513662017, 13908.513202038082, 5309.33633295838, 5354.11657076578, 5379.596530260246, 5418.214358917935, 5422.15956526739, 1045.9633912813015, 1077.989220107789, 1081.6106201767357, 1081.810683130449, 1083.9403832789271, 25606.48787024249, 25634.743652563237, 25672.871635641703, 25713.0, 26287.73712262891, 1152.4986630815622, 1160.4255893332854, 1166.032193279576, 1170.6371024982284, 1175.5767923547517, 13146.4084116215, 13436.395362208725, 13470.79793803074, 13718.451261949609, 17313.3074677014, 226566.0, 226703.0, 227501.0, 227504.0, 227718.0, 53989.1901621476, 54158.45841541613, 54159.18761218585, 54211.18683219755, 54264.45735542673, 1401.4184113592744, 1438.3311760031636, 1453.5058080252766, 1453.731059753949, 1455.4251070827177, 28249.717502824707, 28854.567181492715, 29235.0, 29590.852045739633, 30144.397112058075, 38156.42765358577, 38199.2360152801, 38253.2349353017, 38272.85181444561, 38281.4257786139, 188038.0, 188831.0, 189424.0, 189502.0, 190042.0, 32565.67434325721, 33124.33751324912, 33185.0, 33204.0, 33230.33539329248, 37190.62809371872, 37405.438918415704, 37545.43681844829, 41825.0, 42922.0, 30077.699223008367, 30980.380392392475, 31430.0, 32422.0, 32927.835360824, 31165.844170779, 31530.684693152776, 31538.211544711565, 31830.522542161423, 32085.679143209203, 37633.0, 37664.43503347507, 37746.245075098894, 37809.810950945066, 37837.81081094577, 30142.641516977932, 32702.509462357608, 32818.50772238466, 33361.666383335854, 33623.83188084142, 25663.230103096936, 26778.330541736614, 26973.516456595076, 26984.32539186536, 27007.1897843065], "value": 16746.367532907425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.91514536344596, 438.92538268494354, 444.7109378903712, 455.687853820133, 466.785278771765, 18742.0, 19706.704399434002, 20457.693134602956, 20483.0, 20605.38183854487, 20446.386608401735, 23117.653235201484, 23312.0, 23372.76627233727, 23594.0, 5442.619016668825, 5630.971845140789, 5631.60578759487, 5633.859153521174, 5646.802361917334, 5323.467653234665, 5475.534579560742, 5478.506934375905, 5490.231367608538, 5559.0, 5430.049741295257, 5431.967926094029, 5433.918491222635, 5436.238926550286, 5444.074507333763, 5388.272583201277, 5409.648372855771, 5427.592930530226, 5566.137248726453, 5571.0, 5047.268146118829, 5075.238714192864, 5080.441151473372, 5081.669691470042, 5084.46613105626, 25005.62491562628, 25401.0, 25409.364765881, 25610.0, 26087.73912260872, 2146.2809958663865, 2171.6633921742155, 2178.673199020144, 2179.0194412514434, 2179.2808373236794, 16851.74722379165, 16986.40547580841, 17460.30158793647, 17614.823851761448, 17648.205830737646, 2027.3613811649284, 2079.625667379871, 2082.7084208210863, 2109.2617583845686, 2111.5460176062065, 114538.42730786376, 115959.42020289929, 116685.0, 117486.99999999914, 121311.3934430331, 12428.192167509264, 12718.872811271955, 12854.357282135856, 12910.870891290966, 13131.671708207181, 18275.543111422056, 18320.26718931228, 18367.54081147982, 18376.264949402143, 18387.26450941974, 8474.449160804528, 8822.426542274732, 8885.511296878605, 8967.103289671111, 9009.054049324857, 8029.379434395946, 8066.395020373378, 8104.797380065545, 8203.384746144064, 8260.958695206486, 8058.798530036796, 8088.797780055545, 8125.9187408126345, 8203.872579637726, 8252.133525979685, 2119.8198153156845, 2172.1528603844513, 2202.5044365017743, 2225.243417238147, 2256.729192496911, 1008.6469735592631, 1038.4288641247283, 1040.8290672992882, 1051.0, 1054.4938429553856, 19375.90312048431, 19391.418257452016, 20736.792632073786, 20770.896145519175, 21230.78769212319, 982.9115379615869, 1056.3450660590483, 1059.8251288537306, 1082.7509672775307, 1090.1769164280918, 10784.460776961121, 11100.500477478532, 11307.94685434928, 11372.31766094037, 11412.600558980395, 531083.0, 537338.0, 542570.7529483548, 545018.0, 548438.4139665357, 83210.0, 90586.0, 96526.51736741271, 97519.27287998314, 97965.0, 1101.1576144249655, 1222.541546919905, 1247.2267194339386, 1254.103316128954, 1262.1291308996763, 20276.59446811085, 20333.89833050825, 20744.792552074287, 20861.68707469359, 21033.36899893006, 47497.52502474931, 48043.592371334176, 48543.0, 48652.27021594608, 48681.756591216814, 61479.692601536706, 61882.0, 62158.37841621707, 62895.6855215721, 63421.682891585246, 9370.67202647904, 13564.457421703022, 13600.65998350049, 14290.714185716435, 14738.336774845373, 15046.54860354191, 15769.0, 15830.129342885792, 16045.27796249195, 16559.337626495286, 11088.944555277172, 12637.0, 12959.41682624303, 13007.739845202854, 13392.397342119822, 12310.0, 12671.0, 12927.741445171232, 13102.672433189247, 13179.406926688514, 13546.86453135456, 13787.862121378657, 13814.585562433143, 13872.098313609584, 13910.165390076629, 13657.180569165881, 13698.45206191741, 13710.17738935667, 13757.38091785852, 13875.791863122264, 12942.935285323512, 13025.0, 13029.739405212033, 13260.469581216643, 13302.733945321233], "value": 10473.494028633877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.403439503816, 1392.7701929181685, 1424.067235960446, 1436.3392839293924, 1437.4825062977334, 10839.349639021655, 11278.210525263235, 11285.548578056867, 11291.887081129196, 11294.661160165198, 11108.055815255713, 11204.21570490066, 11488.36813975231, 11554.942225288862, 11558.13314001449, 2284.2690339091496, 2304.320225533463, 2319.814414846808, 2321.6401457773986, 2323.512062466884, 1923.3172223860538, 2230.553889222154, 2280.874551899653, 2291.86248825071, 2293.0713061210154, 2019.7475315585552, 2238.3396897915154, 2326.6277395616703, 2327.3134425344565, 2328.860268383902, 2196.3081629286726, 2218.7115674962233, 2223.299660606912, 2225.343523660524, 2234.4748983988748, 2218.3123231798195, 2243.719535058118, 2244.5062086340977, 2249.6513040478753, 2254.2673631069806, 11235.887641123565, 11289.717757056058, 11307.681925205314, 11329.773404531945, 11337.886621133766, 6109.995905363988, 6533.118029066063, 6547.116139321179, 6549.705263263165, 6573.408393244631, 3742.7005839533044, 3989.3218152914073, 4100.630943215095, 4237.555056719031, 4247.10810729744, 1327.2832670357996, 1351.3918736568583, 1378.710470801133, 1383.5503461374992, 1411.0616440067342, 17176.398826041153, 17323.826761732347, 17333.13334333278, 17336.0, 17342.999999999873, 4999.425066117443, 5020.146575082244, 5117.641765076409, 5128.820491282787, 5211.843644690665, 12343.814842777365, 12346.0, 12364.690882728004, 12371.628851134481, 12377.195482293622, 6394.552381333262, 6397.488200943913, 6399.872002559922, 6407.743690252338, 6407.7757278495965, 5842.561807864342, 5857.88284234313, 5870.7945221917025, 5956.153592386374, 6016.217891674054, 4103.457718254486, 4139.668826493934, 4165.541790403053, 4184.4141820145205, 4196.0, 1040.443362800913, 1151.9251248668809, 1160.4081918221768, 1172.2146162071433, 1203.3093503627417, 722.9060222171189, 831.910197641092, 843.5799985095736, 857.5540718826176, 872.9869051964225, 5972.25346831646, 5985.281766188085, 6092.695365231721, 6101.735571469243, 6253.937460625427, 947.3747326764441, 960.7886265021684, 961.1925982175006, 968.9467079310706, 988.3476905242649, 3820.7325487215626, 3873.302805495038, 3890.2414029264587, 3906.4140378942816, 3923.2545816295383, 15119.470818521298, 15239.923800380928, 15498.225088745517, 15503.0, 15621.687566248838, 15197.316120774592, 15206.0, 15238.238088095552, 15241.23793810305, 15243.0, 9337.253019758404, 9561.61753529851, 9581.425114493153, 9636.891757447844, 9650.372725772802, 6704.262531121475, 6705.329467053451, 6734.09089772894, 6764.458843292623, 6869.931300686929, 13385.0, 13479.39342729599, 13773.793393098911, 13792.724145517233, 13828.239446830521, 13718.17690938547, 13775.931120344334, 13889.236092015037, 13906.374213160634, 14018.369173387426, 8585.484870907765, 8648.091950345122, 8666.263367613572, 8667.956660216658, 8672.913270867462, 10967.780644387227, 11386.032187264176, 11446.427678616203, 11462.82805757931, 11475.081993440337, 9454.810903782023, 9526.856777186505, 9577.904220957702, 9614.759631009001, 9785.902140978498, 9103.453792772454, 9294.209992150743, 9307.441553506811, 9319.394239374418, 9446.669366572138, 7631.427642926692, 7642.235776422313, 7720.652570634447, 7723.613819309125, 7726.0, 5834.358220595816, 5993.340732519332, 6014.6391216527145, 6189.133521306931, 6236.906446403398, 6087.726052327567, 6200.410960958701, 6200.441960223601, 6294.937050629618, 6364.713587888464], "value": 5292.09097097274, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.4945091165146, 426.258310539661, 426.31363504757337, 431.84237753220043, 434.66991007517, 5767.855803604902, 5903.114532820079, 5904.704764761761, 5925.2593425821715, 5931.466168044875, 5687.2606561147095, 5768.942310576893, 5771.595988280822, 5783.913241301373, 5805.477507024367, 4303.419038429819, 4363.912721745563, 4410.404595379631, 4426.490953540336, 4435.911281774363, 4386.802593883267, 4426.114777044588, 4426.313921342197, 4430.158269928703, 4439.2453282941815, 4371.497277813044, 4383.4739831220295, 4391.846285380012, 4397.626201772853, 4402.647788176938, 4291.399204111427, 4349.195398851207, 4400.251957167289, 4409.272470042439, 4419.0, 3831.6934645228594, 3839.596842331543, 3852.9019229519454, 3854.5759966403675, 3857.40210267409, 5632.127020311858, 5644.887102257973, 5652.604317697763, 5696.857578560528, 5712.22884910536, 5046.318746969149, 5181.611379146541, 5189.299444574972, 5218.895622087537, 5226.9546090782, 6109.205803245594, 6186.9381306186815, 6193.0, 6205.503559715212, 6219.0, 4346.391505189276, 4362.105768317488, 4362.8691139265875, 4367.10474352757, 4370.781460926941, 6152.630842149485, 6248.4064013918605, 6316.305206427335, 6421.29365769765, 6485.77299794505, 4306.181825453154, 4402.603765661106, 4410.492793328808, 4410.691251612357, 4431.955680443219, 4483.484399294058, 4484.192845287879, 4485.753283569435, 4496.168208881368, 4501.122281155209, 5085.843538567353, 5150.459201783834, 5160.7935682573025, 5161.587073034223, 5184.844454666366, 6147.708981114016, 6167.229096362955, 6185.226846644169, 6187.3503282154725, 6208.410201030895, 1525.9694806103817, 1537.4618883390947, 1541.8149822021205, 1542.506397952667, 1542.7994360733258, 995.2635050062902, 1017.9389236645825, 1031.783325501653, 1041.6874937518714, 1046.2414749306845, 5944.197533333031, 5962.766435830522, 6003.459688627957, 6013.872786151177, 6020.969895150496, 6331.240251169889, 6376.681165941684, 6383.202099737533, 6400.51996100285, 6413.551051426355, 5855.677937713466, 6031.638101713824, 6056.454919057306, 6067.7269522871575, 6069.969650151721, 3336.7831090979494, 3345.1135449106005, 3363.6636336366655, 3368.2589830237307, 3368.646292139339, 6394.776182833672, 6641.966790166115, 6660.966695166493, 6672.766453174116, 6729.707723278652, 6413.422791948747, 6494.447971922439, 6503.219613646298, 6505.837354066186, 6508.544401891917, 6442.871142577123, 6668.533202675766, 6673.9666301668185, 6674.432673222734, 6737.59574425536, 6365.681715914278, 6403.9359606405205, 6415.518836087405, 6433.9678301610065, 6440.677966101583, 6247.375262473716, 6292.996167056707, 6304.558680892477, 6323.620582765049, 6355.777547785805, 6328.0, 6463.935360646334, 6485.77299794505, 6638.834029149117, 6643.966780166068, 4428.623566996841, 4439.889002774957, 4440.400545926388, 4453.1761624099645, 4455.108978204307, 6253.187085678833, 6379.138816259746, 6384.329645387167, 6397.6481293529305, 6422.42198202164, 6187.4222073371, 6215.0, 6222.128901953821, 6223.96888015557, 6225.595336303126, 6066.423689749467, 6101.389861013863, 6151.753929842936, 6209.751609935552, 6219.844503887439, 6140.0, 6167.629942203482, 6191.690415479118, 6202.5658203925295, 6206.348333424925, 6253.249610046823, 6260.436560709558, 6262.091996660368, 6264.843378915563, 6265.530085243534, 5892.145638882253, 6017.308009578955, 6066.726997285221, 6075.27096748393, 6093.786717464867], "value": 4694.966074789004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.7089033835721, 869.4435561240807, 885.2519620920324, 885.4333226734886, 888.1828717579828, 16637.916810415933, 16775.328986840526, 17155.399561015336, 17166.0, 17182.054986975712, 16261.837381626181, 16686.0, 16701.331946722115, 16703.66592668146, 16711.331546738114, 1007.9092881640669, 1012.3166862367909, 1028.2236911132086, 1028.2596530498029, 1028.7325295423207, 1040.5681642118511, 1042.8957104289548, 1043.4678314059847, 1043.8642976413093, 1044.0812085364905, 1066.8559744434478, 1073.2272763610226, 1073.6295977887617, 1073.693997210795, 1075.0163600305711, 1072.13157342552, 1073.1843798712957, 1074.0870260278778, 1074.1997212077013, 1075.6504136155781, 776.9145394006712, 784.0, 786.6617354537547, 787.2560430393281, 787.7242964962275, 17456.82543174565, 17509.7373539397, 17587.824121758746, 18204.635907281914, 18230.0, 18316.908415457972, 18455.815441845545, 18978.240870365167, 19155.808441915542, 19194.520136996547, 14428.422863085463, 14838.554843354717, 14994.250287485582, 15031.624209394744, 15034.699306013928, 3376.9155771105675, 3401.795892246473, 3433.6738009889023, 3454.222799870034, 3496.108492334464, 84682.0, 85135.99999999937, 86146.56926715389, 86602.0, 86822.56588717079, 14774.26128693561, 15143.697126057417, 15158.545243642708, 15183.392664293304, 15207.163606001555, 26670.19989400321, 27149.59275610828, 27210.86394568054, 27674.0, 27716.445671086465, 8202.794930126674, 8414.705485308108, 8448.112948140357, 8452.323814094858, 8455.112213217646, 4261.21167583998, 4375.78121093944, 4376.299792033323, 4384.846530371422, 4394.209042372339, 4466.843660471868, 4498.887527811766, 4570.954290457119, 4592.425946756655, 4614.953850461452, 857.8841856349313, 858.5664239558982, 874.6719980007497, 875.8992715837633, 876.6931573949067, 738.5753191914671, 745.5563939456015, 748.4424104042523, 752.8569571781344, 782.5461232485259, 11475.827862582068, 12267.202631828903, 12411.689707757198, 13129.73740525184, 13183.802242966363, 728.9052423185058, 750.1710609776119, 750.598429840033, 752.4958277953784, 753.2128925273103, 5558.110702287615, 5657.010023245998, 5715.199872017921, 5757.193992841006, 5827.737751801179, 86505.5674721635, 86792.0, 87349.56325218333, 87460.5626971861, 88081.0, 74215.0, 74465.0, 77143.0, 77308.22691773123, 78231.60884195543, 65325.0, 67365.0, 67952.62165824173, 68163.65918170377, 68726.65636671784, 11166.944165279121, 11277.21059525858, 11380.260283081574, 11508.251963622337, 11613.76772464563, 36006.45990310095, 36266.0, 36656.0, 37023.81488092542, 38242.21972253468, 43237.35143972906, 43713.0, 43817.123657526034, 43914.341284880116, 45475.31787023131, 14539.927300363854, 14756.704865902837, 14827.0, 14915.254237287874, 15022.924885375503, 15163.620909477351, 15187.0, 15299.0, 15337.309821057856, 15411.922940385226, 14230.786538201728, 14273.0, 14306.785398218826, 18223.362182323555, 19063.618727625646, 16807.663846722753, 16837.663246735243, 16909.408170713967, 17434.651306974043, 17493.475195744148, 17754.0, 17786.37747678825, 18305.450836474927, 18314.26742930321, 18376.908115459337, 12934.870651293366, 13065.346732663138, 13121.212727236396, 13156.539521117098, 13839.723205536035, 13689.589312320646, 14396.784048239075, 15080.888675585646, 15529.922350388175, 15543.279926013129], "value": 8353.997733654363, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1483.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 109.0, 108.0, 116.0, 109.0, 109.0, 109.0, 109.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 117.0, 177.0, 117.0, 115.0, 118.0, 115.0, 135.0, 116.0], "value": 127.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 160.0, 162.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 114.0, 75.0, 74.0, 77.0, 74.0, 93.0, 74.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 83.0, 83.0, 82.0, 94.0, 82.0, 82.0, 105.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 112.0, 114.0, 113.0, 112.0, 113.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 167.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 44.0, 45.0, 46.0, 45.0, 46.0, 45.0, 45.0, 46.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 55.0, 55.0, 55.0, 56.0, 57.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 89.0, 81.0, 82.0, 89.0, 81.0, 80.0, 79.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 124.0, 125.0, 140.0, 122.0, 123.0, 122.0, 168.0, 132.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 180.0, 172.0, 188.0, 179.0, 180.0, 195.0, 176.0, 179.0], "value": 181.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 64.0, 65.0, 63.0, 64.0, 64.0, 63.0], "value": 64.5, "unit": "score"}]}]} 15:13:33 INFO - Return code: 0 15:13:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:13:33 INFO - # TBPL SUCCESS # 15:13:33 INFO - Running post-action listener: _resource_record_post_action 15:13:33 INFO - [mozharness: 2017-05-08 22:13:33.837103Z] Finished run-tests step (success) 15:13:33 INFO - Running post-run listener: _resource_record_post_run 15:13:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 368689152; Read time: 12; Write time: 194020 15:13:33 INFO - TinderboxPrint: CPU usage
12.9% 15:13:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:13:33 INFO - TinderboxPrint: I/O write bytes / time
368,689,152 / 194,020 15:13:33 INFO - TinderboxPrint: CPU idle
8,289.6 (87.1%) 15:13:33 INFO - TinderboxPrint: CPU user
1,182.5 (12.4%) 15:13:33 INFO - TinderboxPrint: Swap in / out
0 / 0 15:13:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107409408; Read time: 0; Write time: 67608 15:13:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 261279744; Read time: 0; Write time: 126412 15:13:34 INFO - Running post-run listener: _upload_blobber_files 15:13:34 INFO - Blob upload gear active. 15:13:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:13:34 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 15:13:34 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'] 15:13:34 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 15:13:34 INFO - (blobuploader) - INFO - Open directory for files ... 15:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:35 INFO - (blobuploader) - INFO - Done attempting. 15:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:36 INFO - (blobuploader) - INFO - Done attempting. 15:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:39 INFO - (blobuploader) - INFO - Done attempting. 15:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:13:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:40 INFO - (blobuploader) - INFO - Done attempting. 15:13:40 INFO - (blobuploader) - INFO - Iteration through files over. 15:13:40 INFO - Return code: 0 15:13:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:13:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:13:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80b4a554994cc261f9afff45b1be837428979fa0a640aad62ac03bceb51682f648ca74f01342b317626a49b68cf182f8b6c9ef46c254f9315728d836b8bdee5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf857b77c76807d8a064c728f919fccd65568a2993d1d64748b50cd9fcbfdbcff2c730d0e5ed6e3629c8b4b75d170fb5ed99026671a8864d655c7aa2fbeeb40", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c67ba545edae398abd6b2aba1f7b5eb0ed5da22f50fe4dfd05546b96ecf12270c8f30cffbb9a623ad0a03536455af8ceb304c3dcc0f8f44c230375ee74fd9e34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9089623568f905ba212bbf519d68e260e0ac7126aa54d54ba652ddbe7470094d36832d95772dac6c8ddb283482539cdd0a487271d34f1bf85cec7d880362407e"} 15:13:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:13:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:13:40 INFO - Contents: 15:13:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80b4a554994cc261f9afff45b1be837428979fa0a640aad62ac03bceb51682f648ca74f01342b317626a49b68cf182f8b6c9ef46c254f9315728d836b8bdee5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf857b77c76807d8a064c728f919fccd65568a2993d1d64748b50cd9fcbfdbcff2c730d0e5ed6e3629c8b4b75d170fb5ed99026671a8864d655c7aa2fbeeb40", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c67ba545edae398abd6b2aba1f7b5eb0ed5da22f50fe4dfd05546b96ecf12270c8f30cffbb9a623ad0a03536455af8ceb304c3dcc0f8f44c230375ee74fd9e34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9089623568f905ba212bbf519d68e260e0ac7126aa54d54ba652ddbe7470094d36832d95772dac6c8ddb283482539cdd0a487271d34f1bf85cec7d880362407e"} 15:13:40 INFO - Running post-run listener: copy_logs_to_upload_dir 15:13:40 INFO - Copying logs to upload dir... 15:13:40 INFO - mkdir: /builds/slave/test/build/upload/logs 15:13:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.566381 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-05-08 15:13:40.214493) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 15:13:40.219216) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80b4a554994cc261f9afff45b1be837428979fa0a640aad62ac03bceb51682f648ca74f01342b317626a49b68cf182f8b6c9ef46c254f9315728d836b8bdee5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf857b77c76807d8a064c728f919fccd65568a2993d1d64748b50cd9fcbfdbcff2c730d0e5ed6e3629c8b4b75d170fb5ed99026671a8864d655c7aa2fbeeb40", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c67ba545edae398abd6b2aba1f7b5eb0ed5da22f50fe4dfd05546b96ecf12270c8f30cffbb9a623ad0a03536455af8ceb304c3dcc0f8f44c230375ee74fd9e34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9089623568f905ba212bbf519d68e260e0ac7126aa54d54ba652ddbe7470094d36832d95772dac6c8ddb283482539cdd0a487271d34f1bf85cec7d880362407e"} build_url:https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/WZGSa1juRl6ql6NFpC4WSA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80b4a554994cc261f9afff45b1be837428979fa0a640aad62ac03bceb51682f648ca74f01342b317626a49b68cf182f8b6c9ef46c254f9315728d836b8bdee5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf857b77c76807d8a064c728f919fccd65568a2993d1d64748b50cd9fcbfdbcff2c730d0e5ed6e3629c8b4b75d170fb5ed99026671a8864d655c7aa2fbeeb40", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c67ba545edae398abd6b2aba1f7b5eb0ed5da22f50fe4dfd05546b96ecf12270c8f30cffbb9a623ad0a03536455af8ceb304c3dcc0f8f44c230375ee74fd9e34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9089623568f905ba212bbf519d68e260e0ac7126aa54d54ba652ddbe7470094d36832d95772dac6c8ddb283482539cdd0a487271d34f1bf85cec7d880362407e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 15:13:40.251839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:13:40.252202) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1494280370.809733-1898016130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:13:40.334442) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 15:13:40.336952) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 15:13:40.337340) ========= ========= Total master_lag: 0.19 =========