builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1494029697.83 results: success (0) revision: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:57.834475) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:57.834908) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:57.835239) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:57.849840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:57.850148) ========= 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=232498196343f89f466a4a9a000001c8-1494029697.307108-771510321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 17:14:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-05-05 17:14:58 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077793 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:57.945371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:57.945685) ========= 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=232498196343f89f466a4a9a000001c8-1494029697.307108-771510321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017801 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:57.995086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 17:14:57.998433) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 --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 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 --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=232498196343f89f466a4a9a000001c8-1494029697.307108-771510321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 17:14:58,302 truncating revision to first 12 chars 2017-05-05 17:14:58,302 Setting DEBUG logging. 2017-05-05 17:14:58,302 attempt 1/10 2017-05-05 17:14:58,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37a5b7f6f101?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 17:14:58,977 unpacking tar archive at: mozilla-central-37a5b7f6f101/testing/mozharness/ program finished with exit code 0 elapsedTime=1.048052 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 17:14:59.059699) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:59.060022) ========= script_repo_revision: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:59.063424) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:59.063700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 17:14:59.074633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-05-05 17:14:59.074897) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1494029697.307108-771510321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:14:59 INFO - MultiFileLogger online at 20170505 17:14:59 in /builds/slave/test 17:14:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:14:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:14:59 INFO - {'append_to_log': False, 17:14:59 INFO - 'base_work_dir': '/builds/slave/test', 17:14:59 INFO - 'blob_upload_branch': 'Firefox', 17:14:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:14:59 INFO - 'branch': 'Firefox', 17:14:59 INFO - 'buildbot_json_path': 'buildprops.json', 17:14:59 INFO - 'config_files': ('talos/linux_config.py',), 17:14:59 INFO - 'default_actions': ('clobber', 17:14:59 INFO - 'read-buildbot-config', 17:14:59 INFO - 'download-and-extract', 17:14:59 INFO - 'populate-webroot', 17:14:59 INFO - 'create-virtualenv', 17:14:59 INFO - 'install', 17:14:59 INFO - 'run-tests'), 17:14:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:14:59 INFO - 'download_minidump_stackwalk': True, 17:14:59 INFO - 'download_symbols': 'ondemand', 17:14:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:14:59 INFO - 'tooltool.py': '/tools/tooltool.py', 17:14:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:14:59 INFO - '/tools/misc-python/virtualenv.py')}, 17:14:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:14:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:14:59 INFO - 'gecko_profile': False, 17:14:59 INFO - 'gecko_profile_interval': 0, 17:14:59 INFO - 'installer_path': 'installer.exe', 17:14:59 INFO - 'log_level': 'info', 17:14:59 INFO - 'log_name': 'talos', 17:14:59 INFO - 'log_to_console': True, 17:14:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:14:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:14:59 INFO - 'opt_config_files': (), 17:14:59 INFO - 'pip_index': False, 17:14:59 INFO - 'suite': 'dromaeojs-e10s', 17:14:59 INFO - 'system_bits': '32', 17:14:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:14:59 INFO - 'title': 'talos-linux64-ix-025', 17:14:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:14:59 INFO - 'use_talos_json': True, 17:14:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:14:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:14:59 INFO - 'work_dir': 'build'} 17:14:59 INFO - [mozharness: 2017-05-06 00:14:59.475651Z] Running clobber step. 17:14:59 INFO - Running pre-action listener: _resource_record_pre_action 17:14:59 INFO - Running main action method: clobber 17:14:59 INFO - rmtree: /builds/slave/test/build 17:14:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:15:00 INFO - Running post-action listener: _resource_record_post_action 17:15:00 INFO - [mozharness: 2017-05-06 00:15:00.524959Z] Finished clobber step (success) 17:15:00 INFO - [mozharness: 2017-05-06 00:15:00.525058Z] Running read-buildbot-config step. 17:15:00 INFO - Running pre-action listener: _resource_record_pre_action 17:15:00 INFO - Running main action method: read_buildbot_config 17:15:00 INFO - Using buildbot properties: 17:15:00 INFO - { 17:15:00 INFO - "project": "", 17:15:00 INFO - "product": "firefox", 17:15:00 INFO - "who": "kwierso@gmail.com", 17:15:00 INFO - "installer_path": "public/build/target.tar.bz2", 17:15:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:15:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:15:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:15:00 INFO - "stage_platform": "linux64-pgo", 17:15:00 INFO - "basedir": "/builds/slave/test", 17:15:00 INFO - "buildnumber": 197, 17:15:00 INFO - "platform": "ubuntu64_hw", 17:15:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:15:00 INFO - "slavebuilddir": "test", 17:15:00 INFO - "taskId": "D5eqLj-ORcWyqKxIp3RnqA", 17:15:00 INFO - "branch": "mozilla-central", 17:15:00 INFO - "script_repo_revision": "production", 17:15:00 INFO - "revision": "37a5b7f6f101df2eb292b1b6baaf1540c9920e20", 17:15:00 INFO - "slavename": "talos-linux64-ix-025", 17:15:00 INFO - "repo_path": "mozilla-central" 17:15:00 INFO - } 17:15:00 INFO - Finding installer, test and symbols from parent task. 17:15:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D5eqLj-ORcWyqKxIp3RnqA'}, attempt #1 17:15:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D5eqLj-ORcWyqKxIp3RnqA'}, attempt #1 17:15:01 INFO - Task dependencies: E-z8X3TIRqCsRQ2h6kzILw 17:15:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw'}, attempt #1 17:15:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.tar.bz2 17:15:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/test_packages.json 17:15:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.crashreporter-symbols.zip 17:15:01 INFO - Running post-action listener: _resource_record_post_action 17:15:01 INFO - [mozharness: 2017-05-06 00:15:01.893776Z] Finished read-buildbot-config step (success) 17:15:01 INFO - [mozharness: 2017-05-06 00:15:01.893991Z] Running download-and-extract step. 17:15:01 INFO - Running pre-action listener: _resource_record_pre_action 17:15:01 INFO - Running main action method: download_and_extract 17:15:01 INFO - mkdir: /builds/slave/test/build/tests 17:15:01 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')]} 17:15:01 INFO - trying https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.test_packages.json 17:15:01 INFO - Downloading https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:15:02 INFO - Downloaded 986 bytes. 17:15:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:15:02 INFO - Using the following test package requirements: 17:15:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:15:02 INFO - u'common': [u'target.common.tests.zip'], 17:15:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:15:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:15:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:15:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:15:02 INFO - u'mozbase': [u'target.common.tests.zip'], 17:15:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:15:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:15:02 INFO - u'web-platform': [u'target.common.tests.zip', 17:15:02 INFO - u'target.web-platform.tests.zip'], 17:15:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:15:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:15:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.common.tests.zip 17:15:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:15:02 INFO - Fetch https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.common.tests.zip into memory 17:15:03 INFO - Content-Length response header: 60564279 17:15:03 INFO - Bytes received: 60564279 17:15:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:15:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.common.tests.zip 17:15:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:15:13 INFO - Fetch https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.common.tests.zip into memory 17:15:14 INFO - Content-Length response header: 60564279 17:15:14 INFO - Bytes received: 60564279 17:15:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.talos.tests.zip 17:15:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:15:25 INFO - Fetch https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.talos.tests.zip into memory 17:15:26 INFO - Content-Length response header: 14408697 17:15:26 INFO - Bytes received: 14408697 17:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:26 INFO - trying https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.tar.bz2 17:15:26 INFO - Downloading https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:15:28 INFO - Downloaded 63882108 bytes. 17:15:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.tar.bz2 17:15:28 INFO - mkdir: /builds/slave/test/properties 17:15:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:28 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:28 INFO - Contents: 17:15:28 INFO - build_url:https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.tar.bz2 17:15:28 INFO - Running post-action listener: _resource_record_post_action 17:15:28 INFO - Running post-action listener: set_extra_try_arguments 17:15:28 INFO - [mozharness: 2017-05-06 00:15:28.175007Z] Finished download-and-extract step (success) 17:15:28 INFO - [mozharness: 2017-05-06 00:15:28.175102Z] Running populate-webroot step. 17:15:28 INFO - Running pre-action listener: _resource_record_pre_action 17:15:28 INFO - Running main action method: populate_webroot 17:15:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:28 INFO - '--tppagecycles', 17:15:28 INFO - '7'], 17:15:28 INFO - 'tests': ['tsvgm']}}, 17:15:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:15:28 INFO - 'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:15:28 INFO - 'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['damp', 'tps']}, 17:15:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:15:28 INFO - 'tests': ['damp', 'tps']}, 17:15:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['dromaeo_dom']}, 17:15:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:15:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:15:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore', 17:15:28 INFO - 'tabpaint']}, 17:15:28 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore', 17:15:28 INFO - 'tabpaint']}, 17:15:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore', 17:15:28 INFO - 'tabpaint']}, 17:15:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore', 17:15:28 INFO - 'tabpaint']}, 17:15:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore', 17:15:28 INFO - 'tabpaint']}, 17:15:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore', 17:15:28 INFO - 'tabpaint']}, 17:15:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:15:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:15:28 INFO - 'bloom_basic_ref']}, 17:15:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['tsvgx', 17:15:28 INFO - 'tsvgr_opacity', 17:15:28 INFO - 'tart', 17:15:28 INFO - 'tscrollx', 17:15:28 INFO - 'cart', 17:15:28 INFO - 'tsvg_static']}, 17:15:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:28 INFO - 'tsvgr_opacity', 17:15:28 INFO - 'tart', 17:15:28 INFO - 'tscrollx', 17:15:28 INFO - 'cart', 17:15:28 INFO - 'tsvg_static']}, 17:15:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:15:28 INFO - 'talos_options': ['--disable-e10s'], 17:15:28 INFO - 'tests': ['tp5o']}, 17:15:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:15:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:15:28 INFO - 'talos_options': ['--disable-e10s', 17:15:28 INFO - '--xperf_path', 17:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:28 INFO - 'tests': ['tp5n']}, 17:15:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:15:28 INFO - 'talos_options': ['--xperf_path', 17:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:28 INFO - 'tests': ['tp5n']}}, 17:15:28 INFO - 'talos.zip': {'path': '', 17:15:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:28 INFO - Running post-action listener: _resource_record_post_action 17:15:28 INFO - [mozharness: 2017-05-06 00:15:28.188736Z] Finished populate-webroot step (success) 17:15:28 INFO - [mozharness: 2017-05-06 00:15:28.188824Z] Running create-virtualenv step. 17:15:28 INFO - Running pre-action listener: _resource_record_pre_action 17:15:28 INFO - Running main action method: create_virtualenv 17:15:28 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:28 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 17:15:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:28 INFO - Using real prefix '/usr' 17:15:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:28 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:30 INFO - Installing pip.................done. 17:15:30 INFO - Return code: 0 17:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:15:30 INFO - Reading from file tmpfile_stdout 17:15:30 INFO - Output received: 17:15:30 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) 17:15:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, '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': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', '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 17:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:15:30 INFO - Using env: {'DISPLAY': ':0', 17:15:30 INFO - 'HOME': '/home/cltbld', 17:15:30 INFO - 'LANG': 'en_US.UTF-8', 17:15:30 INFO - 'LANGUAGE': 'en_US:en', 17:15:30 INFO - 'LOGNAME': 'cltbld', 17:15:30 INFO - 'MAIL': '/var/mail/cltbld', 17:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:30 INFO - 'MOZ_NO_REMOTE': '1', 17:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:30 INFO - 'NO_EM_RESTART': '1', 17:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:30 INFO - 'PWD': '/builds/slave/test', 17:15:30 INFO - 'SHELL': '/bin/bash', 17:15:30 INFO - 'SHLVL': '1', 17:15:30 INFO - 'TERM': 'linux', 17:15:30 INFO - 'TMOUT': '86400', 17:15:30 INFO - 'USER': 'cltbld', 17:15:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:30 INFO - '_': '/tools/buildbot/bin/python'} 17:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:31 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 17:15:31 INFO - Cleaning up... 17:15:31 INFO - Return code: 0 17:15:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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', '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 0x282c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, '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': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', '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 17:15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:15: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 psutil>=3.1.1 17:15:31 INFO - Using env: {'DISPLAY': ':0', 17:15:31 INFO - 'HOME': '/home/cltbld', 17:15:31 INFO - 'LANG': 'en_US.UTF-8', 17:15:31 INFO - 'LANGUAGE': 'en_US:en', 17:15:31 INFO - 'LOGNAME': 'cltbld', 17:15:31 INFO - 'MAIL': '/var/mail/cltbld', 17:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:31 INFO - 'MOZ_NO_REMOTE': '1', 17:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:31 INFO - 'NO_EM_RESTART': '1', 17:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:31 INFO - 'PWD': '/builds/slave/test', 17:15:31 INFO - 'SHELL': '/bin/bash', 17:15:31 INFO - 'SHLVL': '1', 17:15:31 INFO - 'TERM': 'linux', 17:15:31 INFO - 'TMOUT': '86400', 17:15:31 INFO - 'USER': 'cltbld', 17:15:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:31 INFO - '_': '/tools/buildbot/bin/python'} 17:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:31 INFO - Downloading/unpacking psutil>=3.1.1 17:15:31 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 17:15:31 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 17:15:31 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 17:15:31 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 17:15:31 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 17:15:31 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 17:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:32 INFO - Installing collected packages: psutil 17:15:32 INFO - Running setup.py install for psutil 17:15:32 INFO - building 'psutil._psutil_linux' extension 17:15:32 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 17:15:32 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 17:15:32 INFO - building 'psutil._psutil_posix' extension 17:15:32 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 17:15:32 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 17:15:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:33 INFO - Successfully installed psutil 17:15:33 INFO - Cleaning up... 17:15:33 INFO - Return code: 0 17:15:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, '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': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', '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 17:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:15:33 INFO - Using env: {'DISPLAY': ':0', 17:15:33 INFO - 'HOME': '/home/cltbld', 17:15:33 INFO - 'LANG': 'en_US.UTF-8', 17:15:33 INFO - 'LANGUAGE': 'en_US:en', 17:15:33 INFO - 'LOGNAME': 'cltbld', 17:15:33 INFO - 'MAIL': '/var/mail/cltbld', 17:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:33 INFO - 'MOZ_NO_REMOTE': '1', 17:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:33 INFO - 'NO_EM_RESTART': '1', 17:15:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:33 INFO - 'PWD': '/builds/slave/test', 17:15:33 INFO - 'SHELL': '/bin/bash', 17:15:33 INFO - 'SHLVL': '1', 17:15:33 INFO - 'TERM': 'linux', 17:15:33 INFO - 'TMOUT': '86400', 17:15:33 INFO - 'USER': 'cltbld', 17:15:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:33 INFO - '_': '/tools/buildbot/bin/python'} 17:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:15:34 INFO - Installing collected packages: mozsystemmonitor 17:15:34 INFO - Running setup.py install for mozsystemmonitor 17:15:34 INFO - Successfully installed mozsystemmonitor 17:15:34 INFO - Cleaning up... 17:15:34 INFO - Return code: 0 17:15:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x282c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, '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': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', '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 17:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:15:34 INFO - Using env: {'DISPLAY': ':0', 17:15:34 INFO - 'HOME': '/home/cltbld', 17:15:34 INFO - 'LANG': 'en_US.UTF-8', 17:15:34 INFO - 'LANGUAGE': 'en_US:en', 17:15:34 INFO - 'LOGNAME': 'cltbld', 17:15:34 INFO - 'MAIL': '/var/mail/cltbld', 17:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:34 INFO - 'MOZ_NO_REMOTE': '1', 17:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:34 INFO - 'NO_EM_RESTART': '1', 17:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:34 INFO - 'PWD': '/builds/slave/test', 17:15:34 INFO - 'SHELL': '/bin/bash', 17:15:34 INFO - 'SHLVL': '1', 17:15:34 INFO - 'TERM': 'linux', 17:15:34 INFO - 'TMOUT': '86400', 17:15:34 INFO - 'USER': 'cltbld', 17:15:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:34 INFO - '_': '/tools/buildbot/bin/python'} 17:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:34 INFO - Downloading/unpacking jsonschema==2.5.1 17:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:35 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:35 INFO - warning: no files found matching '*.txt' 17:15:35 INFO - no previously-included directories found matching 'build' 17:15:35 INFO - no previously-included directories found matching 'dist' 17:15:35 INFO - no previously-included directories found matching '.git*' 17:15:36 INFO - Installing collected packages: jsonschema, functools32 17:15:36 INFO - Running setup.py install for functools32 17:15:36 INFO - warning: no files found matching '*.txt' 17:15:36 INFO - no previously-included directories found matching 'build' 17:15:36 INFO - no previously-included directories found matching 'dist' 17:15:36 INFO - no previously-included directories found matching '.git*' 17:15:36 INFO - Successfully installed jsonschema functools32 17:15:36 INFO - Cleaning up... 17:15:36 INFO - Return code: 0 17:15:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:36 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 0x282c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, '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': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', '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 17:15:36 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 17:15:36 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 17:15:36 INFO - Using env: {'DISPLAY': ':0', 17:15:36 INFO - 'HOME': '/home/cltbld', 17:15:36 INFO - 'LANG': 'en_US.UTF-8', 17:15:36 INFO - 'LANGUAGE': 'en_US:en', 17:15:36 INFO - 'LOGNAME': 'cltbld', 17:15:36 INFO - 'MAIL': '/var/mail/cltbld', 17:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:36 INFO - 'MOZ_NO_REMOTE': '1', 17:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:36 INFO - 'NO_EM_RESTART': '1', 17:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:36 INFO - 'PWD': '/builds/slave/test', 17:15:36 INFO - 'SHELL': '/bin/bash', 17:15:36 INFO - 'SHLVL': '1', 17:15:36 INFO - 'TERM': 'linux', 17:15:36 INFO - 'TMOUT': '86400', 17:15:36 INFO - 'USER': 'cltbld', 17:15:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:36 INFO - '_': '/tools/buildbot/bin/python'} 17:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:15:36 INFO - Cleaning up... 17:15:36 INFO - Return code: 0 17:15:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:36 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 0x282c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, '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': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', '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 17:15:36 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 17:15:36 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 17:15:36 INFO - Using env: {'DISPLAY': ':0', 17:15:36 INFO - 'HOME': '/home/cltbld', 17:15:36 INFO - 'LANG': 'en_US.UTF-8', 17:15:36 INFO - 'LANGUAGE': 'en_US:en', 17:15:36 INFO - 'LOGNAME': 'cltbld', 17:15:36 INFO - 'MAIL': '/var/mail/cltbld', 17:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:36 INFO - 'MOZ_NO_REMOTE': '1', 17:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:36 INFO - 'NO_EM_RESTART': '1', 17:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:36 INFO - 'PWD': '/builds/slave/test', 17:15:36 INFO - 'SHELL': '/bin/bash', 17:15:36 INFO - 'SHLVL': '1', 17:15:36 INFO - 'TERM': 'linux', 17:15:36 INFO - 'TMOUT': '86400', 17:15:36 INFO - 'USER': 'cltbld', 17:15:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:36 INFO - '_': '/tools/buildbot/bin/python'} 17:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:36 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 17:15:36 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 17:15:36 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 17:15:36 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 17:15:36 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 17:15:36 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 17:15:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15:37 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 17:15:37 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 17:15:37 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 17:15:37 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 17:15:37 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 17:15:37 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 17:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:15:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15:38 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 17:15:38 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 17:15:38 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 17:15:38 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 17:15:38 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 17:15:38 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 17:15:38 INFO - Downloading docopt-0.6.1.tar.gz 17:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:38 INFO - Running setup.py install for blobuploader 17:15:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:15:38 INFO - Running setup.py install for requests 17:15:38 INFO - Running setup.py install for docopt 17:15:38 INFO - Successfully installed blobuploader requests docopt 17:15:38 INFO - Cleaning up... 17:15:38 INFO - Return code: 0 17:15:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:38 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')]} 17:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:38 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')]} 17:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:38 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 0x282c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, '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': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', '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 17:15:38 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 17:15:38 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 17:15:38 INFO - Using env: {'DISPLAY': ':0', 17:15:38 INFO - 'HOME': '/home/cltbld', 17:15:38 INFO - 'LANG': 'en_US.UTF-8', 17:15:38 INFO - 'LANGUAGE': 'en_US:en', 17:15:38 INFO - 'LOGNAME': 'cltbld', 17:15:38 INFO - 'MAIL': '/var/mail/cltbld', 17:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:38 INFO - 'MOZ_NO_REMOTE': '1', 17:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:38 INFO - 'NO_EM_RESTART': '1', 17:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:38 INFO - 'PWD': '/builds/slave/test', 17:15:38 INFO - 'SHELL': '/bin/bash', 17:15:38 INFO - 'SHLVL': '1', 17:15:38 INFO - 'TERM': 'linux', 17:15:38 INFO - 'TMOUT': '86400', 17:15:38 INFO - 'USER': 'cltbld', 17:15:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:38 INFO - '_': '/tools/buildbot/bin/python'} 17:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:39 INFO - Running setup.py (path:/tmp/pip-jsKw57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:39 INFO - Running setup.py (path:/tmp/pip-nv13_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:39 INFO - Running setup.py (path:/tmp/pip-4pvHld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:39 INFO - Running setup.py (path:/tmp/pip-ILWALx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:39 INFO - Running setup.py (path:/tmp/pip-IzyHYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:39 INFO - Running setup.py (path:/tmp/pip-Nr8IEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:39 INFO - Running setup.py (path:/tmp/pip-JqoJU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:39 INFO - Running setup.py (path:/tmp/pip-zhKHLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:39 INFO - Running setup.py (path:/tmp/pip-IlQYYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:39 INFO - Running setup.py (path:/tmp/pip-pBOEo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:39 INFO - Running setup.py (path:/tmp/pip-epJC7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:39 INFO - Running setup.py (path:/tmp/pip-TfclnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:40 INFO - Running setup.py (path:/tmp/pip-4_TrZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:40 INFO - Running setup.py (path:/tmp/pip-TjPyiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:40 INFO - Running setup.py (path:/tmp/pip-UOK0I7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:40 INFO - Running setup.py (path:/tmp/pip-Myhya8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:40 INFO - Running setup.py (path:/tmp/pip-I2KWio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:40 INFO - Running setup.py install for manifestparser 17:15:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:15:40 INFO - Running setup.py install for mozcrash 17:15:40 INFO - Running setup.py install for mozdebug 17:15:40 INFO - Running setup.py install for mozdevice 17:15:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:15:40 INFO - Running setup.py install for mozfile 17:15:40 INFO - Running setup.py install for mozhttpd 17:15:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:15:40 INFO - Running setup.py install for mozinfo 17:15:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Running setup.py install for mozInstall 17:15:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Running setup.py install for mozleak 17:15:41 INFO - Running setup.py install for mozlog 17:15:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Running setup.py install for moznetwork 17:15:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Running setup.py install for mozprocess 17:15:41 INFO - Running setup.py install for mozprofile 17:15:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Running setup.py install for mozrunner 17:15:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:15:41 INFO - Running setup.py install for mozscreenshot 17:15:41 INFO - Running setup.py install for moztest 17:15:42 INFO - Running setup.py install for mozversion 17:15:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:15:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:42 INFO - Cleaning up... 17:15:42 INFO - Return code: 0 17:15:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:42 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 0x282c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, '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': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', '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 17:15:42 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 17:15:42 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 17:15:42 INFO - Using env: {'DISPLAY': ':0', 17:15:42 INFO - 'HOME': '/home/cltbld', 17:15:42 INFO - 'LANG': 'en_US.UTF-8', 17:15:42 INFO - 'LANGUAGE': 'en_US:en', 17:15:42 INFO - 'LOGNAME': 'cltbld', 17:15:42 INFO - 'MAIL': '/var/mail/cltbld', 17:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:42 INFO - 'MOZ_NO_REMOTE': '1', 17:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:42 INFO - 'NO_EM_RESTART': '1', 17:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:42 INFO - 'PWD': '/builds/slave/test', 17:15:42 INFO - 'SHELL': '/bin/bash', 17:15:42 INFO - 'SHLVL': '1', 17:15:42 INFO - 'TERM': 'linux', 17:15:42 INFO - 'TMOUT': '86400', 17:15:42 INFO - 'USER': 'cltbld', 17:15:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:42 INFO - '_': '/tools/buildbot/bin/python'} 17:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:42 INFO - Running setup.py (path:/tmp/pip-193tNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:42 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)) 17:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:42 INFO - Running setup.py (path:/tmp/pip-2RMOtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:42 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)) 17:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:42 INFO - Running setup.py (path:/tmp/pip-aePge0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:42 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)) 17:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:42 INFO - Running setup.py (path:/tmp/pip-KHFnrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:42 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)) 17:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:42 INFO - Running setup.py (path:/tmp/pip-2vyDEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:42 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)) 17:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:42 INFO - Running setup.py (path:/tmp/pip-p8TFWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:42 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)) 17:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:42 INFO - Running setup.py (path:/tmp/pip-E0pjHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:42 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)) 17:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:42 INFO - Running setup.py (path:/tmp/pip-flNN4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:42 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)) 17:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:42 INFO - Running setup.py (path:/tmp/pip-i2tBvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:43 INFO - Running setup.py (path:/tmp/pip-hC5xx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:43 INFO - Running setup.py (path:/tmp/pip-7qf7Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:43 INFO - Running setup.py (path:/tmp/pip-7cVEN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:43 INFO - Running setup.py (path:/tmp/pip-Z8N98z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:43 INFO - Running setup.py (path:/tmp/pip-SRzXOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:43 INFO - Running setup.py (path:/tmp/pip-3qsxv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:43 INFO - Running setup.py (path:/tmp/pip-ikk3Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:43 INFO - Running setup.py (path:/tmp/pip-Enkejv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:43 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)) 17:15:43 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)) 17:15:43 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)) 17:15:43 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)) 17:15:43 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)) 17:15:43 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)) 17:15:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:43 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 17:15:43 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 17:15:43 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 17:15:43 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 17:15:43 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 17:15:43 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 17:15:44 INFO - Downloading blessings-1.6.tar.gz 17:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:44 INFO - Installing collected packages: blessings 17:15:44 INFO - Running setup.py install for blessings 17:15:44 INFO - Successfully installed blessings 17:15:44 INFO - Cleaning up... 17:15:44 INFO - Return code: 0 17:15:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:45 INFO - Reading from file tmpfile_stdout 17:15:45 INFO - Current package versions: 17:15:45 INFO - argparse == 1.2.1 17:15:45 INFO - blessings == 1.6 17:15:45 INFO - blobuploader == 1.2.4 17:15:45 INFO - docopt == 0.6.1 17:15:45 INFO - functools32 == 3.2.3-2 17:15:45 INFO - jsonschema == 2.5.1 17:15:45 INFO - manifestparser == 1.1 17:15:45 INFO - mozInstall == 1.12 17:15:45 INFO - mozcrash == 1.0 17:15:45 INFO - mozdebug == 0.1 17:15:45 INFO - mozdevice == 0.50 17:15:45 INFO - mozfile == 1.2 17:15:45 INFO - mozhttpd == 0.7 17:15:45 INFO - mozinfo == 0.9 17:15:45 INFO - mozleak == 0.1 17:15:45 INFO - mozlog == 3.4 17:15:45 INFO - moznetwork == 0.27 17:15:45 INFO - mozprocess == 0.25 17:15:45 INFO - mozprofile == 0.28 17:15:45 INFO - mozrunner == 6.13 17:15:45 INFO - mozscreenshot == 0.1 17:15:45 INFO - mozsystemmonitor == 0.3 17:15:45 INFO - moztest == 0.8 17:15:45 INFO - mozversion == 1.4 17:15:45 INFO - psutil == 3.1.1 17:15:45 INFO - requests == 1.2.3 17:15:45 INFO - wsgiref == 0.1.2 17:15:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:45 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')]} 17:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:45 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')]} 17:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:45 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 0x282c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, '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': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', '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 17:15:45 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 17:15:45 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 17:15:45 INFO - Using env: {'DISPLAY': ':0', 17:15:45 INFO - 'HOME': '/home/cltbld', 17:15:45 INFO - 'LANG': 'en_US.UTF-8', 17:15:45 INFO - 'LANGUAGE': 'en_US:en', 17:15:45 INFO - 'LOGNAME': 'cltbld', 17:15:45 INFO - 'MAIL': '/var/mail/cltbld', 17:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:45 INFO - 'MOZ_NO_REMOTE': '1', 17:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:45 INFO - 'NO_EM_RESTART': '1', 17:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:45 INFO - 'PWD': '/builds/slave/test', 17:15:45 INFO - 'SHELL': '/bin/bash', 17:15:45 INFO - 'SHLVL': '1', 17:15:45 INFO - 'TERM': 'linux', 17:15:45 INFO - 'TMOUT': '86400', 17:15:45 INFO - 'USER': 'cltbld', 17:15:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:45 INFO - '_': '/tools/buildbot/bin/python'} 17:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:45 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)) 17:15:45 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)) 17:15:45 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)) 17:15:45 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)) 17:15:45 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)) 17:15:45 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)) 17:15:45 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)) 17:15:45 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)) 17:15:45 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)) 17:15:45 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)) 17:15:45 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)) 17:15:45 INFO - Cleaning up... 17:15:45 INFO - Return code: 0 17:15:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:15:45 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')]} 17:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:45 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')]} 17:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:45 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 0x282c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2924a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, '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': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', '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 17:15:45 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 17:15:45 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 17:15:45 INFO - Using env: {'DISPLAY': ':0', 17:15:45 INFO - 'HOME': '/home/cltbld', 17:15:45 INFO - 'LANG': 'en_US.UTF-8', 17:15:45 INFO - 'LANGUAGE': 'en_US:en', 17:15:45 INFO - 'LOGNAME': 'cltbld', 17:15:45 INFO - 'MAIL': '/var/mail/cltbld', 17:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:45 INFO - 'MOZ_NO_REMOTE': '1', 17:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:45 INFO - 'NO_EM_RESTART': '1', 17:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:45 INFO - 'PWD': '/builds/slave/test', 17:15:45 INFO - 'SHELL': '/bin/bash', 17:15:45 INFO - 'SHLVL': '1', 17:15:45 INFO - 'TERM': 'linux', 17:15:45 INFO - 'TMOUT': '86400', 17:15:45 INFO - 'USER': 'cltbld', 17:15:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:45 INFO - '_': '/tools/buildbot/bin/python'} 17:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:15:45 INFO - Cleaning up... 17:15:45 INFO - Return code: 0 17:15:45 INFO - Running post-action listener: _resource_record_post_action 17:15:45 INFO - Running post-action listener: _start_resource_monitoring 17:15:45 INFO - Starting resource monitoring. 17:15:45 INFO - [mozharness: 2017-05-06 00:15:45.672871Z] Finished create-virtualenv step (success) 17:15:45 INFO - [mozharness: 2017-05-06 00:15:45.673447Z] Running install step. 17:15:45 INFO - Running pre-action listener: _resource_record_pre_action 17:15:45 INFO - Running main action method: install 17:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:45 INFO - Reading from file tmpfile_stdout 17:15:45 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:15:45 INFO - Reading from file tmpfile_stdout 17:15:45 INFO - Output received: 17:15:45 INFO - Usage: mozinstall [options] installer 17:15:45 INFO - Options: 17:15:45 INFO - -h, --help show this help message and exit 17:15:45 INFO - -d DEST, --destination=DEST 17:15:45 INFO - Directory to install application into. [default: 17:15:45 INFO - "/builds/slave/test"] 17:15:45 INFO - --app=APP Application being installed. [default: firefox] 17:15:45 INFO - mkdir: /builds/slave/test/build/application 17:15:45 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'] 17:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:16:02 INFO - Reading from file tmpfile_stdout 17:16:02 INFO - Output received: 17:16:02 INFO - /builds/slave/test/build/application/firefox/firefox 17:16:02 INFO - Running post-action listener: _resource_record_post_action 17:16:02 INFO - [mozharness: 2017-05-06 00:16:02.176652Z] Finished install step (success) 17:16:02 INFO - [mozharness: 2017-05-06 00:16:02.176929Z] Running run-tests step. 17:16:02 INFO - Running pre-action listener: _resource_record_pre_action 17:16:02 INFO - Running main action method: run_tests 17:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:02 INFO - Python 2.7.3 17:16:02 INFO - Return code: 0 17:16:02 INFO - grabbing minidump binary from tooltool 17:16:02 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')]} 17:16:02 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 0x2ac7290>, '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 0x2ac7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac8040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:02 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 17:16:02 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 17:16:02 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 17:16:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:02 INFO - Return code: 0 17:16:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:16:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:02 INFO - ENV: RUST_BACKTRACE is now 1 17:16:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:16:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 17:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 17:16:02 INFO - Using env: {'DISPLAY': ':0', 17:16:02 INFO - 'HOME': '/home/cltbld', 17:16:02 INFO - 'LANG': 'en_US.UTF-8', 17:16:02 INFO - 'LANGUAGE': 'en_US:en', 17:16:02 INFO - 'LOGNAME': 'cltbld', 17:16:02 INFO - 'MAIL': '/var/mail/cltbld', 17:16:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:02 INFO - 'MOZ_NO_REMOTE': '1', 17:16:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:02 INFO - 'NO_EM_RESTART': '1', 17:16:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:02 INFO - 'PWD': '/builds/slave/test', 17:16:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:02 INFO - 'RUST_BACKTRACE': '1', 17:16:02 INFO - 'SHELL': '/bin/bash', 17:16:02 INFO - 'SHLVL': '1', 17:16:02 INFO - 'TERM': 'linux', 17:16:02 INFO - 'TMOUT': '86400', 17:16:02 INFO - 'USER': 'cltbld', 17:16:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494029697.307108-771510321', 17:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:02 INFO - '_': '/tools/buildbot/bin/python'} 17:16:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 17:16:02 INFO - mozversion application_buildid: 20170505231114 17:16:02 INFO - mozversion application_changeset: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 17:16:02 INFO - mozversion application_display_name: Nightly 17:16:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:02 INFO - mozversion application_name: Firefox 17:16:02 INFO - mozversion application_remotingname: firefox 17:16:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:16:02 INFO - mozversion application_vendor: Mozilla 17:16:02 INFO - mozversion application_version: 55.0a1 17:16:02 INFO - mozversion platform_buildid: 20170505231114 17:16:02 INFO - mozversion platform_changeset: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 17:16:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:16:02 INFO - mozversion platform_version: 55.0a1 17:16:02 INFO - using testdate: 1494029762 17:16:02 INFO - actual date: 1494029762 17:16:02 INFO - starting webserver on 'localhost:44885' 17:16:02 INFO - SUITE-START | Running 2 tests 17:16:02 INFO - TEST-START | dromaeo_css 17:16:02 INFO - operating with platform_type : linux_ 17:16:02 INFO - Initialising browser for dromaeo_css test... 17:16:02 INFO - TEST-INFO | started process 9031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYtqkWu/profile http://localhost:44885/getInfo.html) 17:16:06 INFO - PID 9031 | __metrics Screen width/height:1600/1200 17:16:06 INFO - PID 9031 | colorDepth:24 17:16:06 INFO - PID 9031 | Browser inner width/height: 1024/695 17:16:06 INFO - PID 9031 | __metrics 17:16:08 INFO - TEST-INFO | 9031: exit 0 17:16:08 INFO - Browser initialized. 17:16:08 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:08 INFO - TEST-INFO | started process 9204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYtqkWu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:20 INFO - PID 9204 | RSS: Main: 156475392 17:16:20 INFO - PID 9204 | 17:19:21 INFO - PID 9204 | Cycle 1(1): loaded http://localhost:44885/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44885/tests/dromaeo/cssquery-ext.html) 17:19:22 INFO - PID 9204 | RSS: Main: 163893248 17:19:22 INFO - PID 9204 | 17:22:24 INFO - PID 9204 | Cycle 1(1): loaded http://localhost:44885/tests/dromaeo/cssquery-ext.html (next: http://localhost:44885/tests/dromaeo/cssquery-jquery.html) 17:22:25 INFO - PID 9204 | RSS: Main: 156590080 17:22:25 INFO - PID 9204 | 17:25:26 INFO - PID 9204 | Cycle 1(1): loaded http://localhost:44885/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44885/tests/dromaeo/cssquery-mootools.html) 17:25:27 INFO - PID 9204 | RSS: Main: 165371904 17:25:27 INFO - PID 9204 | 17:28:29 INFO - PID 9204 | Cycle 1(1): loaded http://localhost:44885/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44885/tests/dromaeo/cssquery-prototype.html) 17:28:29 INFO - PID 9204 | RSS: Main: 157622272 17:28:29 INFO - PID 9204 | 17:31:32 INFO - PID 9204 | Cycle 1(1): loaded http://localhost:44885/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44885/tests/dromaeo/cssquery-yui.html) 17:31:32 INFO - PID 9204 | RSS: Main: 161890304 17:31:32 INFO - PID 9204 | 17:34:34 INFO - PID 9204 | Cycle 1(1): loaded http://localhost:44885/tests/dromaeo/cssquery-yui.html (next: http://localhost:44885/tests/dromaeo/cssquery-dojo.html) 17:34:34 INFO - PID 9204 | RSS: Main: 163205120 17:34:34 INFO - PID 9204 | 17:34:34 INFO - PID 9204 | __start_tp_report 17:34:34 INFO - PID 9204 | _x_x_mozilla_page_load 17:34:34 INFO - PID 9204 | _x_x_mozilla_page_load_details 17:34:34 INFO - PID 9204 | |i|pagename|runs| 17:34:34 INFO - PID 9204 | |0;dojo.html;3388.119089036851;3394.6944774970257;3424.623291437942;3434.038469228617;3440.845161967711;5772.105323674827;5902.409759024095;5926.22959015328;5944.821655350341;5946.137810017545;5861.413858614136;5883.8529036774;5937.079752638338;5953;5955.017422125344;5231.398389185235;5237.947620523793;5243.606729495284;5253.159494480884;5326.280952071479;5263.1578947368425;5333.066713325172;5335.653182543142;5336.786528538853;5337.226102215176;5241.8165364212455;5290.418054014036;5334.439883812182;5369.838904832861;5371.623986320959;5280.155175171954;5290;5295.364556253236;5297.099493086184;5303.973480132613;5243.79024839006;5272;5281.392639846428;5287.735613219362;5295.708736019517;5798.130280457923;5832.912506312408;5887.0580707086665;5966.105084237399;6001.759929602811;6339.96830015847;6352.237731472253;6354.110424540568;6364.077208804743;6369.20384951881;6343.8414039648915;6371.7769878054505;6371.87256254877;6373.139626150457;6397.52018598607;5916.2604674416125;5957.582969192158;5966.671833049137;5968.074948383008;5996.820095397145;6534.411902928759;6541.640209788412;6554.180727409074;6599.901001484982;6601.438877695449;6222.12890195373;6232.937670623326;6250.749970001149;6288.025356069817;6326.051092336186;6458.257300410513;6471.06169605414;6475.384838440341;6478.255000674889;6491.480681545465;6275.246970363494;6299.653519056405;6344.873102538016;6376.681165941684;6457.160569125984;6408.10286559882;6409.583377080475;6463.192100987377;6468.288488266381;6474.093626892239;4943.703377797344;4944.9258261126115;4946.035523073038;4957.529034741694;4973.428055773632;4374.409454723572;4383.101464199832;4392.670549708785;4400.933985990213;4432;6115.666295175977;6123.8162855114415;6153.84615384619;6163.96918015407;6172.938270617326;6452.161219041494;6484.902726459012;6489.156409666807;6494.707738151795;6506.934930650727;6072.362401947732;6086.178365920633;6126.203593532812;6128.509719222451;6167.290761562388;5587.217789509472;5588.580856435784;5660.320761508563;5670.206171136044;5684.374718781013;6691.26396096429;6722.697478613474;6726.831829204309;6738.460923126237;6804.455643548603;6359.395857393541;6428.903566446414;6445.25879523842;6482.611043337415;6490.837729056622;6628.469722422291;6785.762498312535;6798.660066996729;6815.625140617313;6829.795106146625;6238.844028899314;6258;6314.778982735582;6352.0789485525265;6356;6254.124422580751;6498.252700939453;6509.576877502947;6512;6530;6128.564234752123;6148.938510615016;6202;6231.376862313732;6278.434940855345;6252.562320637694;6271.717772700148;6313.810585682437;6314.336994615499;6315;6123.892747182578;6188.947878860695;6251.874962500816;6258.092576576462;6266.060090986389;6302.275238347649;6356.872862542816;6375.203099612549;6379.617222966637;6394.776182833579;6133.3866613338305;6151.138840562236;6176.258848937977;6202.069689546604;6203.875922481616 17:34:34 INFO - PID 9204 | |1;ext.html;737.4395459450816;796.2992566541443;818.3044412249586;1127.7913585986587;1144.4220668562375;36210.27579448409;36478.452823207605;36654.08364790878;37065.44401833971;37075.44386834193;38307.808460957654;38927.80536097322;39142.8042859786;39174.80412597933;39240.80379598105;7127.643617819102;7177.990162754437;7300.269973002711;7445.329920307171;7462;7304.598247096407;7364.374028207609;7388.556686598795;7397.297256760599;7416.480846340758;7370.152432470281;7396.593187374692;7437.925620743805;7479.700811967515;7485.850282994337;7360.447966402515;7365.705371785122;7376.96311518439;7379.3727533159745;7420.3321701046625;7282.417406607458;7316.926830731731;7345.449091318173;7359.926400736032;7393.408527317802;35775;35885.102872428135;36106;36120.27759444823;36137.81931090328;3519.8560467847797;3531.52324436203;3536.929261414783;3547.166415892263;3559.0924314299687;28762.712372876213;29031.564526532118;29062.41875162506;29094.27264318409;29134.41731165386;3704.4072948328408;3717.6654101130757;3719.5536535615897;3731.570869350005;3743.401055831054;197882;200850;211111;215578;217712;46144.3078353825;46344.536554634695;46533.5346646536;46596.3010554842;46661.766691166325;48528.5147148531;48738.26892596614;49094;49422.25866612004;49428.50571494239;14646.853531464549;14650.706985860223;14805.48180813688;14922.104673719612;14959.326830292446;12023.458944347525;12046.879531204575;12214.145009849402;12246.510139594495;12261.509539618493;13872.474027856928;13919.23444210578;14005.369758360897;14134.929325353512;14176.362063707158;5617.269754931833;5783.363829978699;5787;5805.738741756547;5873.001589729756;1084.7179733269406;1121.9607313744143;1134.3760931487814;1136.3977092141179;1139.1570238023803;25988.8700556496;26145.084922027636;26405.471890562465;26443.47113057728;26576.33559160998;1209.3529961470747;1222.2238878312157;1223.4188760338768;1230.3786587773118;1249.9187552809037;13634.863651363557;13812.86187138136;13939.721205575832;13971.650708732363;13976.231307277994;238410;243051;244196;245243;263007;58616.413835861094;58674;58887.70556147192;59058.704706476194;59374.40625593689;1516.8710659593837;1537.9615509612127;1538.100211376335;1540.7457769467912;1551.8758499320027;28897.42205155927;30816.229594260323;30962;31270.53094203543;31297.217569560944;38430.80784596059;38550.807245964716;38622.52397284258;38756.41865372078;38915.6108438912;223465;224873.50252995174;224914;225167;225238;33757.83121084379;35309.29381412409;35610.28779424449;35709.64290357063;35856.4621530672;42487;43945.34081988709;44149;44239.778801105786;44994.3250851244;32632.83683581567;32806.50790238196;32826.50760238646;33887.909834025464;34347.4847877287;33090.50364244587;33367.66632333645;33701.66298336985;34533;34598.65401345954;38035.61964380431;38447.23105537818;38510.6148938507;38573.2285354297;38714.41928371133;30455.543166852956;31040.379192415574;31430.140816937434;31606.103633782048;33134;26905.461890761682;26961.86519067392;27127.86436067886;27151.45697086087;27372.58941115845 17:34:34 INFO - PID 9204 | |2;jquery.html;433.4040694045687;437.2217452933777;446.22357098648354;451.73347724842347;471.76176031104285;19140.138693758778;19874.403767886968;20159.49601259969;20577;20602.89698551507;21629.56740865182;22196.778032219674;22860.199893003748;22870.88564557175;23316.533669326604;5613.101903695399;5778.6243894146955;5801.506871915893;5816.767329306844;5821.621594596359;5419.160030195326;5615.6630602164005;5633.492985631292;5664.26364572605;5675.943240567603;5626.662400255977;5628.577856660746;5636.774529018855;5638.830835074954;5644.8024319148835;5465;5593.356763972155;5637.069883469264;5640.407757185498;5672.17753425753;5036.521530454601;5082.567981721558;5099.643024988252;5117.130087885069;5124.718140502271;25280.367990800194;25350.1127460538;25350.619740703904;25442.618360724606;25650.178480367143;1831.6519861226457;2166.880821554814;2189.9890500547394;2191.244020812817;2201.680756290345;16513.091779952098;16769;16984.49046528606;17951.371701990367;18153.092345382676;2182.7598964113936;2208.1608988584394;2242.349718581626;2261.705978222837;2270.9205177818862;109232;115330;116780.41609791982;116799;116800.41599792031;12067.275963442222;12195.939020304842;12295.56965506203;12653.36733163338;12669.746605067847;17084;17189.82810171907;17256;17269.913650431918;17343.566410839576;8611.48331100136;8862.246709029805;8936.374453788172;8967.237784788365;9025.593848276843;8014;8047.637856296481;8077;8288.046874609376;8371.916280837113;7899;7968.561729104839;7999.36005119589;8030.357571394275;8032.200715127535;2129.8509104362547;2133.7119488869116;2160.6758986152204;2184.1918490158423;2351.577295736089;1004.6634377483479;1066.6053560182781;1070.8661417322835;1072.1208608940594;1086.1419478611808;20847;20918.79081209199;21138.682919756215;21142.894285528473;21409.357719268446;1083.1713738989679;1087.152021423291;1095.758933034747;1098.6978580890159;1099.6261271167841;10679.252452328417;11224.831627525593;11427.714307142389;11492.42537873103;11574.6527604172;495795;496963;500141;500539;503227;88483.1151688475;88678;89488.55255723679;89538.55230723936;89706.55146724224;1237.5421094195206;1242.993785031087;1260.9432575534306;1263.7662032524013;1275.508929062299;17711.46865594034;17889.19498622539;17966.640667186846;17977.370792022215;18536.25854965786;44785;45433.845693929165;45521.317180242986;45870;45875.788694791045;57101.71449142728;57634.423655762905;57691;58226;58492.70753646205;9085.454872707658;9279.67521136757;9400.153986141007;9475.810483790148;9492.477913714813;14186.716265674422;14387.136771793726;14529.78205326942;14757.778633320295;15009.624759381102;11927.821082683593;12296.323702196465;12409.131360804657;12420.503179873065;12650;11566.190366674253;11688.298702077902;11881.524739010343;11889.881101188877;12337.136400451882;13124.475020999053;13178.868211318148;13384.799228011783;13519.594412167651;13585.59243222705;9525.333226674344;9546.85679714791;9601.951990240004;9792.608295668093;10042.246831487522;13151.93424032912;13169.802452963404;13204.735905282032;13359.866401335863;13805.861941380457 17:34:34 INFO - PID 9204 | |3;mootools.html;1403.5929580421678;1460.9050411723238;1461.050317293759;1463.5316698656434;1473.7199932012916;10903.672889813299;11108.500117494712;11284.26652267602;11434.085273178147;11457.197996140274;11250.831237531444;11385.715357116076;11417.486213120408;11467;11475.827862582048;2317.8029867461246;2353.1411034972284;2358.7641235876363;2361.9763802361927;2366.3492539551676;2211.7788221177834;2263.3775711679255;2297.5979203639295;2298.2071185440996;2302.355340504653;2185.0713446785053;2230.208276061999;2240.0815665577115;2243.0242844362756;2250.077468238023;2266.9546609067893;2278.350670059025;2311.0524684879288;2319.826013049028;2325.5581439526436;2229.55408918217;2310.861348319106;2315.4327189838427;2327.5344931013865;2339.2163625185585;11292.20954533183;11305.717357066056;11448.084153267719;11454.969052785289;11474.713132171679;6571.342865713438;6760.628165450898;6813.7955861324235;6819.965900170468;6837.35045170708;3825.2923209206106;4066.5323487798987;4096.078382363974;4116.300228961054;4166.83332666693;1335.9265240411773;1387.5421111033336;1395.5464474045975;1411.5624156511515;1436.2316160853998;17148.657026859517;17413.47759567215;17478.825211747848;17513.912430437893;17517.562060948578;5189.844304670866;5265.368155821249;5568.136938774496;5591.30108736408;5620.662760234399;12186.51253949832;12196.878031219752;12214.57248996281;12230.510779568896;12250.75498490043;6514.348565143448;6518.761435327273;6532.640704761188;6543.574667646588;6558.344165583499;5880.705964701748;6028.336882942873;6159.538034647419;6213.37866213375;6214.564980451415;4221.197972385298;4308.67684923632;4326.502452217972;4400.559944005638;4423.049044455457;1258.993705031469;1262.9494820207271;1269.581038257373;1286.2089814763854;1295.1710905020793;846.2257034813077;869.1569177897429;881.405051590174;888.8755574219614;911.4759013567225;6325.335839736854;6355.777547785805;6363.61818290904;6372.36276372359;7061.082059332357;973.600823662295;1003.117256813999;1007.4156988946394;1011.1657882247175;1015.1726343030555;4126.216018956388;4336.089421221579;4345.087531618332;4347.739135651871;4433.667474939392;14707.92646036763;15495.380184792708;15496.147711875956;15507.457238996807;15536.533903982898;14762.188079655722;14779.556613301618;14936.850631493764;15086.622834429227;15101.39594416233;8974.506402147814;8980;9055.728328150166;9090.681826136053;9098.226650734628;6408.423241908251;6512.772052978123;6520.510961677988;6660.900086498609;6966.3730264276455;13185.80221296662;13376.531821386205;13467.797983030066;13482.662933426744;13713.382897769425;13418.798718019043;13432.597022089352;13503.797443038558;13578.864211358155;13729.176249425067;9416.717498474783;9645.08371704687;9647.469389183661;9690.12788849007;9746.171575415885;10962.725931851768;11039.834402483808;11066.114710822954;11090.611828585961;11091.72270693239;9546.522673866419;9572.808543829224;9593.472359020321;9616.855747163658;9772.9022709772;9231.86152207704;9437.952810235905;9448.669296574586;9510.334276600572;9534.904650953678;7906.446548741533;7958.641861116148;8038.598070096588;8047.879281810895;8055.1542088079905;6122.969385153046;6255.96872015637;6280;6295.5907865988565;6299.338569450142;6267.968660156853;6318.336574659595;6319.557630965788;6329.936700632935;6385.074164246065 17:34:34 INFO - PID 9204 | |4;prototype.html;394.23156480728903;394.5679480968341;412.19827435637677;413.0935731598672;426.2902267724239;5917.9408205917925;6084.361142080084;6209.84475388115;6251.468625166866;6259.530535209855;5965.940340596593;6079;6084.878302433949;6102.481289090421;6113.755449782004;4795.664303498756;4821.2768084787385;4827.082854257697;4832.202686556731;4833.661643684944;4764.880877978061;4773.379460670126;4789.6168306535565;4839.975800120995;4848.806047758086;4793.544613261734;4803.5676789088975;4812.278158276252;4819.349387832633;4826.276058591205;4780.80876764929;4818.34952281441;4826.0830442215865;4840.782164802592;4863.2461968394955;3786;3879.3792993120965;3892.649661530476;3910.335243008695;3911.6283953024417;5892.587518873681;5906.173135760997;5914.526837852962;5915.31413547137;5954.345022047572;5218.086834803932;5285.810692594174;5322.0952438085615;5322.680639161663;5327.760250788724;6421.293657697696;6456.870047741673;6461.870762584769;6470.870582588322;6473.773417930397;4458.086092351093;4477.48508921475;4481.462224533045;4481.843135490242;4481.865544033684;6657.600543967329;6786.151731033621;6843.692033858439;6851.520393572402;6864.528769642925;4548.636109111263;4550.453945526558;4551.886202844889;4558.658100642465;4563.475200351935;4597.379353787196;4597.931031034537;4612.723236605814;4619.653525985497;4619.815207391734;5287.788488460418;5351.892962140735;5383.192521121863;5383.43473935239;5408.432114627907;6297.338779428185;6456.903146452713;6548.476121910236;6551.80344589663;6560.934390656128;1568.9607759806097;1574.3151728997693;1575.4092215419219;1588.2614584218393;1598.9280482378322;1029.3355751278064;1044.1125043712934;1063.7340664833791;1064.99467502662;1066.9786604267872;6268.373162683695;6314.242290925118;6323.628639260278;6342.143810585604;6351.460125889259;6732.562383445061;6763.2898545652;6769.559978601375;6800.387965083166;6805.897911531331;6101.603395779349;6271.592346497554;6333.809985700436;6337.637407957312;6342.651154186472;3521.207728261121;3529.4705794130573;3536.8938931832085;3548.1129717570607;3555.6266592007983;6862.49025214452;6955.860882782417;6970.965145174242;7008.369246767816;7036.788896333118;6840.828979275459;6859.5541289816;6882.827929301708;6885.758998435031;6889.448844092461;6754.425873800684;6967.407770339477;7025.578465292099;7032.26161253061;7057.364837164782;6755.716413881347;6762.222344430454;6766.695498702668;6776.356246156607;6807.183138023469;6559.8032059038305;6667.566608170453;6681.866362672622;6682.565633233824;6711.496637752286;6972.163340398982;7012.368886800213;7028.613426261605;7031.824204394931;7061.258567850302;4388.429504164438;4424.469063712375;4472.1502914446155;4472.702916154279;4490.955090449053;6586.934130658632;6759.155105611799;6768.729250830109;6777.830554236183;6792.252852186354;6477.8704425912165;6535.869282614416;6552.6068435894;6556.803295901131;6585.407313341822;6495.902561461677;6539.640319782267;6549.70526326326;6558.901616475852;6575.605463672004;6515.315891831289;6534.640594767334;6546.869062618816;6590.5716128451495;6603.306652801579;6477.1579694639395;6514.478841692748;6540.8364790880605;6551.377619126175;6635.63504007265;6328.841778955379;6346.683460536963;6351.047342898602;6393.776217832354;6421.93578064232 17:34:34 INFO - PID 9204 | |5;yui.html;868.400803445622;891.5542228885557;898.3486971945345;899.2491269789725;914.3371055984412;16385.60722338601;17297.913510432445;17311.307547698092;17658.911705441456;18020;18716.157772900217;18945.431637050875;19134.330298439556;19647.115879785408;20022.399328020147;996.292632231115;1030.7062487191151;1030.7320096774818;1030.9329893556894;1033.7880734449457;1031.2008193649906;1035.5236591168073;1042.4006196437042;1042.9791404171913;1045.8692663417073;1097.1825989637732;1099.3623698255033;1103.194667892439;1104.6023431564631;1106.8173751331021;1081.729567608098;1083.5286650307141;1094.8303013032953;1098.730810951318;1099.8460215569826;768.8270139218687;772.7488566215947;776.4719990406521;776.5301992294637;779.1974266505508;16359.672806543922;16611.50165495037;16637.66724665512;16649.33402663892;16668.74996875048;17112.91443542774;17172.570685732833;17466.912665436717;17478.650426991517;17572.91213543937;14221.004529682927;14404.423823047066;14452.638684032983;14478.276086195649;14490.42038318466;3434.742394320436;3451.4822776583464;3481.9129521761906;3487.110786749363;3495.8426870790877;88639.11360886373;94625.52687236588;95056;95557;95680.52159739226;14839.629009274639;15344;15395.846041539442;15413.152276624893;15434.614134646723;27226.455470890472;27795.74919128644;28414.85792571024;28585;28658;8605.225529702231;8727.738167854974;8736.344774141837;8758.693445729368;8774.51740154285;4134.813933373005;4205.91588168241;4214.852480163179;4216.494020717533;4217.704760666724;4641.976790116096;4767.69010014348;4799.712017278975;4806.50998190555;4816.157172494799;928.076563818991;932.2635118256637;940.3558562384789;947.9241660667268;950.695777351241;735.6064505489644;744.8026273037649;751.6955632968657;758.9013428254402;776.6543887969799;11884.346360950058;12629.494820207272;13261;13567.389467473988;13578.32108394596;727.4580437574041;752.5860776572863;758.4842307231025;758.525921299188;763.9885401718979;5473.534749546254;5527.972360138254;5759.596828221985;5816.389279125631;5899.528037756969;85050.57474712587;87667;87929;88237;88852;78708.37436946054;79067.60466197632;79135.60432197918;81033.18966810375;83513.58243208866;61092.38907610867;62369.45120762345;63102;64019;67517;11824.467898944396;13067.869321306665;13122;13135.34323283813;13175.934120329337;34095;34329.82835085908;34371.65628343785;34633.480497793054;34715.30569388648;41489.792551037055;41596.58403416048;41638.791806040776;42028;58516.4148358528;15551.222438878238;15755.606109847346;15814.367425302858;16913.577160570592;17336.219870105622;17571.648567028333;17809.198586063398;18173.45479635613;18185.545361366072;19324.32364867223;17658.117094144985;17802.287908483515;17850.39346458825;18001.369952051617;18590;17591.29634814593;17745.024023678823;17749.467515974542;17769.378071767427;17868.106594670473;17266.482005539852;17569.560760980567;18040.909795451465;18087.276508939496;18546.536336591693;11907.106966977684;11940.641780746591;12017;12235.69410764738;12263.877361226274;12642.367881606067;12847.871521285042;13634.1137826041;13925.164490130624;13929.791053134008 17:34:34 INFO - PID 9204 | __end_tp_report 17:34:34 INFO - PID 9204 | __start_cc_report 17:34:34 INFO - PID 9204 | _x_x_mozilla_cycle_collect,319 17:34:34 INFO - PID 9204 | __end_cc_report 17:34:34 INFO - PID 9204 | __startTimestamp1494030874788__endTimestamp 17:34:34 INFO - PID 9204 | 17:34:34 INFO - PID 9204 | ------- Summary: start ------- 17:34:34 INFO - PID 9204 | Number of tests: 6 17:34:34 INFO - PID 9204 | 17:34:34 INFO - PID 9204 | [#0] dojo.html Cycles:165 Average:5941.95 Median:6202.00 stddev:706.85 (11.4%) stddev-sans-first:680.03 17:34:34 INFO - PID 9204 | Values: 3388.1 3394.7 3424.6 3434.0 3440.8 5772.1 5902.4 5926.2 5944.8 5946.1 5861.4 5883.9 5937.1 5953.0 5955.0 5231.4 5237.9 5243.6 5253.2 5326.3 5263.2 5333.1 5335.7 5336.8 5337.2 5241.8 5290.4 5334.4 5369.8 5371.6 5280.2 5290.0 5295.4 5297.1 5304.0 5243.8 5272.0 5281.4 5287.7 5295.7 5798.1 5832.9 5887.1 5966.1 6001.8 6340.0 6352.2 6354.1 6364.1 6369.2 6343.8 6371.8 6371.9 6373.1 6397.5 5916.3 5957.6 5966.7 5968.1 5996.8 6534.4 6541.6 6554.2 6599.9 6601.4 6222.1 6232.9 6250.7 6288.0 6326.1 6458.3 6471.1 6475.4 6478.3 6491.5 6275.2 6299.7 6344.9 6376.7 6457.2 6408.1 6409.6 6463.2 6468.3 6474.1 4943.7 4944.9 4946.0 4957.5 4973.4 4374.4 4383.1 4392.7 4400.9 4432.0 6115.7 6123.8 6153.8 6164.0 6172.9 6452.2 6484.9 6489.2 6494.7 6506.9 6072.4 6086.2 6126.2 6128.5 6167.3 5587.2 5588.6 5660.3 5670.2 5684.4 6691.3 6722.7 6726.8 6738.5 6804.5 6359.4 6428.9 6445.3 6482.6 6490.8 6628.5 6785.8 6798.7 6815.6 6829.8 6238.8 6258.0 6314.8 6352.1 6356.0 6254.1 6498.3 6509.6 6512.0 6530.0 6128.6 6148.9 6202.0 6231.4 6278.4 6252.6 6271.7 6313.8 6314.3 6315.0 6123.9 6188.9 6251.9 6258.1 6266.1 6302.3 6356.9 6375.2 6379.6 6394.8 6133.4 6151.1 6176.3 6202.1 6203.9 17:34:34 INFO - PID 9204 | 17:34:34 INFO - PID 9204 | [#1] ext.html Cycles:180 Average:39551.11 Median:3534.23 stddev:59007.04 (1669.6%) stddev-sans-first:59100.60 17:34:34 INFO - PID 9204 | Values: 737.4 796.3 818.3 1127.8 1144.4 36210.3 36478.5 36654.1 37065.4 37075.4 38307.8 38927.8 39142.8 39174.8 39240.8 7127.6 7178.0 7300.3 7445.3 7462.0 7304.6 7364.4 7388.6 7397.3 7416.5 7370.2 7396.6 7437.9 7479.7 7485.9 7360.4 7365.7 7377.0 7379.4 7420.3 7282.4 7316.9 7345.4 7359.9 7393.4 35775.0 35885.1 36106.0 36120.3 36137.8 3519.9 3531.5 3536.9 3547.2 3559.1 28762.7 29031.6 29062.4 29094.3 29134.4 3704.4 3717.7 3719.6 3731.6 3743.4 197882.0 200850.0 211111.0 215578.0 217712.0 46144.3 46344.5 46533.5 46596.3 46661.8 48528.5 48738.3 49094.0 49422.3 49428.5 14646.9 14650.7 14805.5 14922.1 14959.3 12023.5 12046.9 12214.1 12246.5 12261.5 13872.5 13919.2 14005.4 14134.9 14176.4 5617.3 5783.4 5787.0 5805.7 5873.0 1084.7 1122.0 1134.4 1136.4 1139.2 25988.9 26145.1 26405.5 26443.5 26576.3 1209.4 1222.2 1223.4 1230.4 1249.9 13634.9 13812.9 13939.7 13971.7 13976.2 238410.0 243051.0 244196.0 245243.0 263007.0 58616.4 58674.0 58887.7 59058.7 59374.4 1516.9 1538.0 1538.1 1540.7 1551.9 28897.4 30816.2 30962.0 31270.5 31297.2 38430.8 38550.8 38622.5 38756.4 38915.6 223465.0 224873.5 224914.0 225167.0 225238.0 33757.8 35309.3 35610.3 35709.6 35856.5 42487.0 43945.3 44149.0 44239.8 44994.3 32632.8 32806.5 32826.5 33887.9 34347.5 33090.5 33367.7 33701.7 34533.0 34598.7 38035.6 38447.2 38510.6 38573.2 38714.4 30455.5 31040.4 31430.1 31606.1 33134.0 26905.5 26961.9 27127.9 27151.5 27372.6 17:34:34 INFO - PID 9204 | 17:34:34 INFO - PID 9204 | [#2] jquery.html Cycles:180 Average:31105.79 Median:2196.46 stddev:82850.19 (3772.0%) stddev-sans-first:83050.60 17:34:34 INFO - PID 9204 | Values: 433.4 437.2 446.2 451.7 471.8 19140.1 19874.4 20159.5 20577.0 20602.9 21629.6 22196.8 22860.2 22870.9 23316.5 5613.1 5778.6 5801.5 5816.8 5821.6 5419.2 5615.7 5633.5 5664.3 5675.9 5626.7 5628.6 5636.8 5638.8 5644.8 5465.0 5593.4 5637.1 5640.4 5672.2 5036.5 5082.6 5099.6 5117.1 5124.7 25280.4 25350.1 25350.6 25442.6 25650.2 1831.7 2166.9 2190.0 2191.2 2201.7 16513.1 16769.0 16984.5 17951.4 18153.1 2182.8 2208.2 2242.3 2261.7 2270.9 109232.0 115330.0 116780.4 116799.0 116800.4 12067.3 12195.9 12295.6 12653.4 12669.7 17084.0 17189.8 17256.0 17269.9 17343.6 8611.5 8862.2 8936.4 8967.2 9025.6 8014.0 8047.6 8077.0 8288.0 8371.9 7899.0 7968.6 7999.4 8030.4 8032.2 2129.9 2133.7 2160.7 2184.2 2351.6 1004.7 1066.6 1070.9 1072.1 1086.1 20847.0 20918.8 21138.7 21142.9 21409.4 1083.2 1087.2 1095.8 1098.7 1099.6 10679.3 11224.8 11427.7 11492.4 11574.7 495795.0 496963.0 500141.0 500539.0 503227.0 88483.1 88678.0 89488.6 89538.6 89706.6 1237.5 1243.0 1260.9 1263.8 1275.5 17711.5 17889.2 17966.6 17977.4 18536.3 44785.0 45433.8 45521.3 45870.0 45875.8 57101.7 57634.4 57691.0 58226.0 58492.7 9085.5 9279.7 9400.2 9475.8 9492.5 14186.7 14387.1 14529.8 14757.8 15009.6 11927.8 12296.3 12409.1 12420.5 12650.0 11566.2 11688.3 11881.5 11889.9 12337.1 13124.5 13178.9 13384.8 13519.6 13585.6 9525.3 9546.9 9602.0 9792.6 10042.2 13151.9 13169.8 13204.7 13359.9 13805.9 17:34:34 INFO - PID 9204 | 17:34:34 INFO - PID 9204 | [#3] mootools.html Cycles:180 Average:7177.55 Median:2355.95 stddev:4598.15 (195.2%) stddev-sans-first:4590.58 17:34:34 INFO - PID 9204 | Values: 1403.6 1460.9 1461.1 1463.5 1473.7 10903.7 11108.5 11284.3 11434.1 11457.2 11250.8 11385.7 11417.5 11467.0 11475.8 2317.8 2353.1 2358.8 2362.0 2366.3 2211.8 2263.4 2297.6 2298.2 2302.4 2185.1 2230.2 2240.1 2243.0 2250.1 2267.0 2278.4 2311.1 2319.8 2325.6 2229.6 2310.9 2315.4 2327.5 2339.2 11292.2 11305.7 11448.1 11455.0 11474.7 6571.3 6760.6 6813.8 6820.0 6837.4 3825.3 4066.5 4096.1 4116.3 4166.8 1335.9 1387.5 1395.5 1411.6 1436.2 17148.7 17413.5 17478.8 17513.9 17517.6 5189.8 5265.4 5568.1 5591.3 5620.7 12186.5 12196.9 12214.6 12230.5 12250.8 6514.3 6518.8 6532.6 6543.6 6558.3 5880.7 6028.3 6159.5 6213.4 6214.6 4221.2 4308.7 4326.5 4400.6 4423.0 1259.0 1262.9 1269.6 1286.2 1295.2 846.2 869.2 881.4 888.9 911.5 6325.3 6355.8 6363.6 6372.4 7061.1 973.6 1003.1 1007.4 1011.2 1015.2 4126.2 4336.1 4345.1 4347.7 4433.7 14707.9 15495.4 15496.1 15507.5 15536.5 14762.2 14779.6 14936.9 15086.6 15101.4 8974.5 8980.0 9055.7 9090.7 9098.2 6408.4 6512.8 6520.5 6660.9 6966.4 13185.8 13376.5 13467.8 13482.7 13713.4 13418.8 13432.6 13503.8 13578.9 13729.2 9416.7 9645.1 9647.5 9690.1 9746.2 10962.7 11039.8 11066.1 11090.6 11091.7 9546.5 9572.8 9593.5 9616.9 9772.9 9231.9 9438.0 9448.7 9510.3 9534.9 7906.4 7958.6 8038.6 8047.9 8055.2 6123.0 6256.0 6280.0 6295.6 6299.3 6268.0 6318.3 6319.6 6329.9 6385.1 17:34:34 INFO - PID 9204 | 17:34:34 INFO - PID 9204 | [#4] prototype.html Cycles:180 Average:5451.82 Median:6263.95 stddev:1661.63 (26.5%) stddev-sans-first:1622.35 17:34:34 INFO - PID 9204 | Values: 394.2 394.6 412.2 413.1 426.3 5917.9 6084.4 6209.8 6251.5 6259.5 5965.9 6079.0 6084.9 6102.5 6113.8 4795.7 4821.3 4827.1 4832.2 4833.7 4764.9 4773.4 4789.6 4840.0 4848.8 4793.5 4803.6 4812.3 4819.3 4826.3 4780.8 4818.3 4826.1 4840.8 4863.2 3786.0 3879.4 3892.6 3910.3 3911.6 5892.6 5906.2 5914.5 5915.3 5954.3 5218.1 5285.8 5322.1 5322.7 5327.8 6421.3 6456.9 6461.9 6470.9 6473.8 4458.1 4477.5 4481.5 4481.8 4481.9 6657.6 6786.2 6843.7 6851.5 6864.5 4548.6 4550.5 4551.9 4558.7 4563.5 4597.4 4597.9 4612.7 4619.7 4619.8 5287.8 5351.9 5383.2 5383.4 5408.4 6297.3 6456.9 6548.5 6551.8 6560.9 1569.0 1574.3 1575.4 1588.3 1598.9 1029.3 1044.1 1063.7 1065.0 1067.0 6268.4 6314.2 6323.6 6342.1 6351.5 6732.6 6763.3 6769.6 6800.4 6805.9 6101.6 6271.6 6333.8 6337.6 6342.7 3521.2 3529.5 3536.9 3548.1 3555.6 6862.5 6955.9 6971.0 7008.4 7036.8 6840.8 6859.6 6882.8 6885.8 6889.4 6754.4 6967.4 7025.6 7032.3 7057.4 6755.7 6762.2 6766.7 6776.4 6807.2 6559.8 6667.6 6681.9 6682.6 6711.5 6972.2 7012.4 7028.6 7031.8 7061.3 4388.4 4424.5 4472.2 4472.7 4491.0 6586.9 6759.2 6768.7 6777.8 6792.3 6477.9 6535.9 6552.6 6556.8 6585.4 6495.9 6539.6 6549.7 6558.9 6575.6 6515.3 6534.6 6546.9 6590.6 6603.3 6477.2 6514.5 6540.8 6551.4 6635.6 6328.8 6346.7 6351.0 6393.8 6421.9 17:34:34 INFO - PID 9204 | 17:34:34 INFO - PID 9204 | [#5] yui.html Cycles:180 Average:19664.27 Median:19229.33 stddev:24336.74 (126.6%) stddev-sans-first:24364.08 17:34:34 INFO - PID 9204 | Values: 868.4 891.6 898.3 899.2 914.3 16385.6 17297.9 17311.3 17658.9 18020.0 18716.2 18945.4 19134.3 19647.1 20022.4 996.3 1030.7 1030.7 1030.9 1033.8 1031.2 1035.5 1042.4 1043.0 1045.9 1097.2 1099.4 1103.2 1104.6 1106.8 1081.7 1083.5 1094.8 1098.7 1099.8 768.8 772.7 776.5 776.5 779.2 16359.7 16611.5 16637.7 16649.3 16668.7 17112.9 17172.6 17466.9 17478.7 17572.9 14221.0 14404.4 14452.6 14478.3 14490.4 3434.7 3451.5 3481.9 3487.1 3495.8 88639.1 94625.5 95056.0 95557.0 95680.5 14839.6 15344.0 15395.8 15413.2 15434.6 27226.5 27795.7 28414.9 28585.0 28658.0 8605.2 8727.7 8736.3 8758.7 8774.5 4134.8 4205.9 4214.9 4216.5 4217.7 4642.0 4767.7 4799.7 4806.5 4816.2 928.1 932.3 940.4 947.9 950.7 735.6 744.8 751.7 758.9 776.7 11884.3 12629.5 13261.0 13567.4 13578.3 727.5 752.6 758.5 758.5 764.0 5473.5 5528.0 5759.6 5816.4 5899.5 85050.6 87667.0 87929.0 88237.0 88852.0 78708.4 79067.6 79135.6 81033.2 83513.6 61092.4 62369.5 63102.0 64019.0 67517.0 11824.5 13067.9 13122.0 13135.3 13175.9 34095.0 34329.8 34371.7 34633.5 34715.3 41489.8 41596.6 41638.8 42028.0 58516.4 15551.2 15755.6 15814.4 16913.6 17336.2 17571.6 17809.2 18173.5 18185.5 19324.3 17658.1 17802.3 17850.4 18001.4 18590.0 17591.3 17745.0 17749.5 17769.4 17868.1 17266.5 17569.6 18040.9 18087.3 18546.5 11907.1 11940.6 12017.0 12235.7 12263.9 12642.4 12847.9 13634.1 13925.2 13929.8 17:34:34 INFO - PID 9204 | -------- Summary: end -------- 17:34:34 INFO - PID 9204 | 17:34:35 INFO - TEST-INFO | 9204: exit 0 17:34:35 INFO - TEST-OK | dromaeo_css | took 1113064ms 17:34:35 INFO - TEST-START | kraken 17:34:35 INFO - operating with platform_type : linux_ 17:34:35 INFO - Initialising browser for kraken test... 17:34:35 INFO - TEST-INFO | started process 9630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYFIzOH/profile http://localhost:44885/getInfo.html) 17:34:39 INFO - PID 9630 | __metrics Screen width/height:1600/1200 17:34:39 INFO - PID 9630 | colorDepth:24 17:34:39 INFO - PID 9630 | Browser inner width/height: 1024/695 17:34:39 INFO - PID 9630 | __metrics 17:34:41 INFO - TEST-INFO | 9630: exit 0 17:34:41 INFO - Browser initialized. 17:34:41 INFO - Running cycle 1/1 for kraken test... 17:34:41 INFO - TEST-INFO | started process 9808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYFIzOH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:53 INFO - PID 9808 | RSS: Main: 156286976 17:34:53 INFO - PID 9808 | 17:34:55 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44885/tests/kraken/driver.html?testName=audio-beat-detection) 17:34:56 INFO - PID 9808 | RSS: Main: 162750464 17:34:56 INFO - PID 9808 | 17:34:59 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44885/tests/kraken/driver.html?testName=audio-dft) 17:34:59 INFO - PID 9808 | RSS: Main: 161132544 17:34:59 INFO - PID 9808 | 17:35:02 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44885/tests/kraken/driver.html?testName=audio-fft) 17:35:03 INFO - PID 9808 | RSS: Main: 157483008 17:35:03 INFO - PID 9808 | 17:35:05 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44885/tests/kraken/driver.html?testName=audio-oscillator) 17:35:05 INFO - PID 9808 | RSS: Main: 158613504 17:35:05 INFO - PID 9808 | 17:35:08 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44885/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:08 INFO - PID 9808 | RSS: Main: 158679040 17:35:08 INFO - PID 9808 | 17:35:11 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44885/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:12 INFO - PID 9808 | RSS: Main: 163848192 17:35:12 INFO - PID 9808 | 17:35:15 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44885/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:16 INFO - PID 9808 | RSS: Main: 166756352 17:35:16 INFO - PID 9808 | 17:35:19 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44885/tests/kraken/driver.html?testName=json-parse-financial) 17:35:19 INFO - PID 9808 | RSS: Main: 165785600 17:35:19 INFO - PID 9808 | 17:35:21 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44885/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:21 INFO - PID 9808 | RSS: Main: 165703680 17:35:21 INFO - PID 9808 | 17:35:23 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44885/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:24 INFO - PID 9808 | RSS: Main: 166268928 17:35:24 INFO - PID 9808 | 17:35:26 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44885/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:26 INFO - PID 9808 | RSS: Main: 166203392 17:35:26 INFO - PID 9808 | 17:35:29 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:30 INFO - PID 9808 | RSS: Main: 165482496 17:35:30 INFO - PID 9808 | 17:35:32 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:33 INFO - PID 9808 | RSS: Main: 166047744 17:35:33 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | Cycle 1(1): loaded http://localhost:44885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44885/tests/kraken/driver.html?testName=ai-astar) 17:35:35 INFO - PID 9808 | RSS: Main: 168120320 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | __start_tp_report 17:35:35 INFO - PID 9808 | _x_x_mozilla_page_load 17:35:35 INFO - PID 9808 | _x_x_mozilla_page_load_details 17:35:35 INFO - PID 9808 | |i|pagename|runs| 17:35:35 INFO - PID 9808 | |0;ai-astar;103;111;110;110;110;111;111;110;110;110 17:35:35 INFO - PID 9808 | |1;audio-beat-detection;144;122;120;173;122;119;119;119;142;119 17:35:35 INFO - PID 9808 | |2;audio-dft;163;165;164;162;163;162;167;169;166;168 17:35:35 INFO - PID 9808 | |3;audio-fft;75;76;74;95;75;76;74;74;92;74 17:35:35 INFO - PID 9808 | |4;audio-oscillator;81;84;97;82;82;83;95;82;81;106 17:35:35 INFO - PID 9808 | |5;imaging-gaussian-blur;113;117;114;114;114;114;114;114;115;114 17:35:35 INFO - PID 9808 | |6;imaging-darkroom;149;148;149;148;149;150;148;149;148;148 17:35:35 INFO - PID 9808 | |7;imaging-desaturate;94;94;95;94;94;95;95;95;95;95 17:35:35 INFO - PID 9808 | |8;json-parse-financial;47;45;45;46;46;47;45;46;45;45 17:35:35 INFO - PID 9808 | |9;json-stringify-tinderbox;55;55;54;55;54;55;55;54;54;54 17:35:35 INFO - PID 9808 | |10;stanford-crypto-aes;80;81;81;81;81;81;81;81;83;82 17:35:35 INFO - PID 9808 | |11;stanford-crypto-ccm;128;126;138;126;126;132;130;137;173;125 17:35:35 INFO - PID 9808 | |12;stanford-crypto-pbkdf2;179;192;195;179;180;181;186;181;180;184 17:35:35 INFO - PID 9808 | |13;stanford-crypto-sha256-iterative;67;69;64;64;70;64;66;63;62;64 17:35:35 INFO - PID 9808 | __end_tp_report 17:35:35 INFO - PID 9808 | __start_cc_report 17:35:35 INFO - PID 9808 | _x_x_mozilla_cycle_collect,744 17:35:35 INFO - PID 9808 | __end_cc_report 17:35:35 INFO - PID 9808 | __startTimestamp1494030935537__endTimestamp 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | ------- Summary: start ------- 17:35:35 INFO - PID 9808 | Number of tests: 14 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.37 (2.2%) stddev-sans-first:0.50 17:35:35 INFO - PID 9808 | Values: 103.0 111.0 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:122.00 stddev:17.95 (14.7%) stddev-sans-first:18.30 17:35:35 INFO - PID 9808 | Values: 144.0 122.0 120.0 173.0 122.0 119.0 119.0 119.0 142.0 119.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.50 stddev:2.51 (1.5%) stddev-sans-first:2.57 17:35:35 INFO - PID 9808 | Values: 163.0 165.0 164.0 162.0 163.0 162.0 167.0 169.0 166.0 168.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#3] audio-fft Cycles:10 Average:78.50 Median:75.50 stddev:7.98 (10.6%) stddev-sans-first:8.36 17:35:35 INFO - PID 9808 | Values: 75.0 76.0 74.0 95.0 75.0 76.0 74.0 74.0 92.0 74.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:82.50 stddev:8.79 (10.7%) stddev-sans-first:9.03 17:35:35 INFO - PID 9808 | Values: 81.0 84.0 97.0 82.0 82.0 83.0 95.0 82.0 81.0 106.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.06 (0.9%) stddev-sans-first:1.01 17:35:35 INFO - PID 9808 | Values: 113.0 117.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:35:35 INFO - PID 9808 | Values: 149.0 148.0 149.0 148.0 149.0 150.0 148.0 149.0 148.0 148.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:35:35 INFO - PID 9808 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#8] json-parse-financial Cycles:10 Average:45.70 Median:46.00 stddev:0.82 (1.8%) stddev-sans-first:0.73 17:35:35 INFO - PID 9808 | Values: 47.0 45.0 45.0 46.0 46.0 47.0 45.0 46.0 45.0 45.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:55.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 17:35:35 INFO - PID 9808 | Values: 55.0 55.0 54.0 55.0 54.0 55.0 55.0 54.0 54.0 54.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:0.79 (1.0%) stddev-sans-first:0.71 17:35:35 INFO - PID 9808 | Values: 80.0 81.0 81.0 81.0 81.0 81.0 81.0 81.0 83.0 82.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:131.00 stddev:14.43 (11.0%) stddev-sans-first:15.14 17:35:35 INFO - PID 9808 | Values: 128.0 126.0 138.0 126.0 126.0 132.0 130.0 137.0 173.0 125.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.70 Median:182.50 stddev:5.66 (3.1%) stddev-sans-first:5.74 17:35:35 INFO - PID 9808 | Values: 179.0 192.0 195.0 179.0 180.0 181.0 186.0 181.0 180.0 184.0 17:35:35 INFO - PID 9808 | 17:35:35 INFO - PID 9808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.63 (4.0%) stddev-sans-first:2.71 17:35:35 INFO - PID 9808 | Values: 67.0 69.0 64.0 64.0 70.0 64.0 66.0 63.0 62.0 64.0 17:35:35 INFO - PID 9808 | -------- Summary: end -------- 17:35:35 INFO - PID 9808 | 17:35:36 INFO - TEST-INFO | 9808: exit 0 17:35:36 INFO - TEST-OK | kraken | took 61182ms 17:35:36 INFO - SUITE-END | took 1174s 17:35:37 INFO - Completed test suite (00:19:34) 17:35:37 INFO - javascript benchmark 17:35:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7860.997705472967, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3388.119089036851, 3394.6944774970257, 3424.623291437942, 3434.038469228617, 3440.845161967711, 5772.105323674827, 5902.409759024095, 5926.22959015328, 5944.821655350341, 5946.137810017545, 5861.413858614136, 5883.8529036774, 5937.079752638338, 5953.0, 5955.017422125344, 5231.398389185235, 5237.947620523793, 5243.606729495284, 5253.159494480884, 5326.280952071479, 5263.1578947368425, 5333.066713325172, 5335.653182543142, 5336.786528538853, 5337.226102215176, 5241.8165364212455, 5290.418054014036, 5334.439883812182, 5369.838904832861, 5371.623986320959, 5280.155175171954, 5290.0, 5295.364556253236, 5297.099493086184, 5303.973480132613, 5243.79024839006, 5272.0, 5281.392639846428, 5287.735613219362, 5295.708736019517, 5798.130280457923, 5832.912506312408, 5887.0580707086665, 5966.105084237399, 6001.759929602811, 6339.96830015847, 6352.237731472253, 6354.110424540568, 6364.077208804743, 6369.20384951881, 6343.8414039648915, 6371.7769878054505, 6371.87256254877, 6373.139626150457, 6397.52018598607, 5916.2604674416125, 5957.582969192158, 5966.671833049137, 5968.074948383008, 5996.820095397145, 6534.411902928759, 6541.640209788412, 6554.180727409074, 6599.901001484982, 6601.438877695449, 6222.12890195373, 6232.937670623326, 6250.749970001149, 6288.025356069817, 6326.051092336186, 6458.257300410513, 6471.06169605414, 6475.384838440341, 6478.255000674889, 6491.480681545465, 6275.246970363494, 6299.653519056405, 6344.873102538016, 6376.681165941684, 6457.160569125984, 6408.10286559882, 6409.583377080475, 6463.192100987377, 6468.288488266381, 6474.093626892239, 4943.703377797344, 4944.9258261126115, 4946.035523073038, 4957.529034741694, 4973.428055773632, 4374.409454723572, 4383.101464199832, 4392.670549708785, 4400.933985990213, 4432.0, 6115.666295175977, 6123.8162855114415, 6153.84615384619, 6163.96918015407, 6172.938270617326, 6452.161219041494, 6484.902726459012, 6489.156409666807, 6494.707738151795, 6506.934930650727, 6072.362401947732, 6086.178365920633, 6126.203593532812, 6128.509719222451, 6167.290761562388, 5587.217789509472, 5588.580856435784, 5660.320761508563, 5670.206171136044, 5684.374718781013, 6691.26396096429, 6722.697478613474, 6726.831829204309, 6738.460923126237, 6804.455643548603, 6359.395857393541, 6428.903566446414, 6445.25879523842, 6482.611043337415, 6490.837729056622, 6628.469722422291, 6785.762498312535, 6798.660066996729, 6815.625140617313, 6829.795106146625, 6238.844028899314, 6258.0, 6314.778982735582, 6352.0789485525265, 6356.0, 6254.124422580751, 6498.252700939453, 6509.576877502947, 6512.0, 6530.0, 6128.564234752123, 6148.938510615016, 6202.0, 6231.376862313732, 6278.434940855345, 6252.562320637694, 6271.717772700148, 6313.810585682437, 6314.336994615499, 6315.0, 6123.892747182578, 6188.947878860695, 6251.874962500816, 6258.092576576462, 6266.060090986389, 6302.275238347649, 6356.872862542816, 6375.203099612549, 6379.617222966637, 6394.776182833579, 6133.3866613338305, 6151.138840562236, 6176.258848937977, 6202.069689546604, 6203.875922481616], "value": 5892.273783118139, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.4395459450816, 796.2992566541443, 818.3044412249586, 1127.7913585986587, 1144.4220668562375, 36210.27579448409, 36478.452823207605, 36654.08364790878, 37065.44401833971, 37075.44386834193, 38307.808460957654, 38927.80536097322, 39142.8042859786, 39174.80412597933, 39240.80379598105, 7127.643617819102, 7177.990162754437, 7300.269973002711, 7445.329920307171, 7462.0, 7304.598247096407, 7364.374028207609, 7388.556686598795, 7397.297256760599, 7416.480846340758, 7370.152432470281, 7396.593187374692, 7437.925620743805, 7479.700811967515, 7485.850282994337, 7360.447966402515, 7365.705371785122, 7376.96311518439, 7379.3727533159745, 7420.3321701046625, 7282.417406607458, 7316.926830731731, 7345.449091318173, 7359.926400736032, 7393.408527317802, 35775.0, 35885.102872428135, 36106.0, 36120.27759444823, 36137.81931090328, 3519.8560467847797, 3531.52324436203, 3536.929261414783, 3547.166415892263, 3559.0924314299687, 28762.712372876213, 29031.564526532118, 29062.41875162506, 29094.27264318409, 29134.41731165386, 3704.4072948328408, 3717.6654101130757, 3719.5536535615897, 3731.570869350005, 3743.401055831054, 197882.0, 200850.0, 211111.0, 215578.0, 217712.0, 46144.3078353825, 46344.536554634695, 46533.5346646536, 46596.3010554842, 46661.766691166325, 48528.5147148531, 48738.26892596614, 49094.0, 49422.25866612004, 49428.50571494239, 14646.853531464549, 14650.706985860223, 14805.48180813688, 14922.104673719612, 14959.326830292446, 12023.458944347525, 12046.879531204575, 12214.145009849402, 12246.510139594495, 12261.509539618493, 13872.474027856928, 13919.23444210578, 14005.369758360897, 14134.929325353512, 14176.362063707158, 5617.269754931833, 5783.363829978699, 5787.0, 5805.738741756547, 5873.001589729756, 1084.7179733269406, 1121.9607313744143, 1134.3760931487814, 1136.3977092141179, 1139.1570238023803, 25988.8700556496, 26145.084922027636, 26405.471890562465, 26443.47113057728, 26576.33559160998, 1209.3529961470747, 1222.2238878312157, 1223.4188760338768, 1230.3786587773118, 1249.9187552809037, 13634.863651363557, 13812.86187138136, 13939.721205575832, 13971.650708732363, 13976.231307277994, 238410.0, 243051.0, 244196.0, 245243.0, 263007.0, 58616.413835861094, 58674.0, 58887.70556147192, 59058.704706476194, 59374.40625593689, 1516.8710659593837, 1537.9615509612127, 1538.100211376335, 1540.7457769467912, 1551.8758499320027, 28897.42205155927, 30816.229594260323, 30962.0, 31270.53094203543, 31297.217569560944, 38430.80784596059, 38550.807245964716, 38622.52397284258, 38756.41865372078, 38915.6108438912, 223465.0, 224873.50252995174, 224914.0, 225167.0, 225238.0, 33757.83121084379, 35309.29381412409, 35610.28779424449, 35709.64290357063, 35856.4621530672, 42487.0, 43945.34081988709, 44149.0, 44239.778801105786, 44994.3250851244, 32632.83683581567, 32806.50790238196, 32826.50760238646, 33887.909834025464, 34347.4847877287, 33090.50364244587, 33367.66632333645, 33701.66298336985, 34533.0, 34598.65401345954, 38035.61964380431, 38447.23105537818, 38510.6148938507, 38573.2285354297, 38714.41928371133, 30455.543166852956, 31040.379192415574, 31430.140816937434, 31606.103633782048, 33134.0, 26905.461890761682, 26961.86519067392, 27127.86436067886, 27151.45697086087, 27372.58941115845], "value": 17415.06439842578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.4040694045687, 437.2217452933777, 446.22357098648354, 451.73347724842347, 471.76176031104285, 19140.138693758778, 19874.403767886968, 20159.49601259969, 20577.0, 20602.89698551507, 21629.56740865182, 22196.778032219674, 22860.199893003748, 22870.88564557175, 23316.533669326604, 5613.101903695399, 5778.6243894146955, 5801.506871915893, 5816.767329306844, 5821.621594596359, 5419.160030195326, 5615.6630602164005, 5633.492985631292, 5664.26364572605, 5675.943240567603, 5626.662400255977, 5628.577856660746, 5636.774529018855, 5638.830835074954, 5644.8024319148835, 5465.0, 5593.356763972155, 5637.069883469264, 5640.407757185498, 5672.17753425753, 5036.521530454601, 5082.567981721558, 5099.643024988252, 5117.130087885069, 5124.718140502271, 25280.367990800194, 25350.1127460538, 25350.619740703904, 25442.618360724606, 25650.178480367143, 1831.6519861226457, 2166.880821554814, 2189.9890500547394, 2191.244020812817, 2201.680756290345, 16513.091779952098, 16769.0, 16984.49046528606, 17951.371701990367, 18153.092345382676, 2182.7598964113936, 2208.1608988584394, 2242.349718581626, 2261.705978222837, 2270.9205177818862, 109232.0, 115330.0, 116780.41609791982, 116799.0, 116800.41599792031, 12067.275963442222, 12195.939020304842, 12295.56965506203, 12653.36733163338, 12669.746605067847, 17084.0, 17189.82810171907, 17256.0, 17269.913650431918, 17343.566410839576, 8611.48331100136, 8862.246709029805, 8936.374453788172, 8967.237784788365, 9025.593848276843, 8014.0, 8047.637856296481, 8077.0, 8288.046874609376, 8371.916280837113, 7899.0, 7968.561729104839, 7999.36005119589, 8030.357571394275, 8032.200715127535, 2129.8509104362547, 2133.7119488869116, 2160.6758986152204, 2184.1918490158423, 2351.577295736089, 1004.6634377483479, 1066.6053560182781, 1070.8661417322835, 1072.1208608940594, 1086.1419478611808, 20847.0, 20918.79081209199, 21138.682919756215, 21142.894285528473, 21409.357719268446, 1083.1713738989679, 1087.152021423291, 1095.758933034747, 1098.6978580890159, 1099.6261271167841, 10679.252452328417, 11224.831627525593, 11427.714307142389, 11492.42537873103, 11574.6527604172, 495795.0, 496963.0, 500141.0, 500539.0, 503227.0, 88483.1151688475, 88678.0, 89488.55255723679, 89538.55230723936, 89706.55146724224, 1237.5421094195206, 1242.993785031087, 1260.9432575534306, 1263.7662032524013, 1275.508929062299, 17711.46865594034, 17889.19498622539, 17966.640667186846, 17977.370792022215, 18536.25854965786, 44785.0, 45433.845693929165, 45521.317180242986, 45870.0, 45875.788694791045, 57101.71449142728, 57634.423655762905, 57691.0, 58226.0, 58492.70753646205, 9085.454872707658, 9279.67521136757, 9400.153986141007, 9475.810483790148, 9492.477913714813, 14186.716265674422, 14387.136771793726, 14529.78205326942, 14757.778633320295, 15009.624759381102, 11927.821082683593, 12296.323702196465, 12409.131360804657, 12420.503179873065, 12650.0, 11566.190366674253, 11688.298702077902, 11881.524739010343, 11889.881101188877, 12337.136400451882, 13124.475020999053, 13178.868211318148, 13384.799228011783, 13519.594412167651, 13585.59243222705, 9525.333226674344, 9546.85679714791, 9601.951990240004, 9792.608295668093, 10042.246831487522, 13151.93424032912, 13169.802452963404, 13204.735905282032, 13359.866401335863, 13805.861941380457], "value": 10152.433894832724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.5929580421678, 1460.9050411723238, 1461.050317293759, 1463.5316698656434, 1473.7199932012916, 10903.672889813299, 11108.500117494712, 11284.26652267602, 11434.085273178147, 11457.197996140274, 11250.831237531444, 11385.715357116076, 11417.486213120408, 11467.0, 11475.827862582048, 2317.8029867461246, 2353.1411034972284, 2358.7641235876363, 2361.9763802361927, 2366.3492539551676, 2211.7788221177834, 2263.3775711679255, 2297.5979203639295, 2298.2071185440996, 2302.355340504653, 2185.0713446785053, 2230.208276061999, 2240.0815665577115, 2243.0242844362756, 2250.077468238023, 2266.9546609067893, 2278.350670059025, 2311.0524684879288, 2319.826013049028, 2325.5581439526436, 2229.55408918217, 2310.861348319106, 2315.4327189838427, 2327.5344931013865, 2339.2163625185585, 11292.20954533183, 11305.717357066056, 11448.084153267719, 11454.969052785289, 11474.713132171679, 6571.342865713438, 6760.628165450898, 6813.7955861324235, 6819.965900170468, 6837.35045170708, 3825.2923209206106, 4066.5323487798987, 4096.078382363974, 4116.300228961054, 4166.83332666693, 1335.9265240411773, 1387.5421111033336, 1395.5464474045975, 1411.5624156511515, 1436.2316160853998, 17148.657026859517, 17413.47759567215, 17478.825211747848, 17513.912430437893, 17517.562060948578, 5189.844304670866, 5265.368155821249, 5568.136938774496, 5591.30108736408, 5620.662760234399, 12186.51253949832, 12196.878031219752, 12214.57248996281, 12230.510779568896, 12250.75498490043, 6514.348565143448, 6518.761435327273, 6532.640704761188, 6543.574667646588, 6558.344165583499, 5880.705964701748, 6028.336882942873, 6159.538034647419, 6213.37866213375, 6214.564980451415, 4221.197972385298, 4308.67684923632, 4326.502452217972, 4400.559944005638, 4423.049044455457, 1258.993705031469, 1262.9494820207271, 1269.581038257373, 1286.2089814763854, 1295.1710905020793, 846.2257034813077, 869.1569177897429, 881.405051590174, 888.8755574219614, 911.4759013567225, 6325.335839736854, 6355.777547785805, 6363.61818290904, 6372.36276372359, 7061.082059332357, 973.600823662295, 1003.117256813999, 1007.4156988946394, 1011.1657882247175, 1015.1726343030555, 4126.216018956388, 4336.089421221579, 4345.087531618332, 4347.739135651871, 4433.667474939392, 14707.92646036763, 15495.380184792708, 15496.147711875956, 15507.457238996807, 15536.533903982898, 14762.188079655722, 14779.556613301618, 14936.850631493764, 15086.622834429227, 15101.39594416233, 8974.506402147814, 8980.0, 9055.728328150166, 9090.681826136053, 9098.226650734628, 6408.423241908251, 6512.772052978123, 6520.510961677988, 6660.900086498609, 6966.3730264276455, 13185.80221296662, 13376.531821386205, 13467.797983030066, 13482.662933426744, 13713.382897769425, 13418.798718019043, 13432.597022089352, 13503.797443038558, 13578.864211358155, 13729.176249425067, 9416.717498474783, 9645.08371704687, 9647.469389183661, 9690.12788849007, 9746.171575415885, 10962.725931851768, 11039.834402483808, 11066.114710822954, 11090.611828585961, 11091.72270693239, 9546.522673866419, 9572.808543829224, 9593.472359020321, 9616.855747163658, 9772.9022709772, 9231.86152207704, 9437.952810235905, 9448.669296574586, 9510.334276600572, 9534.904650953678, 7906.446548741533, 7958.641861116148, 8038.598070096588, 8047.879281810895, 8055.1542088079905, 6122.969385153046, 6255.96872015637, 6280.0, 6295.5907865988565, 6299.338569450142, 6267.968660156853, 6318.336574659595, 6319.557630965788, 6329.936700632935, 6385.074164246065], "value": 5408.991557038052, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.23156480728903, 394.5679480968341, 412.19827435637677, 413.0935731598672, 426.2902267724239, 5917.9408205917925, 6084.361142080084, 6209.84475388115, 6251.468625166866, 6259.530535209855, 5965.940340596593, 6079.0, 6084.878302433949, 6102.481289090421, 6113.755449782004, 4795.664303498756, 4821.2768084787385, 4827.082854257697, 4832.202686556731, 4833.661643684944, 4764.880877978061, 4773.379460670126, 4789.6168306535565, 4839.975800120995, 4848.806047758086, 4793.544613261734, 4803.5676789088975, 4812.278158276252, 4819.349387832633, 4826.276058591205, 4780.80876764929, 4818.34952281441, 4826.0830442215865, 4840.782164802592, 4863.2461968394955, 3786.0, 3879.3792993120965, 3892.649661530476, 3910.335243008695, 3911.6283953024417, 5892.587518873681, 5906.173135760997, 5914.526837852962, 5915.31413547137, 5954.345022047572, 5218.086834803932, 5285.810692594174, 5322.0952438085615, 5322.680639161663, 5327.760250788724, 6421.293657697696, 6456.870047741673, 6461.870762584769, 6470.870582588322, 6473.773417930397, 4458.086092351093, 4477.48508921475, 4481.462224533045, 4481.843135490242, 4481.865544033684, 6657.600543967329, 6786.151731033621, 6843.692033858439, 6851.520393572402, 6864.528769642925, 4548.636109111263, 4550.453945526558, 4551.886202844889, 4558.658100642465, 4563.475200351935, 4597.379353787196, 4597.931031034537, 4612.723236605814, 4619.653525985497, 4619.815207391734, 5287.788488460418, 5351.892962140735, 5383.192521121863, 5383.43473935239, 5408.432114627907, 6297.338779428185, 6456.903146452713, 6548.476121910236, 6551.80344589663, 6560.934390656128, 1568.9607759806097, 1574.3151728997693, 1575.4092215419219, 1588.2614584218393, 1598.9280482378322, 1029.3355751278064, 1044.1125043712934, 1063.7340664833791, 1064.99467502662, 1066.9786604267872, 6268.373162683695, 6314.242290925118, 6323.628639260278, 6342.143810585604, 6351.460125889259, 6732.562383445061, 6763.2898545652, 6769.559978601375, 6800.387965083166, 6805.897911531331, 6101.603395779349, 6271.592346497554, 6333.809985700436, 6337.637407957312, 6342.651154186472, 3521.207728261121, 3529.4705794130573, 3536.8938931832085, 3548.1129717570607, 3555.6266592007983, 6862.49025214452, 6955.860882782417, 6970.965145174242, 7008.369246767816, 7036.788896333118, 6840.828979275459, 6859.5541289816, 6882.827929301708, 6885.758998435031, 6889.448844092461, 6754.425873800684, 6967.407770339477, 7025.578465292099, 7032.26161253061, 7057.364837164782, 6755.716413881347, 6762.222344430454, 6766.695498702668, 6776.356246156607, 6807.183138023469, 6559.8032059038305, 6667.566608170453, 6681.866362672622, 6682.565633233824, 6711.496637752286, 6972.163340398982, 7012.368886800213, 7028.613426261605, 7031.824204394931, 7061.258567850302, 4388.429504164438, 4424.469063712375, 4472.1502914446155, 4472.702916154279, 4490.955090449053, 6586.934130658632, 6759.155105611799, 6768.729250830109, 6777.830554236183, 6792.252852186354, 6477.8704425912165, 6535.869282614416, 6552.6068435894, 6556.803295901131, 6585.407313341822, 6495.902561461677, 6539.640319782267, 6549.70526326326, 6558.901616475852, 6575.605463672004, 6515.315891831289, 6534.640594767334, 6546.869062618816, 6590.5716128451495, 6603.306652801579, 6477.1579694639395, 6514.478841692748, 6540.8364790880605, 6551.377619126175, 6635.63504007265, 6328.841778955379, 6346.683460536963, 6351.047342898602, 6393.776217832354, 6421.93578064232], "value": 4924.171561961544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [868.400803445622, 891.5542228885557, 898.3486971945345, 899.2491269789725, 914.3371055984412, 16385.60722338601, 17297.913510432445, 17311.307547698092, 17658.911705441456, 18020.0, 18716.157772900217, 18945.431637050875, 19134.330298439556, 19647.115879785408, 20022.399328020147, 996.292632231115, 1030.7062487191151, 1030.7320096774818, 1030.9329893556894, 1033.7880734449457, 1031.2008193649906, 1035.5236591168073, 1042.4006196437042, 1042.9791404171913, 1045.8692663417073, 1097.1825989637732, 1099.3623698255033, 1103.194667892439, 1104.6023431564631, 1106.8173751331021, 1081.729567608098, 1083.5286650307141, 1094.8303013032953, 1098.730810951318, 1099.8460215569826, 768.8270139218687, 772.7488566215947, 776.4719990406521, 776.5301992294637, 779.1974266505508, 16359.672806543922, 16611.50165495037, 16637.66724665512, 16649.33402663892, 16668.74996875048, 17112.91443542774, 17172.570685732833, 17466.912665436717, 17478.650426991517, 17572.91213543937, 14221.004529682927, 14404.423823047066, 14452.638684032983, 14478.276086195649, 14490.42038318466, 3434.742394320436, 3451.4822776583464, 3481.9129521761906, 3487.110786749363, 3495.8426870790877, 88639.11360886373, 94625.52687236588, 95056.0, 95557.0, 95680.52159739226, 14839.629009274639, 15344.0, 15395.846041539442, 15413.152276624893, 15434.614134646723, 27226.455470890472, 27795.74919128644, 28414.85792571024, 28585.0, 28658.0, 8605.225529702231, 8727.738167854974, 8736.344774141837, 8758.693445729368, 8774.51740154285, 4134.813933373005, 4205.91588168241, 4214.852480163179, 4216.494020717533, 4217.704760666724, 4641.976790116096, 4767.69010014348, 4799.712017278975, 4806.50998190555, 4816.157172494799, 928.076563818991, 932.2635118256637, 940.3558562384789, 947.9241660667268, 950.695777351241, 735.6064505489644, 744.8026273037649, 751.6955632968657, 758.9013428254402, 776.6543887969799, 11884.346360950058, 12629.494820207272, 13261.0, 13567.389467473988, 13578.32108394596, 727.4580437574041, 752.5860776572863, 758.4842307231025, 758.525921299188, 763.9885401718979, 5473.534749546254, 5527.972360138254, 5759.596828221985, 5816.389279125631, 5899.528037756969, 85050.57474712587, 87667.0, 87929.0, 88237.0, 88852.0, 78708.37436946054, 79067.60466197632, 79135.60432197918, 81033.18966810375, 83513.58243208866, 61092.38907610867, 62369.45120762345, 63102.0, 64019.0, 67517.0, 11824.467898944396, 13067.869321306665, 13122.0, 13135.34323283813, 13175.934120329337, 34095.0, 34329.82835085908, 34371.65628343785, 34633.480497793054, 34715.30569388648, 41489.792551037055, 41596.58403416048, 41638.791806040776, 42028.0, 58516.4148358528, 15551.222438878238, 15755.606109847346, 15814.367425302858, 16913.577160570592, 17336.219870105622, 17571.648567028333, 17809.198586063398, 18173.45479635613, 18185.545361366072, 19324.32364867223, 17658.117094144985, 17802.287908483515, 17850.39346458825, 18001.369952051617, 18590.0, 17591.29634814593, 17745.024023678823, 17749.467515974542, 17769.378071767427, 17868.106594670473, 17266.482005539852, 17569.560760980567, 18040.909795451465, 18087.276508939496, 18546.536336591693, 11907.106966977684, 11940.641780746591, 12017.0, 12235.69410764738, 12263.877361226274, 12642.367881606067, 12847.871521285042, 13634.1137826041, 13925.164490130624, 13929.791053134008], "value": 8503.71845041909, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1492.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 120.0, 173.0, 122.0, 119.0, 119.0, 119.0, 142.0, 119.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 162.0, 163.0, 162.0, 167.0, 169.0, 166.0, 168.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 95.0, 75.0, 76.0, 74.0, 74.0, 92.0, 74.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 97.0, 82.0, 82.0, 83.0, 95.0, 82.0, 81.0, 106.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 149.0, 150.0, 148.0, 149.0, 148.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 45.0, 45.0, 46.0, 46.0, 47.0, 45.0, 46.0, 45.0, 45.0], "value": 45.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 81.0, 81.0, 81.0, 81.0, 81.0, 83.0, 82.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 138.0, 126.0, 126.0, 132.0, 130.0, 137.0, 173.0, 125.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 192.0, 195.0, 179.0, 180.0, 181.0, 186.0, 181.0, 180.0, 184.0], "value": 183.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 64.0, 64.0, 70.0, 64.0, 66.0, 63.0, 62.0, 64.0], "value": 65.3, "unit": "score"}]}]} 17:35:37 INFO - Return code: 0 17:35:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:35:37 INFO - # TBPL SUCCESS # 17:35:37 INFO - Running post-action listener: _resource_record_post_action 17:35:37 INFO - [mozharness: 2017-05-06 00:35:37.384671Z] Finished run-tests step (success) 17:35:37 INFO - Running post-run listener: _resource_record_post_run 17:35:37 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370102272; Read time: 16; Write time: 263500 17:35:37 INFO - TinderboxPrint: CPU usage
13.2% 17:35:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:35:37 INFO - TinderboxPrint: I/O write bytes / time
370,102,272 / 263,500 17:35:37 INFO - TinderboxPrint: CPU idle
8,246.9 (86.8%) 17:35:37 INFO - TinderboxPrint: CPU user
1,201.1 (12.6%) 17:35:37 INFO - TinderboxPrint: Swap in / out
0 / 0 17:35:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 121962496; Read time: 0; Write time: 105932 17:35:37 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 247549952; Read time: 0; Write time: 157540 17:35:38 INFO - Running post-run listener: _upload_blobber_files 17:35:38 INFO - Blob upload gear active. 17:35:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:35:38 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 17:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:35:38 INFO - (blobuploader) - INFO - Open directory for files ... 17:35:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:35:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:35:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:41 INFO - (blobuploader) - INFO - Done attempting. 17:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:35:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:42 INFO - (blobuploader) - INFO - Done attempting. 17:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:35:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:43 INFO - (blobuploader) - INFO - Done attempting. 17:35:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:35:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:35:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:43 INFO - (blobuploader) - INFO - Done attempting. 17:35:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:35:43 INFO - Return code: 0 17:35:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:35:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:35:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c831900b1e5f16513e63eee596b7af15ad2ad2cbb52640fc67a853129236ba4c44a8e7903149acf9e9eb0dece392ab0735d273a2fe93b79e6680a671e2ecf219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7e06308b9202141dae4e4ecd86b306f6933ea1df24aea14ee4f0e03b0787422ae9539b31ff461a7ca32c5d4af3f7fb6af4c2addd151d3c355d21eca5297db54", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb44c79607ad7e0ac09ede5045b35820f4eff9732e5c42f3c5fa4fb0fff2d4bbc0b812151744f9185d8b33fed9a46595ea8c9bb44c37ee45870bc5a80332b38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84337bfd60c5d8129cd055b80ad27f2873aff6e37368162d72e5b595acd21fe5baa338500403a37802d085f2d99da374557dcffad0396f88a173e20205e91b6c"} 17:35:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:35:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:35:43 INFO - Contents: 17:35:43 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c831900b1e5f16513e63eee596b7af15ad2ad2cbb52640fc67a853129236ba4c44a8e7903149acf9e9eb0dece392ab0735d273a2fe93b79e6680a671e2ecf219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7e06308b9202141dae4e4ecd86b306f6933ea1df24aea14ee4f0e03b0787422ae9539b31ff461a7ca32c5d4af3f7fb6af4c2addd151d3c355d21eca5297db54", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb44c79607ad7e0ac09ede5045b35820f4eff9732e5c42f3c5fa4fb0fff2d4bbc0b812151744f9185d8b33fed9a46595ea8c9bb44c37ee45870bc5a80332b38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84337bfd60c5d8129cd055b80ad27f2873aff6e37368162d72e5b595acd21fe5baa338500403a37802d085f2d99da374557dcffad0396f88a173e20205e91b6c"} 17:35:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:35:43 INFO - Copying logs to upload dir... 17:35:43 INFO - mkdir: /builds/slave/test/build/upload/logs 17:35:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.511091 ========= master_lag: -0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-05-05 17:35:43.430690) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 17:35:43.437921) ========= 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=232498196343f89f466a4a9a000001c8-1494029697.307108-771510321 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/sha512/c831900b1e5f16513e63eee596b7af15ad2ad2cbb52640fc67a853129236ba4c44a8e7903149acf9e9eb0dece392ab0735d273a2fe93b79e6680a671e2ecf219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7e06308b9202141dae4e4ecd86b306f6933ea1df24aea14ee4f0e03b0787422ae9539b31ff461a7ca32c5d4af3f7fb6af4c2addd151d3c355d21eca5297db54", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb44c79607ad7e0ac09ede5045b35820f4eff9732e5c42f3c5fa4fb0fff2d4bbc0b812151744f9185d8b33fed9a46595ea8c9bb44c37ee45870bc5a80332b38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84337bfd60c5d8129cd055b80ad27f2873aff6e37368162d72e5b595acd21fe5baa338500403a37802d085f2d99da374557dcffad0396f88a173e20205e91b6c"} build_url:https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/E-z8X3TIRqCsRQ2h6kzILw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c831900b1e5f16513e63eee596b7af15ad2ad2cbb52640fc67a853129236ba4c44a8e7903149acf9e9eb0dece392ab0735d273a2fe93b79e6680a671e2ecf219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7e06308b9202141dae4e4ecd86b306f6933ea1df24aea14ee4f0e03b0787422ae9539b31ff461a7ca32c5d4af3f7fb6af4c2addd151d3c355d21eca5297db54", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb44c79607ad7e0ac09ede5045b35820f4eff9732e5c42f3c5fa4fb0fff2d4bbc0b812151744f9185d8b33fed9a46595ea8c9bb44c37ee45870bc5a80332b38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84337bfd60c5d8129cd055b80ad27f2873aff6e37368162d72e5b595acd21fe5baa338500403a37802d085f2d99da374557dcffad0396f88a173e20205e91b6c"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 17:35:43.503940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 17:35:43.504258) ========= 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=232498196343f89f466a4a9a000001c8-1494029697.307108-771510321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 17:35:43.525148) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 17:35:43.525446) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 17:35:43.525713) ========= ========= Total master_lag: -0.02 =========