builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-073 starttime: 1494371743.34 results: success (0) revision: 2b6f6881a24a726364054aa69031927e2f3fc5fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:43.340450) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:43.341023) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:43.341297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:43.355789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:43.356047) ========= 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=0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-09 16:15:43-- 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% 217M=0s 2017-05-09 16:15:43 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.165361 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:43.535836) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:43.536148) ========= 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=0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023295 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:43.584959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-09 16:15:43.585272) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2b6f6881a24a726364054aa69031927e2f3fc5fa --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 2b6f6881a24a726364054aa69031927e2f3fc5fa --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=0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-09 16:15:43,845 truncating revision to first 12 chars 2017-05-09 16:15:43,845 Setting DEBUG logging. 2017-05-09 16:15:43,845 attempt 1/10 2017-05-09 16:15:43,845 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2b6f6881a24a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 16:15:44,610 unpacking tar archive at: mozilla-central-2b6f6881a24a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.027106 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-09 16:15:44.628899) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:44.629226) ========= script_repo_revision: 2b6f6881a24a726364054aa69031927e2f3fc5fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:44.629624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:44.629888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 16:15:44.642943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-09 16:15:44.643222) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:15:44 INFO - MultiFileLogger online at 20170509 16:15:44 in /builds/slave/test 16:15:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:15:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:15:44 INFO - {'append_to_log': False, 16:15:44 INFO - 'base_work_dir': '/builds/slave/test', 16:15:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:15:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:15:44 INFO - 'branch': 'Firefox-Non-PGO', 16:15:44 INFO - 'buildbot_json_path': 'buildprops.json', 16:15:44 INFO - 'config_files': ('talos/linux_config.py',), 16:15:44 INFO - 'default_actions': ('clobber', 16:15:44 INFO - 'read-buildbot-config', 16:15:44 INFO - 'download-and-extract', 16:15:44 INFO - 'populate-webroot', 16:15:44 INFO - 'create-virtualenv', 16:15:44 INFO - 'install', 16:15:44 INFO - 'run-tests'), 16:15:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:15:44 INFO - 'download_minidump_stackwalk': True, 16:15:44 INFO - 'download_symbols': 'ondemand', 16:15:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:15:44 INFO - 'tooltool.py': '/tools/tooltool.py', 16:15:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:15:44 INFO - '/tools/misc-python/virtualenv.py')}, 16:15:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:15:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:15:44 INFO - 'gecko_profile': False, 16:15:44 INFO - 'gecko_profile_interval': 0, 16:15:44 INFO - 'installer_path': 'installer.exe', 16:15:44 INFO - 'log_level': 'info', 16:15:44 INFO - 'log_name': 'talos', 16:15:44 INFO - 'log_to_console': True, 16:15:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:15:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:15:44 INFO - 'opt_config_files': (), 16:15:44 INFO - 'pip_index': False, 16:15:44 INFO - 'suite': 'dromaeojs-e10s', 16:15:44 INFO - 'system_bits': '32', 16:15:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:15:44 INFO - 'title': 'talos-linux64-ix-073', 16:15:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:15:44 INFO - 'use_talos_json': True, 16:15:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:15:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:15:44 INFO - 'work_dir': 'build'} 16:15:44 INFO - [mozharness: 2017-05-09 23:15:44.996169Z] Running clobber step. 16:15:44 INFO - Running pre-action listener: _resource_record_pre_action 16:15:44 INFO - Running main action method: clobber 16:15:44 INFO - rmtree: /builds/slave/test/build 16:15:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:15:46 INFO - Running post-action listener: _resource_record_post_action 16:15:46 INFO - [mozharness: 2017-05-09 23:15:46.528838Z] Finished clobber step (success) 16:15:46 INFO - [mozharness: 2017-05-09 23:15:46.528937Z] Running read-buildbot-config step. 16:15:46 INFO - Running pre-action listener: _resource_record_pre_action 16:15:46 INFO - Running main action method: read_buildbot_config 16:15:46 INFO - Using buildbot properties: 16:15:46 INFO - { 16:15:46 INFO - "project": "", 16:15:46 INFO - "product": "firefox", 16:15:46 INFO - "who": "kwierso@gmail.com", 16:15:46 INFO - "installer_path": "public/build/target.tar.bz2", 16:15:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:15:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:15:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:15:46 INFO - "stage_platform": "linux64", 16:15:46 INFO - "basedir": "/builds/slave/test", 16:15:46 INFO - "buildnumber": 820, 16:15:46 INFO - "platform": "ubuntu64_hw", 16:15:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:15:46 INFO - "slavebuilddir": "test", 16:15:46 INFO - "taskId": "MEridungS1qxy2WNbo7w1g", 16:15:46 INFO - "branch": "mozilla-central", 16:15:46 INFO - "script_repo_revision": "production", 16:15:46 INFO - "revision": "2b6f6881a24a726364054aa69031927e2f3fc5fa", 16:15:46 INFO - "slavename": "talos-linux64-ix-073", 16:15:46 INFO - "repo_path": "mozilla-central" 16:15:46 INFO - } 16:15:46 INFO - Finding installer, test and symbols from parent task. 16:15:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MEridungS1qxy2WNbo7w1g'}, attempt #1 16:15:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MEridungS1qxy2WNbo7w1g'}, attempt #1 16:15:47 INFO - Task dependencies: YV2HgeL5S5iKdWYV2Pnp0A 16:15:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A'}, attempt #1 16:15:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.tar.bz2 16:15:47 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/test_packages.json 16:15:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.crashreporter-symbols.zip 16:15:47 INFO - Running post-action listener: _resource_record_post_action 16:15:47 INFO - [mozharness: 2017-05-09 23:15:47.884651Z] Finished read-buildbot-config step (success) 16:15:47 INFO - [mozharness: 2017-05-09 23:15:47.884868Z] Running download-and-extract step. 16:15:47 INFO - Running pre-action listener: _resource_record_pre_action 16:15:47 INFO - Running main action method: download_and_extract 16:15:47 INFO - mkdir: /builds/slave/test/build/tests 16:15:47 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')]} 16:15:47 INFO - trying https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.test_packages.json 16:15:47 INFO - Downloading https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:15:48 INFO - Downloaded 986 bytes. 16:15:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:15:48 INFO - Using the following test package requirements: 16:15:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:15:48 INFO - u'common': [u'target.common.tests.zip'], 16:15:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:15:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:15:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:15:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:15:48 INFO - u'mozbase': [u'target.common.tests.zip'], 16:15:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:15:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:15:48 INFO - u'web-platform': [u'target.common.tests.zip', 16:15:48 INFO - u'target.web-platform.tests.zip'], 16:15:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:15:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:15:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.common.tests.zip 16:15:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:15:48 INFO - Fetch https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.common.tests.zip into memory 16:15:49 INFO - Content-Length response header: 58446291 16:15:49 INFO - Bytes received: 58446291 16:15:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:15:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.common.tests.zip 16:15:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:15:59 INFO - Fetch https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.common.tests.zip into memory 16:16:00 INFO - Content-Length response header: 58446291 16:16:00 INFO - Bytes received: 58446291 16:16:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.talos.tests.zip 16:16:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:16:11 INFO - Fetch https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.talos.tests.zip into memory 16:16:12 INFO - Content-Length response header: 14409362 16:16:12 INFO - Bytes received: 14409362 16:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:12 INFO - trying https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.tar.bz2 16:16:12 INFO - Downloading https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:16:13 INFO - Downloaded 62882168 bytes. 16:16:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.tar.bz2 16:16:13 INFO - mkdir: /builds/slave/test/properties 16:16:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:16:13 INFO - Writing to file /builds/slave/test/properties/build_url 16:16:13 INFO - Contents: 16:16:13 INFO - build_url:https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.tar.bz2 16:16:13 INFO - Running post-action listener: _resource_record_post_action 16:16:13 INFO - Running post-action listener: set_extra_try_arguments 16:16:13 INFO - [mozharness: 2017-05-09 23:16:13.500222Z] Finished download-and-extract step (success) 16:16:13 INFO - [mozharness: 2017-05-09 23:16:13.500320Z] Running populate-webroot step. 16:16:13 INFO - Running pre-action listener: _resource_record_pre_action 16:16:13 INFO - Running main action method: populate_webroot 16:16:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:16:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:16:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:16:13 INFO - '--tppagecycles', 16:16:13 INFO - '7'], 16:16:13 INFO - 'tests': ['tsvgm']}}, 16:16:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:16:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:16:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:16:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:16:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:16:13 INFO - 'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:16:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:16:13 INFO - 'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['damp', 'tps']}, 16:16:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:16:13 INFO - 'tests': ['damp', 'tps']}, 16:16:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['dromaeo_dom']}, 16:16:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:16:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:16:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:16:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['a11yr', 16:16:13 INFO - 'ts_paint', 16:16:13 INFO - 'tpaint', 16:16:13 INFO - 'sessionrestore', 16:16:13 INFO - 'sessionrestore_no_auto_restore', 16:16:13 INFO - 'tabpaint']}, 16:16:13 INFO - 'other-e10s': {'tests': ['a11yr', 16:16:13 INFO - 'ts_paint', 16:16:13 INFO - 'tpaint', 16:16:13 INFO - 'sessionrestore', 16:16:13 INFO - 'sessionrestore_no_auto_restore', 16:16:13 INFO - 'tabpaint']}, 16:16:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:16:13 INFO - 'ts_paint', 16:16:13 INFO - 'tpaint', 16:16:13 INFO - 'sessionrestore', 16:16:13 INFO - 'sessionrestore_no_auto_restore', 16:16:13 INFO - 'tabpaint']}, 16:16:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:16:13 INFO - 'ts_paint', 16:16:13 INFO - 'tpaint', 16:16:13 INFO - 'sessionrestore', 16:16:13 INFO - 'sessionrestore_no_auto_restore', 16:16:13 INFO - 'tabpaint']}, 16:16:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['a11yr', 16:16:13 INFO - 'ts_paint', 16:16:13 INFO - 'tpaint', 16:16:13 INFO - 'sessionrestore', 16:16:13 INFO - 'sessionrestore_no_auto_restore', 16:16:13 INFO - 'tabpaint']}, 16:16:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['a11yr', 16:16:13 INFO - 'ts_paint', 16:16:13 INFO - 'tpaint', 16:16:13 INFO - 'sessionrestore', 16:16:13 INFO - 'sessionrestore_no_auto_restore', 16:16:13 INFO - 'tabpaint']}, 16:16:13 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:16:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:16:13 INFO - 'bloom_basic_ref']}, 16:16:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['tsvgx', 16:16:13 INFO - 'tsvgr_opacity', 16:16:13 INFO - 'tart', 16:16:13 INFO - 'tscrollx', 16:16:13 INFO - 'cart', 16:16:13 INFO - 'tsvg_static']}, 16:16:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:16:13 INFO - 'tsvgr_opacity', 16:16:13 INFO - 'tart', 16:16:13 INFO - 'tscrollx', 16:16:13 INFO - 'cart', 16:16:13 INFO - 'tsvg_static']}, 16:16:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:16:13 INFO - 'talos_options': ['--disable-e10s'], 16:16:13 INFO - 'tests': ['tp5o']}, 16:16:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:16:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:16:13 INFO - 'talos_options': ['--disable-e10s', 16:16:13 INFO - '--xperf_path', 16:16:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:13 INFO - 'tests': ['tp5n']}, 16:16:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:16:13 INFO - 'talos_options': ['--xperf_path', 16:16:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:13 INFO - 'tests': ['tp5n']}}, 16:16:13 INFO - 'talos.zip': {'path': '', 16:16:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:16:13 INFO - Running post-action listener: _resource_record_post_action 16:16:13 INFO - [mozharness: 2017-05-09 23:16:13.514087Z] Finished populate-webroot step (success) 16:16:13 INFO - [mozharness: 2017-05-09 23:16:13.514176Z] Running create-virtualenv step. 16:16:13 INFO - Running pre-action listener: _resource_record_pre_action 16:16:13 INFO - Running main action method: create_virtualenv 16:16:13 INFO - Creating virtualenv /builds/slave/test/build/venv 16:16:13 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 16:16:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:16:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:16:13 INFO - Using real prefix '/usr' 16:16:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:16:14 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:16 INFO - Installing pip.................done. 16:16:16 INFO - Return code: 0 16:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:16:16 INFO - Reading from file tmpfile_stdout 16:16:16 INFO - Output received: 16:16:16 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) 16:16:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16:16 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')]} 16:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:16 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')]} 16:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:16 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, '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': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', '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 16:16:16 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 16:16:16 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 16:16:16 INFO - Using env: {'DISPLAY': ':0', 16:16:16 INFO - 'HOME': '/home/cltbld', 16:16:16 INFO - 'LANG': 'en_US.UTF-8', 16:16:16 INFO - 'LANGUAGE': 'en_US:en', 16:16:16 INFO - 'LOGNAME': 'cltbld', 16:16:16 INFO - 'MAIL': '/var/mail/cltbld', 16:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:16 INFO - 'MOZ_NO_REMOTE': '1', 16:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:16 INFO - 'NO_EM_RESTART': '1', 16:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:16 INFO - 'PWD': '/builds/slave/test', 16:16:16 INFO - 'SHELL': '/bin/bash', 16:16:16 INFO - 'SHLVL': '1', 16:16:16 INFO - 'TERM': 'linux', 16:16:16 INFO - 'TMOUT': '86400', 16:16:16 INFO - 'USER': 'cltbld', 16:16:16 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:16 INFO - '_': '/tools/buildbot/bin/python'} 16:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:16 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 16:16:16 INFO - Cleaning up... 16:16:16 INFO - Return code: 0 16:16:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:16:16 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')]} 16:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:16 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')]} 16:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:16 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, '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': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', '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 16:16:16 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 16:16:16 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 16:16:16 INFO - Using env: {'DISPLAY': ':0', 16:16:16 INFO - 'HOME': '/home/cltbld', 16:16:16 INFO - 'LANG': 'en_US.UTF-8', 16:16:16 INFO - 'LANGUAGE': 'en_US:en', 16:16:16 INFO - 'LOGNAME': 'cltbld', 16:16:16 INFO - 'MAIL': '/var/mail/cltbld', 16:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:16 INFO - 'MOZ_NO_REMOTE': '1', 16:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:16 INFO - 'NO_EM_RESTART': '1', 16:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:16 INFO - 'PWD': '/builds/slave/test', 16:16:16 INFO - 'SHELL': '/bin/bash', 16:16:16 INFO - 'SHLVL': '1', 16:16:16 INFO - 'TERM': 'linux', 16:16:16 INFO - 'TMOUT': '86400', 16:16:16 INFO - 'USER': 'cltbld', 16:16:16 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:16 INFO - '_': '/tools/buildbot/bin/python'} 16:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:16 INFO - Downloading/unpacking psutil>=3.1.1 16:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:17 INFO - Installing collected packages: psutil 16:16:17 INFO - Running setup.py install for psutil 16:16:18 INFO - building 'psutil._psutil_linux' extension 16:16:18 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 16:16:18 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 16:16:18 INFO - building 'psutil._psutil_posix' extension 16:16:18 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 16:16:18 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 16:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:18 INFO - Successfully installed psutil 16:16:18 INFO - Cleaning up... 16:16:18 INFO - Return code: 0 16:16:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, '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': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', '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 16:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:16:18 INFO - Using env: {'DISPLAY': ':0', 16:16:18 INFO - 'HOME': '/home/cltbld', 16:16:18 INFO - 'LANG': 'en_US.UTF-8', 16:16:18 INFO - 'LANGUAGE': 'en_US:en', 16:16:18 INFO - 'LOGNAME': 'cltbld', 16:16:18 INFO - 'MAIL': '/var/mail/cltbld', 16:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:18 INFO - 'MOZ_NO_REMOTE': '1', 16:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:18 INFO - 'NO_EM_RESTART': '1', 16:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:18 INFO - 'PWD': '/builds/slave/test', 16:16:18 INFO - 'SHELL': '/bin/bash', 16:16:18 INFO - 'SHLVL': '1', 16:16:18 INFO - 'TERM': 'linux', 16:16:18 INFO - 'TMOUT': '86400', 16:16:18 INFO - 'USER': 'cltbld', 16:16:18 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:18 INFO - '_': '/tools/buildbot/bin/python'} 16:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:16:18 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 16:16:18 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 16:16:18 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 16:16:18 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 16:16:18 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 16:16:18 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 16:16:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:16:19 INFO - Installing collected packages: mozsystemmonitor 16:16:19 INFO - Running setup.py install for mozsystemmonitor 16:16:19 INFO - Successfully installed mozsystemmonitor 16:16:19 INFO - Cleaning up... 16:16:20 INFO - Return code: 0 16:16:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:20 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, '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': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', '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 16:16:20 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 16:16:20 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 16:16:20 INFO - Using env: {'DISPLAY': ':0', 16:16:20 INFO - 'HOME': '/home/cltbld', 16:16:20 INFO - 'LANG': 'en_US.UTF-8', 16:16:20 INFO - 'LANGUAGE': 'en_US:en', 16:16:20 INFO - 'LOGNAME': 'cltbld', 16:16:20 INFO - 'MAIL': '/var/mail/cltbld', 16:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:20 INFO - 'MOZ_NO_REMOTE': '1', 16:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:20 INFO - 'NO_EM_RESTART': '1', 16:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:20 INFO - 'PWD': '/builds/slave/test', 16:16:20 INFO - 'SHELL': '/bin/bash', 16:16:20 INFO - 'SHLVL': '1', 16:16:20 INFO - 'TERM': 'linux', 16:16:20 INFO - 'TMOUT': '86400', 16:16:20 INFO - 'USER': 'cltbld', 16:16:20 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:20 INFO - '_': '/tools/buildbot/bin/python'} 16:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:20 INFO - Downloading/unpacking jsonschema==2.5.1 16:16:20 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 16:16:20 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 16:16:20 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 16:16:20 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 16:16:20 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 16:16:20 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 16:16:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:16:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:16:21 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 16:16:21 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 16:16:21 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 16:16:21 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 16:16:21 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 16:16:21 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 16:16:21 INFO - Downloading functools32-3.2.3-2.tar.gz 16:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:16:21 INFO - warning: no files found matching '*.txt' 16:16:21 INFO - no previously-included directories found matching 'build' 16:16:21 INFO - no previously-included directories found matching 'dist' 16:16:21 INFO - no previously-included directories found matching '.git*' 16:16:21 INFO - Installing collected packages: jsonschema, functools32 16:16:21 INFO - Running setup.py install for functools32 16:16:21 INFO - warning: no files found matching '*.txt' 16:16:21 INFO - no previously-included directories found matching 'build' 16:16:21 INFO - no previously-included directories found matching 'dist' 16:16:21 INFO - no previously-included directories found matching '.git*' 16:16:21 INFO - Successfully installed jsonschema functools32 16:16:21 INFO - Cleaning up... 16:16:21 INFO - Return code: 0 16:16:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:16:21 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')]} 16:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:21 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')]} 16:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:21 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, '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': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', '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 16:16:21 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 16:16:21 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 16:16:21 INFO - Using env: {'DISPLAY': ':0', 16:16:21 INFO - 'HOME': '/home/cltbld', 16:16:21 INFO - 'LANG': 'en_US.UTF-8', 16:16:21 INFO - 'LANGUAGE': 'en_US:en', 16:16:21 INFO - 'LOGNAME': 'cltbld', 16:16:21 INFO - 'MAIL': '/var/mail/cltbld', 16:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:21 INFO - 'MOZ_NO_REMOTE': '1', 16:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:21 INFO - 'NO_EM_RESTART': '1', 16:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:21 INFO - 'PWD': '/builds/slave/test', 16:16:21 INFO - 'SHELL': '/bin/bash', 16:16:21 INFO - 'SHLVL': '1', 16:16:21 INFO - 'TERM': 'linux', 16:16:21 INFO - 'TMOUT': '86400', 16:16:21 INFO - 'USER': 'cltbld', 16:16:21 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:21 INFO - '_': '/tools/buildbot/bin/python'} 16:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:16:21 INFO - Cleaning up... 16:16:21 INFO - Return code: 0 16:16:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:16:21 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')]} 16:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:21 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')]} 16:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:21 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, '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': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', '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 16:16:21 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 16:16:21 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 16:16:21 INFO - Using env: {'DISPLAY': ':0', 16:16:21 INFO - 'HOME': '/home/cltbld', 16:16:21 INFO - 'LANG': 'en_US.UTF-8', 16:16:21 INFO - 'LANGUAGE': 'en_US:en', 16:16:21 INFO - 'LOGNAME': 'cltbld', 16:16:21 INFO - 'MAIL': '/var/mail/cltbld', 16:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:21 INFO - 'MOZ_NO_REMOTE': '1', 16:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:21 INFO - 'NO_EM_RESTART': '1', 16:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:21 INFO - 'PWD': '/builds/slave/test', 16:16:21 INFO - 'SHELL': '/bin/bash', 16:16:21 INFO - 'SHLVL': '1', 16:16:21 INFO - 'TERM': 'linux', 16:16:21 INFO - 'TMOUT': '86400', 16:16:21 INFO - 'USER': 'cltbld', 16:16:21 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:21 INFO - '_': '/tools/buildbot/bin/python'} 16:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:22 INFO - Downloading/unpacking blobuploader==1.2.4 16:16:22 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 16:16:22 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 16:16:22 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 16:16:22 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 16:16:22 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 16:16:22 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 16:16:23 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16:23 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 16:16:23 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 16:16:23 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 16:16:23 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 16:16:23 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 16:16:23 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 16:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:16:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:16:23 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 16:16:23 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 16:16:23 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 16:16:23 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 16:16:23 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 16:16:23 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 16:16:23 INFO - Downloading docopt-0.6.1.tar.gz 16:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:16:24 INFO - Installing collected packages: blobuploader, requests, docopt 16:16:24 INFO - Running setup.py install for blobuploader 16:16:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:16:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:16:24 INFO - Running setup.py install for requests 16:16:24 INFO - Running setup.py install for docopt 16:16:24 INFO - Successfully installed blobuploader requests docopt 16:16:24 INFO - Cleaning up... 16:16:24 INFO - Return code: 0 16:16:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:24 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, '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': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', '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 16:16:24 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 16:16:24 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 16:16:24 INFO - Using env: {'DISPLAY': ':0', 16:16:24 INFO - 'HOME': '/home/cltbld', 16:16:24 INFO - 'LANG': 'en_US.UTF-8', 16:16:24 INFO - 'LANGUAGE': 'en_US:en', 16:16:24 INFO - 'LOGNAME': 'cltbld', 16:16:24 INFO - 'MAIL': '/var/mail/cltbld', 16:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:24 INFO - 'MOZ_NO_REMOTE': '1', 16:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:24 INFO - 'NO_EM_RESTART': '1', 16:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:24 INFO - 'PWD': '/builds/slave/test', 16:16:24 INFO - 'SHELL': '/bin/bash', 16:16:24 INFO - 'SHLVL': '1', 16:16:24 INFO - 'TERM': 'linux', 16:16:24 INFO - 'TMOUT': '86400', 16:16:24 INFO - 'USER': 'cltbld', 16:16:24 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:24 INFO - '_': '/tools/buildbot/bin/python'} 16:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:24 INFO - Running setup.py (path:/tmp/pip-W7Wctg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:24 INFO - Running setup.py (path:/tmp/pip-LMdTzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:24 INFO - Running setup.py (path:/tmp/pip-1ubtDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:25 INFO - Running setup.py (path:/tmp/pip-6iuAKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:25 INFO - Running setup.py (path:/tmp/pip-G6fkVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:25 INFO - Running setup.py (path:/tmp/pip-Y0Ju2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:25 INFO - Running setup.py (path:/tmp/pip-zNuxHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:25 INFO - Running setup.py (path:/tmp/pip-h2gQZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:25 INFO - Running setup.py (path:/tmp/pip-1d6fo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:25 INFO - Running setup.py (path:/tmp/pip-EmWpUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:25 INFO - Running setup.py (path:/tmp/pip-2qYhTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:25 INFO - Running setup.py (path:/tmp/pip-5YdiHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:25 INFO - Running setup.py (path:/tmp/pip-zpjDkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:25 INFO - Running setup.py (path:/tmp/pip-WZxmkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:25 INFO - Running setup.py (path:/tmp/pip-h1S3gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:25 INFO - Running setup.py (path:/tmp/pip-fh7fRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:25 INFO - Running setup.py (path:/tmp/pip-Mkda1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:16:26 INFO - Running setup.py install for manifestparser 16:16:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:16:26 INFO - Running setup.py install for mozcrash 16:16:26 INFO - Running setup.py install for mozdebug 16:16:26 INFO - Running setup.py install for mozdevice 16:16:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:16:26 INFO - Running setup.py install for mozfile 16:16:26 INFO - Running setup.py install for mozhttpd 16:16:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:16:26 INFO - Running setup.py install for mozinfo 16:16:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:16:26 INFO - Running setup.py install for mozInstall 16:16:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:16:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:16:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:16:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:16:26 INFO - Running setup.py install for mozleak 16:16:26 INFO - Running setup.py install for mozlog 16:16:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:16:27 INFO - Running setup.py install for moznetwork 16:16:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:16:27 INFO - Running setup.py install for mozprocess 16:16:27 INFO - Running setup.py install for mozprofile 16:16:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:16:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:16:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:16:27 INFO - Running setup.py install for mozrunner 16:16:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:16:27 INFO - Running setup.py install for mozscreenshot 16:16:27 INFO - Running setup.py install for moztest 16:16:27 INFO - Running setup.py install for mozversion 16:16:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:16:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:16:27 INFO - Cleaning up... 16:16:27 INFO - Return code: 0 16:16:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:27 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')]} 16:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:27 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')]} 16:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:27 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, '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': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', '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 16:16:27 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 16:16:27 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 16:16:27 INFO - Using env: {'DISPLAY': ':0', 16:16:27 INFO - 'HOME': '/home/cltbld', 16:16:27 INFO - 'LANG': 'en_US.UTF-8', 16:16:27 INFO - 'LANGUAGE': 'en_US:en', 16:16:27 INFO - 'LOGNAME': 'cltbld', 16:16:27 INFO - 'MAIL': '/var/mail/cltbld', 16:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:27 INFO - 'MOZ_NO_REMOTE': '1', 16:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:27 INFO - 'NO_EM_RESTART': '1', 16:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:27 INFO - 'PWD': '/builds/slave/test', 16:16:27 INFO - 'SHELL': '/bin/bash', 16:16:27 INFO - 'SHLVL': '1', 16:16:27 INFO - 'TERM': 'linux', 16:16:27 INFO - 'TMOUT': '86400', 16:16:27 INFO - 'USER': 'cltbld', 16:16:27 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:27 INFO - '_': '/tools/buildbot/bin/python'} 16:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:28 INFO - Running setup.py (path:/tmp/pip-Ap9B9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:28 INFO - Running setup.py (path:/tmp/pip-i2b1xZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:28 INFO - Running setup.py (path:/tmp/pip-LpLNGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:28 INFO - Running setup.py (path:/tmp/pip-JGMCky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:28 INFO - Running setup.py (path:/tmp/pip-G7zzkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:28 INFO - Running setup.py (path:/tmp/pip-48VDO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:28 INFO - Running setup.py (path:/tmp/pip-QvEj0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:28 INFO - Running setup.py (path:/tmp/pip-Z92Id7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:28 INFO - Running setup.py (path:/tmp/pip-SOjBVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:28 INFO - Running setup.py (path:/tmp/pip-1Plqg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:28 INFO - Running setup.py (path:/tmp/pip-Ks32zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:28 INFO - Running setup.py (path:/tmp/pip-D4TrGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:28 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)) 16:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:28 INFO - Running setup.py (path:/tmp/pip-hSkNj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:29 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)) 16:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:29 INFO - Running setup.py (path:/tmp/pip-072GcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:29 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)) 16:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:29 INFO - Running setup.py (path:/tmp/pip-pLJo4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:29 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)) 16:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:29 INFO - Running setup.py (path:/tmp/pip-WP6PoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:29 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)) 16:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:29 INFO - Running setup.py (path:/tmp/pip-BEupma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:29 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)) 16:16:29 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)) 16:16:29 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)) 16:16:29 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)) 16:16:29 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)) 16:16:29 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)) 16:16:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:30 INFO - Downloading blessings-1.6.tar.gz 16:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:16:30 INFO - Installing collected packages: blessings 16:16:30 INFO - Running setup.py install for blessings 16:16:30 INFO - Successfully installed blessings 16:16:30 INFO - Cleaning up... 16:16:30 INFO - Return code: 0 16:16:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:16:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:30 INFO - Reading from file tmpfile_stdout 16:16:30 INFO - Current package versions: 16:16:30 INFO - argparse == 1.2.1 16:16:30 INFO - blessings == 1.6 16:16:30 INFO - blobuploader == 1.2.4 16:16:30 INFO - docopt == 0.6.1 16:16:30 INFO - functools32 == 3.2.3-2 16:16:30 INFO - jsonschema == 2.5.1 16:16:30 INFO - manifestparser == 1.1 16:16:30 INFO - mozInstall == 1.12 16:16:30 INFO - mozcrash == 1.0 16:16:30 INFO - mozdebug == 0.1 16:16:30 INFO - mozdevice == 0.50 16:16:30 INFO - mozfile == 1.2 16:16:30 INFO - mozhttpd == 0.7 16:16:30 INFO - mozinfo == 0.9 16:16:30 INFO - mozleak == 0.1 16:16:30 INFO - mozlog == 3.4 16:16:30 INFO - moznetwork == 0.27 16:16:30 INFO - mozprocess == 0.25 16:16:30 INFO - mozprofile == 0.28 16:16:30 INFO - mozrunner == 6.13 16:16:30 INFO - mozscreenshot == 0.1 16:16:30 INFO - mozsystemmonitor == 0.3 16:16:30 INFO - moztest == 0.8 16:16:30 INFO - mozversion == 1.4 16:16:30 INFO - psutil == 3.1.1 16:16:30 INFO - requests == 1.2.3 16:16:30 INFO - wsgiref == 0.1.2 16:16:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:30 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, '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': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', '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 16:16:30 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 16:16:30 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 16:16:30 INFO - Using env: {'DISPLAY': ':0', 16:16:30 INFO - 'HOME': '/home/cltbld', 16:16:30 INFO - 'LANG': 'en_US.UTF-8', 16:16:30 INFO - 'LANGUAGE': 'en_US:en', 16:16:30 INFO - 'LOGNAME': 'cltbld', 16:16:30 INFO - 'MAIL': '/var/mail/cltbld', 16:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:30 INFO - 'MOZ_NO_REMOTE': '1', 16:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:30 INFO - 'NO_EM_RESTART': '1', 16:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:30 INFO - 'PWD': '/builds/slave/test', 16:16:30 INFO - 'SHELL': '/bin/bash', 16:16:30 INFO - 'SHLVL': '1', 16:16:30 INFO - 'TERM': 'linux', 16:16:30 INFO - 'TMOUT': '86400', 16:16:30 INFO - 'USER': 'cltbld', 16:16:30 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:30 INFO - '_': '/tools/buildbot/bin/python'} 16:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 INFO - Cleaning up... 16:16:31 INFO - Return code: 0 16:16:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:16:31 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')]} 16:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:31 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')]} 16:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:31 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 0x28f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, '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': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', '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 16:16:31 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 16:16:31 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 16:16:31 INFO - Using env: {'DISPLAY': ':0', 16:16:31 INFO - 'HOME': '/home/cltbld', 16:16:31 INFO - 'LANG': 'en_US.UTF-8', 16:16:31 INFO - 'LANGUAGE': 'en_US:en', 16:16:31 INFO - 'LOGNAME': 'cltbld', 16:16:31 INFO - 'MAIL': '/var/mail/cltbld', 16:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:31 INFO - 'MOZ_NO_REMOTE': '1', 16:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:31 INFO - 'NO_EM_RESTART': '1', 16:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:31 INFO - 'PWD': '/builds/slave/test', 16:16:31 INFO - 'SHELL': '/bin/bash', 16:16:31 INFO - 'SHLVL': '1', 16:16:31 INFO - 'TERM': 'linux', 16:16:31 INFO - 'TMOUT': '86400', 16:16:31 INFO - 'USER': 'cltbld', 16:16:31 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:31 INFO - '_': '/tools/buildbot/bin/python'} 16:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:16:31 INFO - Cleaning up... 16:16:31 INFO - Return code: 0 16:16:31 INFO - Running post-action listener: _resource_record_post_action 16:16:31 INFO - Running post-action listener: _start_resource_monitoring 16:16:31 INFO - Starting resource monitoring. 16:16:31 INFO - [mozharness: 2017-05-09 23:16:31.363766Z] Finished create-virtualenv step (success) 16:16:31 INFO - [mozharness: 2017-05-09 23:16:31.364270Z] Running install step. 16:16:31 INFO - Running pre-action listener: _resource_record_pre_action 16:16:31 INFO - Running main action method: install 16:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:31 INFO - Reading from file tmpfile_stdout 16:16:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:16:31 INFO - Reading from file tmpfile_stdout 16:16:31 INFO - Output received: 16:16:31 INFO - Usage: mozinstall [options] installer 16:16:31 INFO - Options: 16:16:31 INFO - -h, --help show this help message and exit 16:16:31 INFO - -d DEST, --destination=DEST 16:16:31 INFO - Directory to install application into. [default: 16:16:31 INFO - "/builds/slave/test"] 16:16:31 INFO - --app=APP Application being installed. [default: firefox] 16:16:31 INFO - mkdir: /builds/slave/test/build/application 16:16:31 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'] 16:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:16:47 INFO - Reading from file tmpfile_stdout 16:16:47 INFO - Output received: 16:16:47 INFO - /builds/slave/test/build/application/firefox/firefox 16:16:47 INFO - Running post-action listener: _resource_record_post_action 16:16:47 INFO - [mozharness: 2017-05-09 23:16:47.419033Z] Finished install step (success) 16:16:47 INFO - [mozharness: 2017-05-09 23:16:47.419281Z] Running run-tests step. 16:16:47 INFO - Running pre-action listener: _resource_record_pre_action 16:16:47 INFO - Running main action method: run_tests 16:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:16:47 INFO - Python 2.7.3 16:16:47 INFO - Return code: 0 16:16:47 INFO - grabbing minidump binary from tooltool 16:16:47 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')]} 16:16:47 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 0x2c62a30>, '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 0x2c637f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c63ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:16:47 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 16:16:47 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 16:16:47 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 16:16:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:16:47 INFO - Return code: 0 16:16:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:16:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:16:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:16:47 INFO - ENV: RUST_BACKTRACE is now 1 16:16:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:16:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-073 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:16:47 INFO - Using env: {'DISPLAY': ':0', 16:16:47 INFO - 'HOME': '/home/cltbld', 16:16:47 INFO - 'LANG': 'en_US.UTF-8', 16:16:47 INFO - 'LANGUAGE': 'en_US:en', 16:16:47 INFO - 'LOGNAME': 'cltbld', 16:16:47 INFO - 'MAIL': '/var/mail/cltbld', 16:16:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:16:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:47 INFO - 'MOZ_NO_REMOTE': '1', 16:16:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:47 INFO - 'NO_EM_RESTART': '1', 16:16:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:47 INFO - 'PWD': '/builds/slave/test', 16:16:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:16:47 INFO - 'RUST_BACKTRACE': '1', 16:16:47 INFO - 'SHELL': '/bin/bash', 16:16:47 INFO - 'SHLVL': '1', 16:16:47 INFO - 'TERM': 'linux', 16:16:47 INFO - 'TMOUT': '86400', 16:16:47 INFO - 'USER': 'cltbld', 16:16:47 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688', 16:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:47 INFO - '_': '/tools/buildbot/bin/python'} 16:16:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:16:47 INFO - mozversion application_buildid: 20170509204849 16:16:47 INFO - mozversion application_changeset: 2b6f6881a24a726364054aa69031927e2f3fc5fa 16:16:47 INFO - mozversion application_display_name: Nightly 16:16:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:16:47 INFO - mozversion application_name: Firefox 16:16:47 INFO - mozversion application_remotingname: firefox 16:16:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:16:47 INFO - mozversion application_vendor: Mozilla 16:16:47 INFO - mozversion application_version: 55.0a1 16:16:47 INFO - mozversion platform_buildid: 20170509204849 16:16:47 INFO - mozversion platform_changeset: 2b6f6881a24a726364054aa69031927e2f3fc5fa 16:16:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:16:47 INFO - mozversion platform_version: 55.0a1 16:16:47 INFO - using testdate: 1494371807 16:16:47 INFO - actual date: 1494371807 16:16:47 INFO - starting webserver on 'localhost:60381' 16:16:47 INFO - SUITE-START | Running 2 tests 16:16:47 INFO - TEST-START | dromaeo_css 16:16:47 INFO - operating with platform_type : linux_ 16:16:47 INFO - Initialising browser for dromaeo_css test... 16:16:47 INFO - TEST-INFO | started process 23666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGcZ5pi/profile http://localhost:60381/getInfo.html) 16:16:51 INFO - PID 23666 | __metrics Screen width/height:1600/1200 16:16:51 INFO - PID 23666 | colorDepth:24 16:16:51 INFO - PID 23666 | Browser inner width/height: 1024/695 16:16:51 INFO - PID 23666 | __metrics 16:16:54 INFO - TEST-INFO | 23666: exit 0 16:16:54 INFO - Browser initialized. 16:16:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:16:54 INFO - TEST-INFO | started process 23837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGcZ5pi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:05 INFO - PID 23837 | RSS: Main: 155324416 16:17:05 INFO - PID 23837 | 16:20:11 INFO - PID 23837 | Cycle 1(1): loaded http://localhost:60381/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60381/tests/dromaeo/cssquery-ext.html) 16:20:13 INFO - PID 23837 | RSS: Main: 166490112 16:20:13 INFO - PID 23837 | 16:23:15 INFO - PID 23837 | Cycle 1(1): loaded http://localhost:60381/tests/dromaeo/cssquery-ext.html (next: http://localhost:60381/tests/dromaeo/cssquery-jquery.html) 16:23:16 INFO - PID 23837 | RSS: Main: 160440320 16:23:16 INFO - PID 23837 | 16:26:18 INFO - PID 23837 | Cycle 1(1): loaded http://localhost:60381/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60381/tests/dromaeo/cssquery-mootools.html) 16:26:19 INFO - PID 23837 | RSS: Main: 168542208 16:26:19 INFO - PID 23837 | 16:29:20 INFO - PID 23837 | Cycle 1(1): loaded http://localhost:60381/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60381/tests/dromaeo/cssquery-prototype.html) 16:29:21 INFO - PID 23837 | RSS: Main: 160169984 16:29:21 INFO - PID 23837 | 16:32:24 INFO - PID 23837 | Cycle 1(1): loaded http://localhost:60381/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60381/tests/dromaeo/cssquery-yui.html) 16:32:24 INFO - PID 23837 | RSS: Main: 165146624 16:32:24 INFO - PID 23837 | 16:35:26 INFO - PID 23837 | Cycle 1(1): loaded http://localhost:60381/tests/dromaeo/cssquery-yui.html (next: http://localhost:60381/tests/dromaeo/cssquery-dojo.html) 16:35:26 INFO - PID 23837 | RSS: Main: 169504768 16:35:26 INFO - PID 23837 | 16:35:26 INFO - PID 23837 | __start_tp_report 16:35:26 INFO - PID 23837 | _x_x_mozilla_page_load 16:35:26 INFO - PID 23837 | _x_x_mozilla_page_load_details 16:35:26 INFO - PID 23837 | |i|pagename|runs| 16:35:26 INFO - PID 23837 | |0;dojo.html;2733.5762956741705;2739.643846299981;2764.295104748289;2764.944701105978;2783.471140483309;5263.526282634562;5311.814086506978;5326.147816349385;5349.197620356948;5370.677759334438;5268.157094864822;5336.946630533694;5338.199270109476;5471.8084867029565;5477.698726570037;4386.429764130658;4672.929906051412;4748.6913350632185;4758.928616070744;4771.71369717818;4795.784189711454;4838.153323168449;4852.4662287148385;4853.757312134379;4879.170541008019;4613.5847773700525;4683.367745354401;4702.083093796711;4780.139574876521;4831.227003679394;4769.57073863354;4784.784684689197;4799.808007679689;4841.540053694894;4856.465788763233;4728.692634978715;4735.337052812609;4737.905241895177;4778.139934811733;4804.063207674505;5203.453637368059;5255.60582956276;5361.08861493547;5415.675059496403;5447.237386765856;5728.312602487728;5728.398518155575;5731.197632331477;5742.0238559445;5778.5377169826315;5763.884722305573;5764;5782.190493330895;5784.971075144639;5787;5303.337082864642;5339.145736682112;5371.248025276464;5373.059714549938;5381.48875856793;5879.764809407576;5902.144189092557;5918.348981612019;5921.437463440966;5935.940640593539;5600.271964644651;5647.152927060892;5669.036263835075;5672.773089076473;5683.976884160891;5808.94191058084;5825.533957283407;5848.181254624356;5852.590318677737;5907.8227653169615;5767.567432442584;5773.04744717117;5783.929972955017;5794.98587747151;5795.362510123883;5606.187102870061;5700.116481945305;5724.055530837365;5797.681127537941;5820.505257053113;4854.05345957542;4859.222524396079;4866.586340161126;4868.294097355934;4898.657094003457;4143.3784932260405;4172.395002724648;4195.160967806451;4199.517055538591;4248.4901811782165;4657.231556793159;4738.218193998021;4778.904421911542;4790.089882922303;4793.5685788279225;5641.041023026095;5652.434756524397;5653.971730141323;5656.462636049569;5658.179563963202;4651.116287905287;4652.697574657636;4653.441587009513;4656.837010704609;4664.183767840615;4887.0714564232685;4982.850514484571;5001.924971125436;5002.799888004512;5006.274090256965;5240.764165612481;5307.124324486416;5308.734563271743;5384.865378365415;5411.675299482044;5855.443732845373;5867.647941123546;5872.324682661549;5878.441548052928;5925.585209035498;5273.894522109613;5352.518273355417;5421.322334708161;5451.672899626035;5481.150421684645;5560.110382338807;5760.337561180518;5761.596688231783;5767.0196066669605;5774.653520788766;5776.42235776419;5787.7395517200985;5868.94131058684;5883.676397797991;5929.466348028525;5664.81434327393;5677.460641239076;5681.0910254359105;5708.771649133988;5709.34342550612;5646.689432081275;5650.463205995424;5680.062789639664;5681.801136960186;5682.119271512922;5460.26286451324;5509;5514;5515.862103447446;5530.391656917655;5619.325680918316;5620.437956204511;5626.634268772516;5630.352509461464;5634.23937768396;5446.482584154499;5489.945100548944;5492.148716948879;5494.505494505353;5503.257060296969 16:35:26 INFO - PID 23837 | |1;ext.html;724.7282269149069;748.042505592841;1026.7741096958666;1046.937183768974;1122.2256642916382;31773.841130794342;32136.517952230733;32225.194370140758;32227.194320142007;32293.354132917357;29758.702412975865;29933;29959.55060674086;30033.549496757565;30124.54813177804;6429.967850160766;6445.129907462503;6557.868842623145;7101.928980710179;7129.465290103237;7078;7113.573185608854;7136.357727804497;7177.2463891291445;7196.676149573282;7146.178189508195;7156.749513767019;7195.748148814792;7196.964015179917;7197.964010179941;7152.53508521947;7161.92838071623;7167.641617919109;7176.892346614753;7211.783646490614;7011.89482157768;7052.471064670171;7089.89365159523;7099.148102227766;7121.679524421414;31608.841955790303;32022.359552809045;32182.195445113826;32228;32419;2883.524218503944;2883.884644614213;2906.9709302906913;2907.8400687962153;2917.7082291770867;24008.27975160748;24009.759902401103;24112.276631701076;24117.517649647085;24302.756972430227;3108.7668424867998;3122.3755248950074;3133.4673105572106;3137.419577378192;3170.25499007733;144228;144470.27764861213;144494;144565;144723;37866;39544.209115817524;39872.21213984725;40150.397744033864;40248.79875600662;41759.164816703495;41788.58211417908;42210.57789422067;42252;42321.788391057846;12210.145289829805;12210.450529726184;12249.938750306192;12311.19977201479;12387.75224495523;9340.859887101698;9428.528573571293;9434.3867648604;9434.669786557437;9470.668526601536;12570.937145314216;12618.621441356774;12636.11547191706;12656.493740250471;12832.29422381778;5338.546223570962;5414.539764120094;5438.510534051954;5438.510534051954;5468.261784659099;865.1175800683394;895.4090300401834;898.4294972692387;911.8996910339857;928.7538802217417;20173.697394539093;21204.46988825261;21405.464863378227;21464.78535214628;21661.566768664852;960.1358777100666;969.7575606098476;973.8831340239217;981.0238812381726;991.4893829677721;10699.535171060026;11253.943730281297;11314.264572802742;11450.37022963745;11490.712732181762;168669;168766.15616921836;169278;170262;170497.14751426413;39691.60308396937;39892.40161397582;39959.60040399617;40001.59998400037;40074.398884016766;1172.1677608897608;1201.9158658893969;1219.4451524556305;1221.7067903703226;1229.33001514175;19834.404967850987;19910.50223744418;20374.592508149457;21035;21170.36488905335;29069.85465072661;29195.124146275644;29205.269868253465;29384.853075734485;29391.41217175602;140748.29625851806;142291.28854356077;143342.28328858706;144853;145565;30783.84608077035;31259.53110703387;31355;31450.528242076845;31622.466068438393;36804.447933280484;37493.250134997696;38061.619383806916;38150.427743583314;38428;29167.270818229714;29180.416391672472;29425;29775.404491910474;30349.241268968453;28667;28837.56743648805;29399.70600294055;29801.40397192001;29896.701032989393;31439.528407073456;31477;31673.5248971261;31687.366252675278;32024.6797532031;26783;26935.595966060133;27475.725242747318;27511.58732619052;28543.571846422736;21646.350609481742;22689.432764181027;22710;22737.204197852996;22775.544489110456 16:35:26 INFO - PID 23837 | |2;jquery.html;406.86980166346774;411.2474172264754;412.67604930129846;412.67736903225165;436.18433529300194;14207.857921420782;14484.637884052903;17014.06422646754;17697.256925176585;17735.911320443396;18719.438416847483;18836.246550137977;18908.338208162717;18955.33656322029;19195.808041919576;5240.475952404748;5322.787088516455;5500.532454741332;5595.804146854861;5637;5431.429699881515;5534.169874518814;5535.861603459905;5536.114221724525;5552.139418390156;5055.443901170886;5523.226748255248;5557.944420555803;5565.053940830068;5569.359523654771;5254.369475662907;5513.145462453326;5515.944840551583;5524.088525393346;5527.806526771564;4948.653594248404;4983.576396006344;4986.950130498685;4989.376327959005;4993.525615066599;21470.35588932319;21867.890660546753;21926.342209733735;22105.226317078985;22253.22113726012;1621.8459246371576;1654.1894471708897;1669.090345761563;1670.8245634208354;1673.029642807169;13642.93178534101;13670;14004.089734167348;14754.336054877556;14963.70072598542;1992.2927360787003;2017.9192832286692;2047.7747447780732;2048;2149.344449942767;84972.39113720573;88087.55956220177;90972;92590;95586.9999999993;10979.17656175774;11156.944215279034;11226.7193320166;11252.15608829341;11390.886091139148;15897.443589474544;15897.920510397606;15900.204989750466;15913.363465461483;15957.840421595636;7451.552906825608;7625.6568454419685;7788.727394541163;7848.607569621496;7880.684772609032;6913.1358580177475;6933.861322773516;6970;7152.856942861114;7190.06529151207;6984.476164287698;7001.754938577125;7053.329933656294;7076.186238582526;7206.901032555947;2023.8380929525604;2050.805173508514;2073.1603700501323;2082.552251265985;2166.501704607949;832.1678321678322;860.617025423693;870.7953630896734;881.9426737262057;892.0811564088999;16896.746548801777;16970.830291697173;17214.397496087826;17247;17930.731039034425;870.0864092702637;873.8820259265045;876.7676565710092;882.5322579033123;905.103947092387;9123.452592844451;9359.812803743887;9690.854637180448;9727.65953191635;9833.704988850346;356748;361072;362054;377521;384877;73457.6327118361;75279.62360188164;76072.23927760762;76473.61763191149;77884.61057694789;1080.827067669169;1083.1767856429012;1121.9439028048564;1124.8818874018275;1127.9605213817476;17777.733333999742;18011.279548818424;18828.905855470635;18868.622627547098;19074.141663624894;36816.26367472689;37500.2499949994;37689.81155094207;38104.80947595244;39658.20683586255;48671.75664121657;50150.74924625354;50444;50539.74730126326;50539.74730126326;8010.919890801018;8085.43401961857;8168.714095006646;8292.502449852787;8312.16878312188;12066.396680166132;12265.632031039084;12282.877171228174;12403.131780775258;12526.37368131608;9130.95434522823;10489.47552622381;10739.355638661706;10895.400752958663;11374;10344.482775861328;10455;10606.893931060591;10608.416537090225;10747.247692661438;10360.792784144425;11032.558697652004;11105.722356941142;11212.719682008015;11267.718307042389;8006.879896801669;8173.632186551738;8204.097549269456;8208.425410221227;8216.548089855116;10409.635662751767;10665.520051597541;10919.617813376493;11026.173037022096;11256.212065155689 16:35:26 INFO - PID 23837 | |3;mootools.html;1242.2546472116728;1308.72516771478;1330.720548684776;1332.7201287729577;1350.790627452745;9542.379745316559;9961.4521201334;9983.900160998388;10043.949780251107;10242.28304018719;10024.198064154869;10143.13783328418;10172.135368493688;10204.846927296096;10217.795644087133;2270.1146552844402;2287.6911616931666;2302.3323236261463;2307.630779075348;2310.156792770635;2157.8381621378458;2211.181862710799;2211.3476524425255;2226.9109235630553;2232.799048085672;2211.557688462306;2221.3780141560387;2265.150568536799;2274.283600665793;2277.7152855893014;2148.0977989244557;2169.642009068502;2205.0628482894786;2228.732552093743;2230.910763569447;2054.281001649426;2168.2194410012385;2171.0664414301846;2183.8034576888;2193.5283913958574;10193.08262256393;10200.897991020143;10244.846327305097;10273.332233404804;10302.742431439274;5545.72271386429;5720.971395143039;5724.8855022899725;5726.31284245889;5746.339170995348;3269.8853632771215;3372.1738174147245;3377.257003459235;3414.231797845465;3451.188970591909;1070.0904231403322;1087.255230167338;1097.13874608432;1123.825806999908;1139.6467095200433;14755.483558075415;14911.179885106314;14952.102873827605;14957.177355245458;15004.924975375163;4425.889352766207;4542.454905411306;4760.833595769059;4800.66395352322;4820.156472617348;10485;10648.254622176528;10675.519601617945;10683.09193718527;10703.946480267548;5533.944660553343;5542.3626282977975;5558.972205138948;5577.749001294951;5582.051051321285;4943.134951383494;5117.283580298761;5166.070107380632;5194.870128246824;5252.894942101213;3625.2024554597947;3701;3765.9246815063543;3766.8681596144;3802.125511132455;1049.905508504223;1051.6056478820442;1067.4289255248405;1072.0780129088978;1078.5308390850005;692.2074225012333;713.9000539924415;721.945854060937;736.1571001203592;736.6611358774917;5304.840854774363;5412.296401467863;5423.349198096174;5559.19391688211;5569.21785028795;529.3066083430718;547;547.2284079448038;550.3670778604637;551.0191858491891;3302.339532093591;3371.780834245766;3377.560917080764;3458.9796010177056;3742.607026262258;12495.437705303284;12741.745165096647;12843.935780321226;13085.934570327277;13675;12341.197822141532;12550.937245313715;12564.183328083645;12838.422270997828;12842.614721558368;7314.012608297811;7368.4842061055215;7397.223291554309;7403.370713489306;7406.814829629302;5614.494695477427;5677.716114194356;5719.628224165416;5818.883622327445;5930.881382372242;11397.373144477133;11419.885801141882;11558.42207889619;11634.301941883514;11707.473163707824;11659.242149260272;11659.242149260272;11665.825012624648;11907.940460297643;12059.698507537381;7111.288871112847;7160;7174.3184397482155;7206.747763828241;7206.89189662166;8920.643174272956;8996.05541418168;9032.729018129467;9289.442633442015;9384.436933783994;8042.914206582037;8100.797480063045;8100.959495202486;8139.83720325602;8297.419180657296;7817.452778305464;7893.684252629831;7913.208679132041;7969.681212751425;8051.436399451982;7053.541519801196;7181.856362872818;7251.601161936144;7287;7421.0723659542555;4496.37050812893;5277.630565860506;5290.629655924048;5343.5457986071615;5361.115415956324;5204.921926171035;5222.086134926449;5311.72518595542;5338.439463856239;5384.380796208487 16:35:26 INFO - PID 23837 | |4;prototype.html;393.8042782817436;394.1073468593636;396.4172666180717;399.57644896409806;404.54084613963164;5546.86132846679;5682.119271512922;5686.488216060548;5687.289088863892;5701.828945131642;5367.543758780498;5424;5431.592630552715;5508.724563771815;5539.473749993755;4299.8065087071;4315.654747620183;4318.654507639381;4330.090680957002;4331.155424692186;4321.265384884561;4326.242907491176;4338.045629961403;4339.609435150835;4347.956520434803;3967.4643923070303;4115.251018317218;4142.834286628531;4294.720843145185;4305.22505948929;4109.28087584673;4115.773632450214;4125.092479654471;4125.216208920296;4125.8968525786795;3590.281943611288;3591.5510561179854;3597.94603080954;3624.89125326238;3626.057225121461;5332.626716129873;5423.2407462954825;5423.403425623178;5425.3489581250105;5438.8912221755345;4886.633502487328;4900.068986892479;4908;4913.950860491385;4937.23472861707;5833.445822646841;5860.179574859523;5868.501177399883;5877.031194549831;5895.73469193883;3992.8802135935966;4057.6145266199665;4076.6942479313875;4079.5120172252596;4081.0409553754844;6011.789587364465;6227.501799856001;6235.282942461584;6268.561200715952;6305.96847015762;4121.258173528794;4152.356384760367;4165.396017577435;4167;4168.270552653274;4207.0113523322;4213.157368526307;4218.430511880918;4223.986243301585;4230.555791641833;4764.833230836974;4834.20235661119;4888.26675998596;4892.633052521004;4900.313956046157;5858.506080949331;5863.882722345529;5869.413058694096;5895.852603684943;5901.616394934315;1443.1773888883235;1449.0581122270398;1450.811394518727;1452.9709405812036;1453.6583902782838;897.7800438892513;951.3768481644533;960.2653969713175;964.1563631822156;967.0377973915859;4871.853844384674;4897.240927656219;4900.926486102711;4906.31311616374;4928.778204980785;6038.071535305374;6081.75672973085;6091.177691011657;6101.572889897665;6114.724837382329;4772.856814295576;4873.829415970424;4900.436449808247;4925.38432695913;4943;3207.775455718124;3215.758818088653;3224.2423030587793;3237.190702324419;3240.5787247657654;5542.667439953535;5613.943860561342;5627;5644.32268127819;5657.858553536194;6212.844678882973;6231.781887633911;6237.126802247689;6291.370862913672;6327.209098862642;5616.584868506581;5624.746886390122;5635.182898479616;5687.51656109227;5689.288838895138;5907.350191478848;6022.488088512526;6087.208662873798;6088.573799833969;6104.633721976696;5974.522038236843;6003.549733770072;6008.519318454601;6031.7587296507645;6049.727762250797;5526.834194974157;5639.125935480007;5664.376918538875;5719.113537401709;5719.714014299185;4150.91698166041;4161.167766446662;4161.8959526012095;4164.37534369847;4186.309258972357;5963.940360596339;6022.819315420545;6113.358097399709;6144.139820425234;6150.630962142286;5898.439648233411;5919.200907877382;5932.436418540232;5932.508346494396;5945.346011938596;5859.384764599826;5875.471207591167;5921.4966727826895;5934.97032514852;5944.227250457586;5689.687067211343;5791;5809.883802323845;5828.358880523224;5858;5916.645001299936;5942.376050514634;5951.137085122719;5956.255468066492;5975.820725378246;5704.657720536781;5765.135229715576;5779.884402312015;5781.913271300849;5798.449147330997 16:35:26 INFO - PID 23837 | |5;yui.html;693.0609024771431;696.1472196559215;710.1300906389677;710.2542330552919;719.5071376107367;12304;12837.550685726;13636;14337.283135843205;14389;13528.458861645522;14510.782338264908;14528.927355363236;14605.707885842277;14623.268836558183;873.8645509945952;891.2602539891874;893.0712059458156;893.3791015244408;897.5601955042048;903.9954800225989;905.5879574793486;911.3483859040784;912.3886995712888;914.095045904553;945.9668911588096;950.1496160935958;954.4082668745388;955.1022039283051;955.3980991975046;933.1881263300971;944.117250370902;945.1115951006033;945.5036106044313;947.1617618407759;696.5611664651288;699.8390370214879;701.0990876723437;701.3232230897208;701.7789396340137;13811.930940345335;13865.37605807741;14067.366968486444;14620.488282910153;14647.04794188385;15111.773323400157;15304.923475382664;15428.074315541104;15834.76247856283;15928.283227254802;11714.180007399485;11845;12011.279323240546;12084.093692973061;12117.636470905887;2963.7184467475554;2967.5697023931625;2970.643522777259;2990.745786608119;2994.4609970205356;69511;69962;70004.29995700029;70168.99999999949;71313.28686713119;12584.685382865318;12608.558700445441;12670.619881403572;12712.491500339884;12766.553170638983;22391.328260152222;22473.775262247495;22490.437739056328;22535;22714.205002824823;5936.940630593639;6063.211782468339;6174.197354343996;6224.844378890564;6241.407066328691;3095.6440009398757;3139.5133754267667;3154.921126971844;3169.8415079245947;3174.761892858045;3442.277121804449;3528.364894318996;3534.8232588370993;3570.0539357070397;3586.677199052098;744.0736283327292;745.3627148787817;754.2344520311888;754.6377738685462;756.6897571995455;600.1687662587348;629.7638385605399;631.8136149835809;637.6429199648212;649.5972497051858;9451.243900487945;9906.05892440217;10080.29437939352;10104.29269951111;10194.388336699822;610.4444955090846;620.9565330426826;621.7854840080165;625.7152995387088;634.9428551430393;4457.598816106566;4574.6340292776495;4585.060062687141;4588.285524212344;4591.334256532784;64328.67835660792;64665.35334646687;64703.352966469734;65409;67156.6642166786;57456.42543574594;58156.41843581595;59599;60146.69926650339;60906;52620.73689631604;52838.99999999923;53353.46646533485;53585;54995.72502137544;9519.904800951901;9613.615455381987;9681.854772178564;9684.176844968257;9955.054269844353;27915.720842791314;28002.159935201977;28146.85926570436;28169.859150704116;28267.43465130645;34213.144671383416;34437.65562344345;34446.311073777884;34934.475982860786;35095;12426.192297500633;12633.431495582905;12656.746865062463;12677.8098328527;12780.233186008498;15538.456154034555;16063.518094457186;16298.42955496552;16390.67218655644;16400.17999100064;13798.103123296954;14481;14826.77759833625;15440.536783896501;15600.375984960474;14241.501547446203;14298.928505357406;14420.278986050866;15666.686666266838;16000.839991599934;14045.227512486912;14607.92696036513;15143.924280378527;15457.922710386376;15926.4425745103;10421.739456513344;10963.068139207937;11202.66392008241;11273.210875238654;11504.36725980079;11959.76080478403;12462.688432789253;12499.312537810507;12501.74996500083;12559.99520038413 16:35:26 INFO - PID 23837 | __end_tp_report 16:35:26 INFO - PID 23837 | __start_cc_report 16:35:26 INFO - PID 23837 | _x_x_mozilla_cycle_collect,358 16:35:26 INFO - PID 23837 | __end_cc_report 16:35:26 INFO - PID 23837 | __startTimestamp1494372926934__endTimestamp 16:35:26 INFO - PID 23837 | 16:35:26 INFO - PID 23837 | ------- Summary: start ------- 16:35:26 INFO - PID 23837 | Number of tests: 6 16:35:26 INFO - PID 23837 | 16:35:26 INFO - PID 23837 | [#0] dojo.html Cycles:165 Average:5262.07 Median:5451.67 stddev:636.47 (11.7%) stddev-sans-first:606.73 16:35:26 INFO - PID 23837 | Values: 2733.6 2739.6 2764.3 2764.9 2783.5 5263.5 5311.8 5326.1 5349.2 5370.7 5268.2 5336.9 5338.2 5471.8 5477.7 4386.4 4672.9 4748.7 4758.9 4771.7 4795.8 4838.2 4852.5 4853.8 4879.2 4613.6 4683.4 4702.1 4780.1 4831.2 4769.6 4784.8 4799.8 4841.5 4856.5 4728.7 4735.3 4737.9 4778.1 4804.1 5203.5 5255.6 5361.1 5415.7 5447.2 5728.3 5728.4 5731.2 5742.0 5778.5 5763.9 5764.0 5782.2 5785.0 5787.0 5303.3 5339.1 5371.2 5373.1 5381.5 5879.8 5902.1 5918.3 5921.4 5935.9 5600.3 5647.2 5669.0 5672.8 5684.0 5808.9 5825.5 5848.2 5852.6 5907.8 5767.6 5773.0 5783.9 5795.0 5795.4 5606.2 5700.1 5724.1 5797.7 5820.5 4854.1 4859.2 4866.6 4868.3 4898.7 4143.4 4172.4 4195.2 4199.5 4248.5 4657.2 4738.2 4778.9 4790.1 4793.6 5641.0 5652.4 5654.0 5656.5 5658.2 4651.1 4652.7 4653.4 4656.8 4664.2 4887.1 4982.9 5001.9 5002.8 5006.3 5240.8 5307.1 5308.7 5384.9 5411.7 5855.4 5867.6 5872.3 5878.4 5925.6 5273.9 5352.5 5421.3 5451.7 5481.2 5560.1 5760.3 5761.6 5767.0 5774.7 5776.4 5787.7 5868.9 5883.7 5929.5 5664.8 5677.5 5681.1 5708.8 5709.3 5646.7 5650.5 5680.1 5681.8 5682.1 5460.3 5509.0 5514.0 5515.9 5530.4 5619.3 5620.4 5626.6 5630.4 5634.2 5446.5 5489.9 5492.1 5494.5 5503.3 16:35:26 INFO - PID 23837 | 16:35:26 INFO - PID 23837 | [#1] ext.html Cycles:180 Average:29834.61 Median:17190.95 stddev:39389.69 (229.1%) stddev-sans-first:39439.54 16:35:26 INFO - PID 23837 | Values: 724.7 748.0 1026.8 1046.9 1122.2 31773.8 32136.5 32225.2 32227.2 32293.4 29758.7 29933.0 29959.6 30033.5 30124.5 6430.0 6445.1 6557.9 7101.9 7129.5 7078.0 7113.6 7136.4 7177.2 7196.7 7146.2 7156.7 7195.7 7197.0 7198.0 7152.5 7161.9 7167.6 7176.9 7211.8 7011.9 7052.5 7089.9 7099.1 7121.7 31608.8 32022.4 32182.2 32228.0 32419.0 2883.5 2883.9 2907.0 2907.8 2917.7 24008.3 24009.8 24112.3 24117.5 24302.8 3108.8 3122.4 3133.5 3137.4 3170.3 144228.0 144470.3 144494.0 144565.0 144723.0 37866.0 39544.2 39872.2 40150.4 40248.8 41759.2 41788.6 42210.6 42252.0 42321.8 12210.1 12210.5 12249.9 12311.2 12387.8 9340.9 9428.5 9434.4 9434.7 9470.7 12570.9 12618.6 12636.1 12656.5 12832.3 5338.5 5414.5 5438.5 5438.5 5468.3 865.1 895.4 898.4 911.9 928.8 20173.7 21204.5 21405.5 21464.8 21661.6 960.1 969.8 973.9 981.0 991.5 10699.5 11253.9 11314.3 11450.4 11490.7 168669.0 168766.2 169278.0 170262.0 170497.1 39691.6 39892.4 39959.6 40001.6 40074.4 1172.2 1201.9 1219.4 1221.7 1229.3 19834.4 19910.5 20374.6 21035.0 21170.4 29069.9 29195.1 29205.3 29384.9 29391.4 140748.3 142291.3 143342.3 144853.0 145565.0 30783.8 31259.5 31355.0 31450.5 31622.5 36804.4 37493.3 38061.6 38150.4 38428.0 29167.3 29180.4 29425.0 29775.4 30349.2 28667.0 28837.6 29399.7 29801.4 29896.7 31439.5 31477.0 31673.5 31687.4 32024.7 26783.0 26935.6 27475.7 27511.6 28543.6 21646.4 22689.4 22710.0 22737.2 22775.5 16:35:26 INFO - PID 23837 | 16:35:26 INFO - PID 23837 | [#2] jquery.html Cycles:180 Average:24883.09 Median:207812.90 stddev:61399.49 (29.5%) stddev-sans-first:61544.23 16:35:26 INFO - PID 23837 | Values: 406.9 411.2 412.7 412.7 436.2 14207.9 14484.6 17014.1 17697.3 17735.9 18719.4 18836.2 18908.3 18955.3 19195.8 5240.5 5322.8 5500.5 5595.8 5637.0 5431.4 5534.2 5535.9 5536.1 5552.1 5055.4 5523.2 5557.9 5565.1 5569.4 5254.4 5513.1 5515.9 5524.1 5527.8 4948.7 4983.6 4987.0 4989.4 4993.5 21470.4 21867.9 21926.3 22105.2 22253.2 1621.8 1654.2 1669.1 1670.8 1673.0 13642.9 13670.0 14004.1 14754.3 14963.7 1992.3 2017.9 2047.8 2048.0 2149.3 84972.4 88087.6 90972.0 92590.0 95587.0 10979.2 11156.9 11226.7 11252.2 11390.9 15897.4 15897.9 15900.2 15913.4 15957.8 7451.6 7625.7 7788.7 7848.6 7880.7 6913.1 6933.9 6970.0 7152.9 7190.1 6984.5 7001.8 7053.3 7076.2 7206.9 2023.8 2050.8 2073.2 2082.6 2166.5 832.2 860.6 870.8 881.9 892.1 16896.7 16970.8 17214.4 17247.0 17930.7 870.1 873.9 876.8 882.5 905.1 9123.5 9359.8 9690.9 9727.7 9833.7 356748.0 361072.0 362054.0 377521.0 384877.0 73457.6 75279.6 76072.2 76473.6 77884.6 1080.8 1083.2 1121.9 1124.9 1128.0 17777.7 18011.3 18828.9 18868.6 19074.1 36816.3 37500.2 37689.8 38104.8 39658.2 48671.8 50150.7 50444.0 50539.7 50539.7 8010.9 8085.4 8168.7 8292.5 8312.2 12066.4 12265.6 12282.9 12403.1 12526.4 9131.0 10489.5 10739.4 10895.4 11374.0 10344.5 10455.0 10606.9 10608.4 10747.2 10360.8 11032.6 11105.7 11212.7 11267.7 8006.9 8173.6 8204.1 8208.4 8216.5 10409.6 10665.5 10919.6 11026.2 11256.2 16:35:26 INFO - PID 23837 | 16:35:26 INFO - PID 23837 | [#3] mootools.html Cycles:180 Average:6137.03 Median:3542.09 stddev:3932.69 (111.0%) stddev-sans-first:3926.53 16:35:26 INFO - PID 23837 | Values: 1242.3 1308.7 1330.7 1332.7 1350.8 9542.4 9961.5 9983.9 10043.9 10242.3 10024.2 10143.1 10172.1 10204.8 10217.8 2270.1 2287.7 2302.3 2307.6 2310.2 2157.8 2211.2 2211.3 2226.9 2232.8 2211.6 2221.4 2265.2 2274.3 2277.7 2148.1 2169.6 2205.1 2228.7 2230.9 2054.3 2168.2 2171.1 2183.8 2193.5 10193.1 10200.9 10244.8 10273.3 10302.7 5545.7 5721.0 5724.9 5726.3 5746.3 3269.9 3372.2 3377.3 3414.2 3451.2 1070.1 1087.3 1097.1 1123.8 1139.6 14755.5 14911.2 14952.1 14957.2 15004.9 4425.9 4542.5 4760.8 4800.7 4820.2 10485.0 10648.3 10675.5 10683.1 10703.9 5533.9 5542.4 5559.0 5577.7 5582.1 4943.1 5117.3 5166.1 5194.9 5252.9 3625.2 3701.0 3765.9 3766.9 3802.1 1049.9 1051.6 1067.4 1072.1 1078.5 692.2 713.9 721.9 736.2 736.7 5304.8 5412.3 5423.3 5559.2 5569.2 529.3 547.0 547.2 550.4 551.0 3302.3 3371.8 3377.6 3459.0 3742.6 12495.4 12741.7 12843.9 13085.9 13675.0 12341.2 12550.9 12564.2 12838.4 12842.6 7314.0 7368.5 7397.2 7403.4 7406.8 5614.5 5677.7 5719.6 5818.9 5930.9 11397.4 11419.9 11558.4 11634.3 11707.5 11659.2 11659.2 11665.8 11907.9 12059.7 7111.3 7160.0 7174.3 7206.7 7206.9 8920.6 8996.1 9032.7 9289.4 9384.4 8042.9 8100.8 8101.0 8139.8 8297.4 7817.5 7893.7 7913.2 7969.7 8051.4 7053.5 7181.9 7251.6 7287.0 7421.1 4496.4 5277.6 5290.6 5343.5 5361.1 5204.9 5222.1 5311.7 5338.4 5384.4 16:35:26 INFO - PID 23837 | 16:35:26 INFO - PID 23837 | [#4] prototype.html Cycles:180 Average:4831.51 Median:5541.07 stddev:1443.11 (26.0%) stddev-sans-first:1408.20 16:35:26 INFO - PID 23837 | Values: 393.8 394.1 396.4 399.6 404.5 5546.9 5682.1 5686.5 5687.3 5701.8 5367.5 5424.0 5431.6 5508.7 5539.5 4299.8 4315.7 4318.7 4330.1 4331.2 4321.3 4326.2 4338.0 4339.6 4348.0 3967.5 4115.3 4142.8 4294.7 4305.2 4109.3 4115.8 4125.1 4125.2 4125.9 3590.3 3591.6 3597.9 3624.9 3626.1 5332.6 5423.2 5423.4 5425.3 5438.9 4886.6 4900.1 4908.0 4914.0 4937.2 5833.4 5860.2 5868.5 5877.0 5895.7 3992.9 4057.6 4076.7 4079.5 4081.0 6011.8 6227.5 6235.3 6268.6 6306.0 4121.3 4152.4 4165.4 4167.0 4168.3 4207.0 4213.2 4218.4 4224.0 4230.6 4764.8 4834.2 4888.3 4892.6 4900.3 5858.5 5863.9 5869.4 5895.9 5901.6 1443.2 1449.1 1450.8 1453.0 1453.7 897.8 951.4 960.3 964.2 967.0 4871.9 4897.2 4900.9 4906.3 4928.8 6038.1 6081.8 6091.2 6101.6 6114.7 4772.9 4873.8 4900.4 4925.4 4943.0 3207.8 3215.8 3224.2 3237.2 3240.6 5542.7 5613.9 5627.0 5644.3 5657.9 6212.8 6231.8 6237.1 6291.4 6327.2 5616.6 5624.7 5635.2 5687.5 5689.3 5907.4 6022.5 6087.2 6088.6 6104.6 5974.5 6003.5 6008.5 6031.8 6049.7 5526.8 5639.1 5664.4 5719.1 5719.7 4150.9 4161.2 4161.9 4164.4 4186.3 5963.9 6022.8 6113.4 6144.1 6150.6 5898.4 5919.2 5932.4 5932.5 5945.3 5859.4 5875.5 5921.5 5935.0 5944.2 5689.7 5791.0 5809.9 5828.4 5858.0 5916.6 5942.4 5951.1 5956.3 5975.8 5704.7 5765.1 5779.9 5781.9 5798.4 16:35:26 INFO - PID 23837 | 16:35:26 INFO - PID 23837 | [#5] yui.html Cycles:180 Average:15548.63 Median:34441.98 stddev:18416.89 (53.5%) stddev-sans-first:18434.76 16:35:26 INFO - PID 23837 | Values: 693.1 696.1 710.1 710.3 719.5 12304.0 12837.6 13636.0 14337.3 14389.0 13528.5 14510.8 14528.9 14605.7 14623.3 873.9 891.3 893.1 893.4 897.6 904.0 905.6 911.3 912.4 914.1 946.0 950.1 954.4 955.1 955.4 933.2 944.1 945.1 945.5 947.2 696.6 699.8 701.1 701.3 701.8 13811.9 13865.4 14067.4 14620.5 14647.0 15111.8 15304.9 15428.1 15834.8 15928.3 11714.2 11845.0 12011.3 12084.1 12117.6 2963.7 2967.6 2970.6 2990.7 2994.5 69511.0 69962.0 70004.3 70169.0 71313.3 12584.7 12608.6 12670.6 12712.5 12766.6 22391.3 22473.8 22490.4 22535.0 22714.2 5936.9 6063.2 6174.2 6224.8 6241.4 3095.6 3139.5 3154.9 3169.8 3174.8 3442.3 3528.4 3534.8 3570.1 3586.7 744.1 745.4 754.2 754.6 756.7 600.2 629.8 631.8 637.6 649.6 9451.2 9906.1 10080.3 10104.3 10194.4 610.4 621.0 621.8 625.7 634.9 4457.6 4574.6 4585.1 4588.3 4591.3 64328.7 64665.4 64703.4 65409.0 67156.7 57456.4 58156.4 59599.0 60146.7 60906.0 52620.7 52839.0 53353.5 53585.0 54995.7 9519.9 9613.6 9681.9 9684.2 9955.1 27915.7 28002.2 28146.9 28169.9 28267.4 34213.1 34437.7 34446.3 34934.5 35095.0 12426.2 12633.4 12656.7 12677.8 12780.2 15538.5 16063.5 16298.4 16390.7 16400.2 13798.1 14481.0 14826.8 15440.5 15600.4 14241.5 14298.9 14420.3 15666.7 16000.8 14045.2 14607.9 15143.9 15457.9 15926.4 10421.7 10963.1 11202.7 11273.2 11504.4 11959.8 12462.7 12499.3 12501.7 12560.0 16:35:26 INFO - PID 23837 | -------- Summary: end -------- 16:35:26 INFO - PID 23837 | 16:35:27 INFO - TEST-INFO | 23837: exit 0 16:35:27 INFO - TEST-OK | dromaeo_css | took 1120018ms 16:35:27 INFO - TEST-START | kraken 16:35:27 INFO - operating with platform_type : linux_ 16:35:27 INFO - Initialising browser for kraken test... 16:35:27 INFO - TEST-INFO | started process 24260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNPzWYZ/profile http://localhost:60381/getInfo.html) 16:35:31 INFO - PID 24260 | __metrics Screen width/height:1600/1200 16:35:31 INFO - PID 24260 | colorDepth:24 16:35:31 INFO - PID 24260 | Browser inner width/height: 1024/695 16:35:31 INFO - PID 24260 | __metrics 16:35:33 INFO - TEST-INFO | 24260: exit 0 16:35:33 INFO - Browser initialized. 16:35:33 INFO - Running cycle 1/1 for kraken test... 16:35:33 INFO - TEST-INFO | started process 24433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNPzWYZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:45 INFO - PID 24433 | RSS: Main: 154873856 16:35:45 INFO - PID 24433 | 16:35:48 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60381/tests/kraken/driver.html?testName=audio-beat-detection) 16:35:49 INFO - PID 24433 | RSS: Main: 161267712 16:35:49 INFO - PID 24433 | 16:35:52 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60381/tests/kraken/driver.html?testName=audio-dft) 16:35:52 INFO - PID 24433 | RSS: Main: 160055296 16:35:52 INFO - PID 24433 | 16:35:55 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60381/tests/kraken/driver.html?testName=audio-fft) 16:35:56 INFO - PID 24433 | RSS: Main: 156631040 16:35:56 INFO - PID 24433 | 16:35:58 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60381/tests/kraken/driver.html?testName=audio-oscillator) 16:35:58 INFO - PID 24433 | RSS: Main: 157323264 16:35:58 INFO - PID 24433 | 16:36:01 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60381/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:01 INFO - PID 24433 | RSS: Main: 157298688 16:36:01 INFO - PID 24433 | 16:36:04 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60381/tests/kraken/driver.html?testName=imaging-darkroom) 16:36:05 INFO - PID 24433 | RSS: Main: 163168256 16:36:05 INFO - PID 24433 | 16:36:09 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60381/tests/kraken/driver.html?testName=imaging-desaturate) 16:36:09 INFO - PID 24433 | RSS: Main: 161099776 16:36:09 INFO - PID 24433 | 16:36:12 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60381/tests/kraken/driver.html?testName=json-parse-financial) 16:36:13 INFO - PID 24433 | RSS: Main: 161624064 16:36:13 INFO - PID 24433 | 16:36:14 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60381/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:36:15 INFO - PID 24433 | RSS: Main: 162304000 16:36:15 INFO - PID 24433 | 16:36:17 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60381/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:36:17 INFO - PID 24433 | RSS: Main: 162078720 16:36:17 INFO - PID 24433 | 16:36:20 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60381/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:36:20 INFO - PID 24433 | RSS: Main: 162136064 16:36:20 INFO - PID 24433 | 16:36:23 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:36:24 INFO - PID 24433 | RSS: Main: 162578432 16:36:24 INFO - PID 24433 | 16:36:27 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:27 INFO - PID 24433 | RSS: Main: 162426880 16:36:27 INFO - PID 24433 | 16:36:29 INFO - PID 24433 | Cycle 1(1): loaded http://localhost:60381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60381/tests/kraken/driver.html?testName=ai-astar) 16:36:30 INFO - PID 24433 | RSS: Main: 164233216 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | __start_tp_report 16:36:30 INFO - PID 24433 | _x_x_mozilla_page_load 16:36:30 INFO - PID 24433 | _x_x_mozilla_page_load_details 16:36:30 INFO - PID 24433 | |i|pagename|runs| 16:36:30 INFO - PID 24433 | |0;ai-astar;104;113;114;113;113;113;112;114;111;113 16:36:30 INFO - PID 24433 | |1;audio-beat-detection;147;123;124;169;123;125;125;124;145;124 16:36:30 INFO - PID 24433 | |2;audio-dft;164;163;162;165;168;167;168;165;162;162 16:36:30 INFO - PID 24433 | |3;audio-fft;74;75;75;103;76;76;74;75;96;78 16:36:30 INFO - PID 24433 | |4;audio-oscillator;84;85;106;85;84;83;98;83;83;101 16:36:30 INFO - PID 24433 | |5;imaging-gaussian-blur;114;116;114;115;113;114;114;114;117;114 16:36:30 INFO - PID 24433 | |6;imaging-darkroom;149;152;150;152;150;152;150;150;151;149 16:36:30 INFO - PID 24433 | |7;imaging-desaturate;94;95;94;94;96;95;96;95;94;95 16:36:30 INFO - PID 24433 | |8;json-parse-financial;55;55;55;55;57;55;55;55;56;56 16:36:30 INFO - PID 24433 | |9;json-stringify-tinderbox;55;56;55;55;55;55;56;56;56;56 16:36:30 INFO - PID 24433 | |10;stanford-crypto-aes;82;84;89;95;82;83;85;85;82;83 16:36:30 INFO - PID 24433 | |11;stanford-crypto-ccm;131;135;130;132;131;139;145;135;219;138 16:36:30 INFO - PID 24433 | |12;stanford-crypto-pbkdf2;178;199;190;204;193;190;191;186;196;178 16:36:30 INFO - PID 24433 | |13;stanford-crypto-sha256-iterative;72;75;74;72;73;70;73;74;71;70 16:36:30 INFO - PID 24433 | __end_tp_report 16:36:30 INFO - PID 24433 | __start_cc_report 16:36:30 INFO - PID 24433 | _x_x_mozilla_cycle_collect,845 16:36:30 INFO - PID 24433 | __end_cc_report 16:36:30 INFO - PID 24433 | __startTimestamp1494372990025__endTimestamp 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | ------- Summary: start ------- 16:36:30 INFO - PID 24433 | Number of tests: 14 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 16:36:30 INFO - PID 24433 | Values: 104.0 113.0 114.0 113.0 113.0 113.0 112.0 114.0 111.0 113.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:125.00 stddev:15.66 (12.5%) stddev-sans-first:15.76 16:36:30 INFO - PID 24433 | Values: 147.0 123.0 124.0 169.0 123.0 125.0 125.0 124.0 145.0 124.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:2.41 (1.5%) stddev-sans-first:2.55 16:36:30 INFO - PID 24433 | Values: 164.0 163.0 162.0 165.0 168.0 167.0 168.0 165.0 162.0 162.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.50 stddev:10.37 (13.7%) stddev-sans-first:10.75 16:36:30 INFO - PID 24433 | Values: 74.0 75.0 75.0 103.0 76.0 76.0 74.0 75.0 96.0 78.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:84.00 stddev:8.84 (10.5%) stddev-sans-first:9.18 16:36:30 INFO - PID 24433 | Values: 84.0 85.0 106.0 85.0 84.0 83.0 98.0 83.0 83.0 101.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.18 (1.0%) stddev-sans-first:1.24 16:36:30 INFO - PID 24433 | Values: 114.0 116.0 114.0 115.0 113.0 114.0 114.0 114.0 117.0 114.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:1.18 (0.8%) stddev-sans-first:1.12 16:36:30 INFO - PID 24433 | Values: 149.0 152.0 150.0 152.0 150.0 152.0 150.0 150.0 151.0 149.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 16:36:30 INFO - PID 24433 | Values: 94.0 95.0 94.0 94.0 96.0 95.0 96.0 95.0 94.0 95.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 16:36:30 INFO - PID 24433 | Values: 55.0 55.0 55.0 55.0 57.0 55.0 55.0 55.0 56.0 56.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 16:36:30 INFO - PID 24433 | Values: 55.0 56.0 55.0 55.0 55.0 55.0 56.0 56.0 56.0 56.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:4.11 (4.9%) stddev-sans-first:4.21 16:36:30 INFO - PID 24433 | Values: 82.0 84.0 89.0 95.0 82.0 83.0 85.0 85.0 82.0 83.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:136.50 stddev:26.92 (19.7%) stddev-sans-first:28.18 16:36:30 INFO - PID 24433 | Values: 131.0 135.0 130.0 132.0 131.0 139.0 145.0 135.0 219.0 138.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.50 Median:192.00 stddev:8.33 (4.3%) stddev-sans-first:7.51 16:36:30 INFO - PID 24433 | Values: 178.0 199.0 190.0 204.0 193.0 190.0 191.0 186.0 196.0 178.0 16:36:30 INFO - PID 24433 | 16:36:30 INFO - PID 24433 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:1.71 (2.3%) stddev-sans-first:1.81 16:36:30 INFO - PID 24433 | Values: 72.0 75.0 74.0 72.0 73.0 70.0 73.0 74.0 71.0 70.0 16:36:30 INFO - PID 24433 | -------- Summary: end -------- 16:36:30 INFO - PID 24433 | 16:36:31 INFO - TEST-INFO | 24433: exit 0 16:36:31 INFO - TEST-OK | kraken | took 63440ms 16:36:31 INFO - SUITE-END | took 1183s 16:36:31 INFO - Completed test suite (00:19:43) 16:36:31 INFO - javascript benchmark 16:36:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6736.630580975933, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2733.5762956741705, 2739.643846299981, 2764.295104748289, 2764.944701105978, 2783.471140483309, 5263.526282634562, 5311.814086506978, 5326.147816349385, 5349.197620356948, 5370.677759334438, 5268.157094864822, 5336.946630533694, 5338.199270109476, 5471.8084867029565, 5477.698726570037, 4386.429764130658, 4672.929906051412, 4748.6913350632185, 4758.928616070744, 4771.71369717818, 4795.784189711454, 4838.153323168449, 4852.4662287148385, 4853.757312134379, 4879.170541008019, 4613.5847773700525, 4683.367745354401, 4702.083093796711, 4780.139574876521, 4831.227003679394, 4769.57073863354, 4784.784684689197, 4799.808007679689, 4841.540053694894, 4856.465788763233, 4728.692634978715, 4735.337052812609, 4737.905241895177, 4778.139934811733, 4804.063207674505, 5203.453637368059, 5255.60582956276, 5361.08861493547, 5415.675059496403, 5447.237386765856, 5728.312602487728, 5728.398518155575, 5731.197632331477, 5742.0238559445, 5778.5377169826315, 5763.884722305573, 5764.0, 5782.190493330895, 5784.971075144639, 5787.0, 5303.337082864642, 5339.145736682112, 5371.248025276464, 5373.059714549938, 5381.48875856793, 5879.764809407576, 5902.144189092557, 5918.348981612019, 5921.437463440966, 5935.940640593539, 5600.271964644651, 5647.152927060892, 5669.036263835075, 5672.773089076473, 5683.976884160891, 5808.94191058084, 5825.533957283407, 5848.181254624356, 5852.590318677737, 5907.8227653169615, 5767.567432442584, 5773.04744717117, 5783.929972955017, 5794.98587747151, 5795.362510123883, 5606.187102870061, 5700.116481945305, 5724.055530837365, 5797.681127537941, 5820.505257053113, 4854.05345957542, 4859.222524396079, 4866.586340161126, 4868.294097355934, 4898.657094003457, 4143.3784932260405, 4172.395002724648, 4195.160967806451, 4199.517055538591, 4248.4901811782165, 4657.231556793159, 4738.218193998021, 4778.904421911542, 4790.089882922303, 4793.5685788279225, 5641.041023026095, 5652.434756524397, 5653.971730141323, 5656.462636049569, 5658.179563963202, 4651.116287905287, 4652.697574657636, 4653.441587009513, 4656.837010704609, 4664.183767840615, 4887.0714564232685, 4982.850514484571, 5001.924971125436, 5002.799888004512, 5006.274090256965, 5240.764165612481, 5307.124324486416, 5308.734563271743, 5384.865378365415, 5411.675299482044, 5855.443732845373, 5867.647941123546, 5872.324682661549, 5878.441548052928, 5925.585209035498, 5273.894522109613, 5352.518273355417, 5421.322334708161, 5451.672899626035, 5481.150421684645, 5560.110382338807, 5760.337561180518, 5761.596688231783, 5767.0196066669605, 5774.653520788766, 5776.42235776419, 5787.7395517200985, 5868.94131058684, 5883.676397797991, 5929.466348028525, 5664.81434327393, 5677.460641239076, 5681.0910254359105, 5708.771649133988, 5709.34342550612, 5646.689432081275, 5650.463205995424, 5680.062789639664, 5681.801136960186, 5682.119271512922, 5460.26286451324, 5509.0, 5514.0, 5515.862103447446, 5530.391656917655, 5619.325680918316, 5620.437956204511, 5626.634268772516, 5630.352509461464, 5634.23937768396, 5446.482584154499, 5489.945100548944, 5492.148716948879, 5494.505494505353, 5503.257060296969], "value": 5214.854899515223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.7282269149069, 748.042505592841, 1026.7741096958666, 1046.937183768974, 1122.2256642916382, 31773.841130794342, 32136.517952230733, 32225.194370140758, 32227.194320142007, 32293.354132917357, 29758.702412975865, 29933.0, 29959.55060674086, 30033.549496757565, 30124.54813177804, 6429.967850160766, 6445.129907462503, 6557.868842623145, 7101.928980710179, 7129.465290103237, 7078.0, 7113.573185608854, 7136.357727804497, 7177.2463891291445, 7196.676149573282, 7146.178189508195, 7156.749513767019, 7195.748148814792, 7196.964015179917, 7197.964010179941, 7152.53508521947, 7161.92838071623, 7167.641617919109, 7176.892346614753, 7211.783646490614, 7011.89482157768, 7052.471064670171, 7089.89365159523, 7099.148102227766, 7121.679524421414, 31608.841955790303, 32022.359552809045, 32182.195445113826, 32228.0, 32419.0, 2883.524218503944, 2883.884644614213, 2906.9709302906913, 2907.8400687962153, 2917.7082291770867, 24008.27975160748, 24009.759902401103, 24112.276631701076, 24117.517649647085, 24302.756972430227, 3108.7668424867998, 3122.3755248950074, 3133.4673105572106, 3137.419577378192, 3170.25499007733, 144228.0, 144470.27764861213, 144494.0, 144565.0, 144723.0, 37866.0, 39544.209115817524, 39872.21213984725, 40150.397744033864, 40248.79875600662, 41759.164816703495, 41788.58211417908, 42210.57789422067, 42252.0, 42321.788391057846, 12210.145289829805, 12210.450529726184, 12249.938750306192, 12311.19977201479, 12387.75224495523, 9340.859887101698, 9428.528573571293, 9434.3867648604, 9434.669786557437, 9470.668526601536, 12570.937145314216, 12618.621441356774, 12636.11547191706, 12656.493740250471, 12832.29422381778, 5338.546223570962, 5414.539764120094, 5438.510534051954, 5438.510534051954, 5468.261784659099, 865.1175800683394, 895.4090300401834, 898.4294972692387, 911.8996910339857, 928.7538802217417, 20173.697394539093, 21204.46988825261, 21405.464863378227, 21464.78535214628, 21661.566768664852, 960.1358777100666, 969.7575606098476, 973.8831340239217, 981.0238812381726, 991.4893829677721, 10699.535171060026, 11253.943730281297, 11314.264572802742, 11450.37022963745, 11490.712732181762, 168669.0, 168766.15616921836, 169278.0, 170262.0, 170497.14751426413, 39691.60308396937, 39892.40161397582, 39959.60040399617, 40001.59998400037, 40074.398884016766, 1172.1677608897608, 1201.9158658893969, 1219.4451524556305, 1221.7067903703226, 1229.33001514175, 19834.404967850987, 19910.50223744418, 20374.592508149457, 21035.0, 21170.36488905335, 29069.85465072661, 29195.124146275644, 29205.269868253465, 29384.853075734485, 29391.41217175602, 140748.29625851806, 142291.28854356077, 143342.28328858706, 144853.0, 145565.0, 30783.84608077035, 31259.53110703387, 31355.0, 31450.528242076845, 31622.466068438393, 36804.447933280484, 37493.250134997696, 38061.619383806916, 38150.427743583314, 38428.0, 29167.270818229714, 29180.416391672472, 29425.0, 29775.404491910474, 30349.241268968453, 28667.0, 28837.56743648805, 29399.70600294055, 29801.40397192001, 29896.701032989393, 31439.528407073456, 31477.0, 31673.5248971261, 31687.366252675278, 32024.6797532031, 26783.0, 26935.595966060133, 27475.725242747318, 27511.58732619052, 28543.571846422736, 21646.350609481742, 22689.432764181027, 22710.0, 22737.204197852996, 22775.544489110456], "value": 14487.185012295746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.86980166346774, 411.2474172264754, 412.67604930129846, 412.67736903225165, 436.18433529300194, 14207.857921420782, 14484.637884052903, 17014.06422646754, 17697.256925176585, 17735.911320443396, 18719.438416847483, 18836.246550137977, 18908.338208162717, 18955.33656322029, 19195.808041919576, 5240.475952404748, 5322.787088516455, 5500.532454741332, 5595.804146854861, 5637.0, 5431.429699881515, 5534.169874518814, 5535.861603459905, 5536.114221724525, 5552.139418390156, 5055.443901170886, 5523.226748255248, 5557.944420555803, 5565.053940830068, 5569.359523654771, 5254.369475662907, 5513.145462453326, 5515.944840551583, 5524.088525393346, 5527.806526771564, 4948.653594248404, 4983.576396006344, 4986.950130498685, 4989.376327959005, 4993.525615066599, 21470.35588932319, 21867.890660546753, 21926.342209733735, 22105.226317078985, 22253.22113726012, 1621.8459246371576, 1654.1894471708897, 1669.090345761563, 1670.8245634208354, 1673.029642807169, 13642.93178534101, 13670.0, 14004.089734167348, 14754.336054877556, 14963.70072598542, 1992.2927360787003, 2017.9192832286692, 2047.7747447780732, 2048.0, 2149.344449942767, 84972.39113720573, 88087.55956220177, 90972.0, 92590.0, 95586.9999999993, 10979.17656175774, 11156.944215279034, 11226.7193320166, 11252.15608829341, 11390.886091139148, 15897.443589474544, 15897.920510397606, 15900.204989750466, 15913.363465461483, 15957.840421595636, 7451.552906825608, 7625.6568454419685, 7788.727394541163, 7848.607569621496, 7880.684772609032, 6913.1358580177475, 6933.861322773516, 6970.0, 7152.856942861114, 7190.06529151207, 6984.476164287698, 7001.754938577125, 7053.329933656294, 7076.186238582526, 7206.901032555947, 2023.8380929525604, 2050.805173508514, 2073.1603700501323, 2082.552251265985, 2166.501704607949, 832.1678321678322, 860.617025423693, 870.7953630896734, 881.9426737262057, 892.0811564088999, 16896.746548801777, 16970.830291697173, 17214.397496087826, 17247.0, 17930.731039034425, 870.0864092702637, 873.8820259265045, 876.7676565710092, 882.5322579033123, 905.103947092387, 9123.452592844451, 9359.812803743887, 9690.854637180448, 9727.65953191635, 9833.704988850346, 356748.0, 361072.0, 362054.0, 377521.0, 384877.0, 73457.6327118361, 75279.62360188164, 76072.23927760762, 76473.61763191149, 77884.61057694789, 1080.827067669169, 1083.1767856429012, 1121.9439028048564, 1124.8818874018275, 1127.9605213817476, 17777.733333999742, 18011.279548818424, 18828.905855470635, 18868.622627547098, 19074.141663624894, 36816.26367472689, 37500.2499949994, 37689.81155094207, 38104.80947595244, 39658.20683586255, 48671.75664121657, 50150.74924625354, 50444.0, 50539.74730126326, 50539.74730126326, 8010.919890801018, 8085.43401961857, 8168.714095006646, 8292.502449852787, 8312.16878312188, 12066.396680166132, 12265.632031039084, 12282.877171228174, 12403.131780775258, 12526.37368131608, 9130.95434522823, 10489.47552622381, 10739.355638661706, 10895.400752958663, 11374.0, 10344.482775861328, 10455.0, 10606.893931060591, 10608.416537090225, 10747.247692661438, 10360.792784144425, 11032.558697652004, 11105.722356941142, 11212.719682008015, 11267.718307042389, 8006.879896801669, 8173.632186551738, 8204.097549269456, 8208.425410221227, 8216.548089855116, 10409.635662751767, 10665.520051597541, 10919.617813376493, 11026.173037022096, 11256.212065155689], "value": 8837.387198864053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.2546472116728, 1308.72516771478, 1330.720548684776, 1332.7201287729577, 1350.790627452745, 9542.379745316559, 9961.4521201334, 9983.900160998388, 10043.949780251107, 10242.28304018719, 10024.198064154869, 10143.13783328418, 10172.135368493688, 10204.846927296096, 10217.795644087133, 2270.1146552844402, 2287.6911616931666, 2302.3323236261463, 2307.630779075348, 2310.156792770635, 2157.8381621378458, 2211.181862710799, 2211.3476524425255, 2226.9109235630553, 2232.799048085672, 2211.557688462306, 2221.3780141560387, 2265.150568536799, 2274.283600665793, 2277.7152855893014, 2148.0977989244557, 2169.642009068502, 2205.0628482894786, 2228.732552093743, 2230.910763569447, 2054.281001649426, 2168.2194410012385, 2171.0664414301846, 2183.8034576888, 2193.5283913958574, 10193.08262256393, 10200.897991020143, 10244.846327305097, 10273.332233404804, 10302.742431439274, 5545.72271386429, 5720.971395143039, 5724.8855022899725, 5726.31284245889, 5746.339170995348, 3269.8853632771215, 3372.1738174147245, 3377.257003459235, 3414.231797845465, 3451.188970591909, 1070.0904231403322, 1087.255230167338, 1097.13874608432, 1123.825806999908, 1139.6467095200433, 14755.483558075415, 14911.179885106314, 14952.102873827605, 14957.177355245458, 15004.924975375163, 4425.889352766207, 4542.454905411306, 4760.833595769059, 4800.66395352322, 4820.156472617348, 10485.0, 10648.254622176528, 10675.519601617945, 10683.09193718527, 10703.946480267548, 5533.944660553343, 5542.3626282977975, 5558.972205138948, 5577.749001294951, 5582.051051321285, 4943.134951383494, 5117.283580298761, 5166.070107380632, 5194.870128246824, 5252.894942101213, 3625.2024554597947, 3701.0, 3765.9246815063543, 3766.8681596144, 3802.125511132455, 1049.905508504223, 1051.6056478820442, 1067.4289255248405, 1072.0780129088978, 1078.5308390850005, 692.2074225012333, 713.9000539924415, 721.945854060937, 736.1571001203592, 736.6611358774917, 5304.840854774363, 5412.296401467863, 5423.349198096174, 5559.19391688211, 5569.21785028795, 529.3066083430718, 547.0, 547.2284079448038, 550.3670778604637, 551.0191858491891, 3302.339532093591, 3371.780834245766, 3377.560917080764, 3458.9796010177056, 3742.607026262258, 12495.437705303284, 12741.745165096647, 12843.935780321226, 13085.934570327277, 13675.0, 12341.197822141532, 12550.937245313715, 12564.183328083645, 12838.422270997828, 12842.614721558368, 7314.012608297811, 7368.4842061055215, 7397.223291554309, 7403.370713489306, 7406.814829629302, 5614.494695477427, 5677.716114194356, 5719.628224165416, 5818.883622327445, 5930.881382372242, 11397.373144477133, 11419.885801141882, 11558.42207889619, 11634.301941883514, 11707.473163707824, 11659.242149260272, 11659.242149260272, 11665.825012624648, 11907.940460297643, 12059.698507537381, 7111.288871112847, 7160.0, 7174.3184397482155, 7206.747763828241, 7206.89189662166, 8920.643174272956, 8996.05541418168, 9032.729018129467, 9289.442633442015, 9384.436933783994, 8042.914206582037, 8100.797480063045, 8100.959495202486, 8139.83720325602, 8297.419180657296, 7817.452778305464, 7893.684252629831, 7913.208679132041, 7969.681212751425, 8051.436399451982, 7053.541519801196, 7181.856362872818, 7251.601161936144, 7287.0, 7421.0723659542555, 4496.37050812893, 5277.630565860506, 5290.629655924048, 5343.5457986071615, 5361.115415956324, 5204.921926171035, 5222.086134926449, 5311.72518595542, 5338.439463856239, 5384.380796208487], "value": 4607.09766645451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.8042782817436, 394.1073468593636, 396.4172666180717, 399.57644896409806, 404.54084613963164, 5546.86132846679, 5682.119271512922, 5686.488216060548, 5687.289088863892, 5701.828945131642, 5367.543758780498, 5424.0, 5431.592630552715, 5508.724563771815, 5539.473749993755, 4299.8065087071, 4315.654747620183, 4318.654507639381, 4330.090680957002, 4331.155424692186, 4321.265384884561, 4326.242907491176, 4338.045629961403, 4339.609435150835, 4347.956520434803, 3967.4643923070303, 4115.251018317218, 4142.834286628531, 4294.720843145185, 4305.22505948929, 4109.28087584673, 4115.773632450214, 4125.092479654471, 4125.216208920296, 4125.8968525786795, 3590.281943611288, 3591.5510561179854, 3597.94603080954, 3624.89125326238, 3626.057225121461, 5332.626716129873, 5423.2407462954825, 5423.403425623178, 5425.3489581250105, 5438.8912221755345, 4886.633502487328, 4900.068986892479, 4908.0, 4913.950860491385, 4937.23472861707, 5833.445822646841, 5860.179574859523, 5868.501177399883, 5877.031194549831, 5895.73469193883, 3992.8802135935966, 4057.6145266199665, 4076.6942479313875, 4079.5120172252596, 4081.0409553754844, 6011.789587364465, 6227.501799856001, 6235.282942461584, 6268.561200715952, 6305.96847015762, 4121.258173528794, 4152.356384760367, 4165.396017577435, 4167.0, 4168.270552653274, 4207.0113523322, 4213.157368526307, 4218.430511880918, 4223.986243301585, 4230.555791641833, 4764.833230836974, 4834.20235661119, 4888.26675998596, 4892.633052521004, 4900.313956046157, 5858.506080949331, 5863.882722345529, 5869.413058694096, 5895.852603684943, 5901.616394934315, 1443.1773888883235, 1449.0581122270398, 1450.811394518727, 1452.9709405812036, 1453.6583902782838, 897.7800438892513, 951.3768481644533, 960.2653969713175, 964.1563631822156, 967.0377973915859, 4871.853844384674, 4897.240927656219, 4900.926486102711, 4906.31311616374, 4928.778204980785, 6038.071535305374, 6081.75672973085, 6091.177691011657, 6101.572889897665, 6114.724837382329, 4772.856814295576, 4873.829415970424, 4900.436449808247, 4925.38432695913, 4943.0, 3207.775455718124, 3215.758818088653, 3224.2423030587793, 3237.190702324419, 3240.5787247657654, 5542.667439953535, 5613.943860561342, 5627.0, 5644.32268127819, 5657.858553536194, 6212.844678882973, 6231.781887633911, 6237.126802247689, 6291.370862913672, 6327.209098862642, 5616.584868506581, 5624.746886390122, 5635.182898479616, 5687.51656109227, 5689.288838895138, 5907.350191478848, 6022.488088512526, 6087.208662873798, 6088.573799833969, 6104.633721976696, 5974.522038236843, 6003.549733770072, 6008.519318454601, 6031.7587296507645, 6049.727762250797, 5526.834194974157, 5639.125935480007, 5664.376918538875, 5719.113537401709, 5719.714014299185, 4150.91698166041, 4161.167766446662, 4161.8959526012095, 4164.37534369847, 4186.309258972357, 5963.940360596339, 6022.819315420545, 6113.358097399709, 6144.139820425234, 6150.630962142286, 5898.439648233411, 5919.200907877382, 5932.436418540232, 5932.508346494396, 5945.346011938596, 5859.384764599826, 5875.471207591167, 5921.4966727826895, 5934.97032514852, 5944.227250457586, 5689.687067211343, 5791.0, 5809.883802323845, 5828.358880523224, 5858.0, 5916.645001299936, 5942.376050514634, 5951.137085122719, 5956.255468066492, 5975.820725378246, 5704.657720536781, 5765.135229715576, 5779.884402312015, 5781.913271300849, 5798.449147330997], "value": 4385.90235358359, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.0609024771431, 696.1472196559215, 710.1300906389677, 710.2542330552919, 719.5071376107367, 12304.0, 12837.550685726, 13636.0, 14337.283135843205, 14389.0, 13528.458861645522, 14510.782338264908, 14528.927355363236, 14605.707885842277, 14623.268836558183, 873.8645509945952, 891.2602539891874, 893.0712059458156, 893.3791015244408, 897.5601955042048, 903.9954800225989, 905.5879574793486, 911.3483859040784, 912.3886995712888, 914.095045904553, 945.9668911588096, 950.1496160935958, 954.4082668745388, 955.1022039283051, 955.3980991975046, 933.1881263300971, 944.117250370902, 945.1115951006033, 945.5036106044313, 947.1617618407759, 696.5611664651288, 699.8390370214879, 701.0990876723437, 701.3232230897208, 701.7789396340137, 13811.930940345335, 13865.37605807741, 14067.366968486444, 14620.488282910153, 14647.04794188385, 15111.773323400157, 15304.923475382664, 15428.074315541104, 15834.76247856283, 15928.283227254802, 11714.180007399485, 11845.0, 12011.279323240546, 12084.093692973061, 12117.636470905887, 2963.7184467475554, 2967.5697023931625, 2970.643522777259, 2990.745786608119, 2994.4609970205356, 69511.0, 69962.0, 70004.29995700029, 70168.99999999949, 71313.28686713119, 12584.685382865318, 12608.558700445441, 12670.619881403572, 12712.491500339884, 12766.553170638983, 22391.328260152222, 22473.775262247495, 22490.437739056328, 22535.0, 22714.205002824823, 5936.940630593639, 6063.211782468339, 6174.197354343996, 6224.844378890564, 6241.407066328691, 3095.6440009398757, 3139.5133754267667, 3154.921126971844, 3169.8415079245947, 3174.761892858045, 3442.277121804449, 3528.364894318996, 3534.8232588370993, 3570.0539357070397, 3586.677199052098, 744.0736283327292, 745.3627148787817, 754.2344520311888, 754.6377738685462, 756.6897571995455, 600.1687662587348, 629.7638385605399, 631.8136149835809, 637.6429199648212, 649.5972497051858, 9451.243900487945, 9906.05892440217, 10080.29437939352, 10104.29269951111, 10194.388336699822, 610.4444955090846, 620.9565330426826, 621.7854840080165, 625.7152995387088, 634.9428551430393, 4457.598816106566, 4574.6340292776495, 4585.060062687141, 4588.285524212344, 4591.334256532784, 64328.67835660792, 64665.35334646687, 64703.352966469734, 65409.0, 67156.6642166786, 57456.42543574594, 58156.41843581595, 59599.0, 60146.69926650339, 60906.0, 52620.73689631604, 52838.99999999923, 53353.46646533485, 53585.0, 54995.72502137544, 9519.904800951901, 9613.615455381987, 9681.854772178564, 9684.176844968257, 9955.054269844353, 27915.720842791314, 28002.159935201977, 28146.85926570436, 28169.859150704116, 28267.43465130645, 34213.144671383416, 34437.65562344345, 34446.311073777884, 34934.475982860786, 35095.0, 12426.192297500633, 12633.431495582905, 12656.746865062463, 12677.8098328527, 12780.233186008498, 15538.456154034555, 16063.518094457186, 16298.42955496552, 16390.67218655644, 16400.17999100064, 13798.103123296954, 14481.0, 14826.77759833625, 15440.536783896501, 15600.375984960474, 14241.501547446203, 14298.928505357406, 14420.278986050866, 15666.686666266838, 16000.839991599934, 14045.227512486912, 14607.92696036513, 15143.924280378527, 15457.922710386376, 15926.4425745103, 10421.739456513344, 10963.068139207937, 11202.66392008241, 11273.210875238654, 11504.36725980079, 11959.76080478403, 12462.688432789253, 12499.312537810507, 12501.74996500083, 12559.99520038413], "value": 6927.688244591417, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 114.0, 113.0, 113.0, 113.0, 112.0, 114.0, 111.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 124.0, 169.0, 123.0, 125.0, 125.0, 124.0, 145.0, 124.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 165.0, 168.0, 167.0, 168.0, 165.0, 162.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 103.0, 76.0, 76.0, 74.0, 75.0, 96.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 106.0, 85.0, 84.0, 83.0, 98.0, 83.0, 83.0, 101.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 117.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 150.0, 152.0, 150.0, 152.0, 150.0, 150.0, 151.0, 149.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 96.0, 95.0, 96.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 57.0, 55.0, 55.0, 55.0, 56.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 89.0, 95.0, 82.0, 83.0, 85.0, 85.0, 82.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 135.0, 130.0, 132.0, 131.0, 139.0, 145.0, 135.0, 219.0, 138.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 199.0, 190.0, 204.0, 193.0, 190.0, 191.0, 186.0, 196.0, 178.0], "value": 190.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 74.0, 72.0, 73.0, 70.0, 73.0, 74.0, 71.0, 70.0], "value": 72.4, "unit": "score"}]}]} 16:36:31 INFO - Return code: 0 16:36:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:36:31 INFO - # TBPL SUCCESS # 16:36:31 INFO - Running post-action listener: _resource_record_post_action 16:36:31 INFO - [mozharness: 2017-05-09 23:36:31.319571Z] Finished run-tests step (success) 16:36:31 INFO - Running post-run listener: _resource_record_post_run 16:36:31 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 376012800; Read time: 20; Write time: 323068 16:36:31 INFO - TinderboxPrint: CPU usage
13.3% 16:36:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 16:36:31 INFO - TinderboxPrint: I/O write bytes / time
376,012,800 / 323,068 16:36:31 INFO - TinderboxPrint: CPU idle
8,296.2 (86.7%) 16:36:31 INFO - TinderboxPrint: CPU user
1,214.3 (12.7%) 16:36:31 INFO - TinderboxPrint: Swap in / out
0 / 0 16:36:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118734848; Read time: 0; Write time: 117384 16:36:31 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 256655360; Read time: 0; Write time: 205604 16:36:31 INFO - Running post-run listener: _upload_blobber_files 16:36:31 INFO - Blob upload gear active. 16:36:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:36:31 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 16:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:36:32 INFO - (blobuploader) - INFO - Open directory for files ... 16:36:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:36:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:36:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:35 INFO - (blobuploader) - INFO - Done attempting. 16:36:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:36:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:36:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:37 INFO - (blobuploader) - INFO - Done attempting. 16:36:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:36:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:38 INFO - (blobuploader) - INFO - Done attempting. 16:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:38 INFO - (blobuploader) - INFO - Done attempting. 16:36:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:36:39 INFO - Return code: 0 16:36:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:36:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:36:39 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c260f84d2acbd0f7bd357dc57affa784b926bcc6752ad99bf0b4412c6efb79c0b2111e9f89c80366c0db96313ad92074dc60484ed6feeec6b37419275d4a852", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffaec5db6795efc14f9ba478b1e9cbb7ed4b28206f6ea27dd9c2bcc93438637f88c4e05c097b54e407602cd4bc7cff029f58f3ec14e652faeba2e374c14aa9c1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b012790d959539c820d0220b5d20ec92bc4e2b33146e664ee163a9485cb21d3d4beaf19f9d4fdbc087f9dee81561226b538babd179d60d1e81dce67dbab66aa6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d0ebe3fb6cbf904046559ce0cd9df2e1c3c338dd8a5e3264442a8fd3f6f59497300cd0217085e451208fe8c10758cf7a7980a9d04cdee26288bd9881968365a"} 16:36:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:36:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:36:39 INFO - Contents: 16:36:39 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c260f84d2acbd0f7bd357dc57affa784b926bcc6752ad99bf0b4412c6efb79c0b2111e9f89c80366c0db96313ad92074dc60484ed6feeec6b37419275d4a852", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffaec5db6795efc14f9ba478b1e9cbb7ed4b28206f6ea27dd9c2bcc93438637f88c4e05c097b54e407602cd4bc7cff029f58f3ec14e652faeba2e374c14aa9c1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b012790d959539c820d0220b5d20ec92bc4e2b33146e664ee163a9485cb21d3d4beaf19f9d4fdbc087f9dee81561226b538babd179d60d1e81dce67dbab66aa6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d0ebe3fb6cbf904046559ce0cd9df2e1c3c338dd8a5e3264442a8fd3f6f59497300cd0217085e451208fe8c10758cf7a7980a9d04cdee26288bd9881968365a"} 16:36:39 INFO - Running post-run listener: copy_logs_to_upload_dir 16:36:39 INFO - Copying logs to upload dir... 16:36:39 INFO - mkdir: /builds/slave/test/build/upload/logs 16:36:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.186891 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-09 16:36:38.843899) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 16:36:38.848870) ========= 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=0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c260f84d2acbd0f7bd357dc57affa784b926bcc6752ad99bf0b4412c6efb79c0b2111e9f89c80366c0db96313ad92074dc60484ed6feeec6b37419275d4a852", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffaec5db6795efc14f9ba478b1e9cbb7ed4b28206f6ea27dd9c2bcc93438637f88c4e05c097b54e407602cd4bc7cff029f58f3ec14e652faeba2e374c14aa9c1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b012790d959539c820d0220b5d20ec92bc4e2b33146e664ee163a9485cb21d3d4beaf19f9d4fdbc087f9dee81561226b538babd179d60d1e81dce67dbab66aa6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d0ebe3fb6cbf904046559ce0cd9df2e1c3c338dd8a5e3264442a8fd3f6f59497300cd0217085e451208fe8c10758cf7a7980a9d04cdee26288bd9881968365a"} build_url:https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/YV2HgeL5S5iKdWYV2Pnp0A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c260f84d2acbd0f7bd357dc57affa784b926bcc6752ad99bf0b4412c6efb79c0b2111e9f89c80366c0db96313ad92074dc60484ed6feeec6b37419275d4a852", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffaec5db6795efc14f9ba478b1e9cbb7ed4b28206f6ea27dd9c2bcc93438637f88c4e05c097b54e407602cd4bc7cff029f58f3ec14e652faeba2e374c14aa9c1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b012790d959539c820d0220b5d20ec92bc4e2b33146e664ee163a9485cb21d3d4beaf19f9d4fdbc087f9dee81561226b538babd179d60d1e81dce67dbab66aa6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d0ebe3fb6cbf904046559ce0cd9df2e1c3c338dd8a5e3264442a8fd3f6f59497300cd0217085e451208fe8c10758cf7a7980a9d04cdee26288bd9881968365a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 16:36:38.881624) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:36:38.881946) ========= 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=0a54c299e5ca1d63338479f2000001b5-1494371742.684880-340381688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:36:38.961219) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 16:36:38.964574) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 16:36:38.964879) ========= ========= Total master_lag: 0.17 =========