builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1493917518.98 results: success (0) revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:18.979668) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:18.980145) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:18.980732) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.029403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.029802) ========= 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-1493917152.670997-537101294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 10:05:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 55.0M=0s 2017-05-04 10:05:19 (55.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095174 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.142849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.143155) ========= 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-1493917152.670997-537101294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020111 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.196146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.199595) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b255199db9d6a6f189b89b7906f99155bde3726 --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 0b255199db9d6a6f189b89b7906f99155bde3726 --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-1493917152.670997-537101294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 10:05:19,262 truncating revision to first 12 chars 2017-05-04 10:05:19,262 Setting DEBUG logging. 2017-05-04 10:05:19,262 attempt 1/10 2017-05-04 10:05:19,262 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b255199db9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 10:05:19,648 unpacking tar archive at: mozilla-central-0b255199db9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652295 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.868413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.868820) ========= script_repo_revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.869240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.869518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:05:19.879737) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-05-04 10:05:19.880111) ========= /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-1493917152.670997-537101294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:20 INFO - MultiFileLogger online at 20170504 10:05:20 in /builds/slave/test 10:05:20 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 10:05:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:20 INFO - {'append_to_log': False, 10:05:20 INFO - 'base_work_dir': '/builds/slave/test', 10:05:20 INFO - 'blob_upload_branch': 'Firefox', 10:05:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:20 INFO - 'branch': 'Firefox', 10:05:20 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:20 INFO - 'config_files': ('talos/linux_config.py',), 10:05:20 INFO - 'default_actions': ('clobber', 10:05:20 INFO - 'read-buildbot-config', 10:05:20 INFO - 'download-and-extract', 10:05:20 INFO - 'populate-webroot', 10:05:20 INFO - 'create-virtualenv', 10:05:20 INFO - 'install', 10:05:20 INFO - 'run-tests'), 10:05:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:20 INFO - 'download_minidump_stackwalk': True, 10:05:20 INFO - 'download_symbols': 'ondemand', 10:05:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:20 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:20 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:20 INFO - 'gecko_profile': False, 10:05:20 INFO - 'gecko_profile_interval': 0, 10:05:20 INFO - 'installer_path': 'installer.exe', 10:05:20 INFO - 'log_level': 'info', 10:05:20 INFO - 'log_name': 'talos', 10:05:20 INFO - 'log_to_console': True, 10:05:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:20 INFO - 'opt_config_files': (), 10:05:20 INFO - 'pip_index': False, 10:05:20 INFO - 'suite': 'dromaeojs-e10s', 10:05:20 INFO - 'system_bits': '32', 10:05:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:20 INFO - 'title': 'talos-linux64-ix-025', 10:05:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:20 INFO - 'use_talos_json': True, 10:05:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:20 INFO - 'work_dir': 'build'} 10:05:20 INFO - [mozharness: 2017-05-04 17:05:20.048929Z] Running clobber step. 10:05:20 INFO - Running pre-action listener: _resource_record_pre_action 10:05:20 INFO - Running main action method: clobber 10:05:20 INFO - rmtree: /builds/slave/test/build 10:05:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:20 INFO - Running post-action listener: _resource_record_post_action 10:05:20 INFO - [mozharness: 2017-05-04 17:05:20.990060Z] Finished clobber step (success) 10:05:20 INFO - [mozharness: 2017-05-04 17:05:20.990159Z] Running read-buildbot-config step. 10:05:20 INFO - Running pre-action listener: _resource_record_pre_action 10:05:20 INFO - Running main action method: read_buildbot_config 10:05:20 INFO - Using buildbot properties: 10:05:20 INFO - { 10:05:20 INFO - "project": "", 10:05:20 INFO - "product": "firefox", 10:05:20 INFO - "who": "archaeopteryx@coole-files.de", 10:05:20 INFO - "installer_path": "public/build/target.tar.bz2", 10:05:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:05:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:05:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:05:20 INFO - "stage_platform": "linux64-pgo", 10:05:20 INFO - "basedir": "/builds/slave/test", 10:05:20 INFO - "buildnumber": 194, 10:05:20 INFO - "platform": "ubuntu64_hw", 10:05:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:05:20 INFO - "slavebuilddir": "test", 10:05:20 INFO - "taskId": "c1xdrpeQQ9KoiGxJPWZC5Q", 10:05:20 INFO - "branch": "mozilla-central", 10:05:20 INFO - "script_repo_revision": "production", 10:05:20 INFO - "revision": "0b255199db9d6a6f189b89b7906f99155bde3726", 10:05:20 INFO - "slavename": "talos-linux64-ix-025", 10:05:20 INFO - "repo_path": "mozilla-central" 10:05:20 INFO - } 10:05:20 INFO - Finding installer, test and symbols from parent task. 10:05:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c1xdrpeQQ9KoiGxJPWZC5Q'}, attempt #1 10:05:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c1xdrpeQQ9KoiGxJPWZC5Q'}, attempt #1 10:05:21 INFO - Task dependencies: ArH1QPTVQzy70sA-Zlw7xw 10:05:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw'}, attempt #1 10:05:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 10:05:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/test_packages.json 10:05:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.crashreporter-symbols.zip 10:05:22 INFO - Running post-action listener: _resource_record_post_action 10:05:22 INFO - [mozharness: 2017-05-04 17:05:22.404376Z] Finished read-buildbot-config step (success) 10:05:22 INFO - [mozharness: 2017-05-04 17:05:22.404593Z] Running download-and-extract step. 10:05:22 INFO - Running pre-action listener: _resource_record_pre_action 10:05:22 INFO - Running main action method: download_and_extract 10:05:22 INFO - mkdir: /builds/slave/test/build/tests 10:05:22 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')]} 10:05:22 INFO - trying https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.test_packages.json 10:05:22 INFO - Downloading https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:05:22 INFO - Downloaded 986 bytes. 10:05:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:05:23 INFO - Using the following test package requirements: 10:05:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:05:23 INFO - u'common': [u'target.common.tests.zip'], 10:05:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:05:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:05:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:05:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:05:23 INFO - u'mozbase': [u'target.common.tests.zip'], 10:05:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:05:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:05:23 INFO - u'web-platform': [u'target.common.tests.zip', 10:05:23 INFO - u'target.web-platform.tests.zip'], 10:05:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:05:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:05:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip 10:05:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:05:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip into memory 10:05:24 INFO - Content-Length response header: 60559924 10:05:24 INFO - Bytes received: 60559924 10:05:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:05:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip 10:05:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:05:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.common.tests.zip into memory 10:05:35 INFO - Content-Length response header: 60559924 10:05:35 INFO - Bytes received: 60559924 10:05:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.talos.tests.zip 10:05:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:05:45 INFO - Fetch https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.talos.tests.zip into memory 10:05:46 INFO - Content-Length response header: 14408809 10:05:46 INFO - Bytes received: 14408809 10:05:46 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')]} 10:05:46 INFO - trying https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 10:05:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:05:48 INFO - Downloaded 64065221 bytes. 10:05:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 10:05:48 INFO - mkdir: /builds/slave/test/properties 10:05:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:48 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:48 INFO - Contents: 10:05:48 INFO - build_url:https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 10:05:48 INFO - Running post-action listener: _resource_record_post_action 10:05:48 INFO - Running post-action listener: set_extra_try_arguments 10:05:48 INFO - [mozharness: 2017-05-04 17:05:48.389528Z] Finished download-and-extract step (success) 10:05:48 INFO - [mozharness: 2017-05-04 17:05:48.389678Z] Running populate-webroot step. 10:05:48 INFO - Running pre-action listener: _resource_record_pre_action 10:05:48 INFO - Running main action method: populate_webroot 10:05:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:48 INFO - '--tppagecycles', 10:05:48 INFO - '7'], 10:05:48 INFO - 'tests': ['tsvgm']}}, 10:05:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:05:48 INFO - 'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:05:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:05:48 INFO - 'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['damp', 'tps']}, 10:05:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:05:48 INFO - 'tests': ['damp', 'tps']}, 10:05:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['dromaeo_dom']}, 10:05:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:05:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:05:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['a11yr', 10:05:48 INFO - 'ts_paint', 10:05:48 INFO - 'tpaint', 10:05:48 INFO - 'sessionrestore', 10:05:48 INFO - 'sessionrestore_no_auto_restore', 10:05:48 INFO - 'tabpaint']}, 10:05:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:48 INFO - 'ts_paint', 10:05:48 INFO - 'tpaint', 10:05:48 INFO - 'sessionrestore', 10:05:48 INFO - 'sessionrestore_no_auto_restore', 10:05:48 INFO - 'tabpaint']}, 10:05:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:48 INFO - 'ts_paint', 10:05:48 INFO - 'tpaint', 10:05:48 INFO - 'sessionrestore', 10:05:48 INFO - 'sessionrestore_no_auto_restore', 10:05:48 INFO - 'tabpaint']}, 10:05:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:48 INFO - 'ts_paint', 10:05:48 INFO - 'tpaint', 10:05:48 INFO - 'sessionrestore', 10:05:48 INFO - 'sessionrestore_no_auto_restore', 10:05:48 INFO - 'tabpaint']}, 10:05:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['a11yr', 10:05:48 INFO - 'ts_paint', 10:05:48 INFO - 'tpaint', 10:05:48 INFO - 'sessionrestore', 10:05:48 INFO - 'sessionrestore_no_auto_restore', 10:05:48 INFO - 'tabpaint']}, 10:05:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['a11yr', 10:05:48 INFO - 'ts_paint', 10:05:48 INFO - 'tpaint', 10:05:48 INFO - 'sessionrestore', 10:05:48 INFO - 'sessionrestore_no_auto_restore', 10:05:48 INFO - 'tabpaint']}, 10:05:48 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:05:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:05:48 INFO - 'bloom_basic_ref']}, 10:05:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['tsvgx', 10:05:48 INFO - 'tsvgr_opacity', 10:05:48 INFO - 'tart', 10:05:48 INFO - 'tscrollx', 10:05:48 INFO - 'cart', 10:05:48 INFO - 'tsvg_static']}, 10:05:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:48 INFO - 'tsvgr_opacity', 10:05:48 INFO - 'tart', 10:05:48 INFO - 'tscrollx', 10:05:48 INFO - 'cart', 10:05:48 INFO - 'tsvg_static']}, 10:05:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:05:48 INFO - 'talos_options': ['--disable-e10s'], 10:05:48 INFO - 'tests': ['tp5o']}, 10:05:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:05:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:05:48 INFO - 'talos_options': ['--disable-e10s', 10:05:48 INFO - '--xperf_path', 10:05:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:48 INFO - 'tests': ['tp5n']}, 10:05:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:05:48 INFO - 'talos_options': ['--xperf_path', 10:05:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:48 INFO - 'tests': ['tp5n']}}, 10:05:48 INFO - 'talos.zip': {'path': '', 10:05:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:48 INFO - Running post-action listener: _resource_record_post_action 10:05:48 INFO - [mozharness: 2017-05-04 17:05:48.406410Z] Finished populate-webroot step (success) 10:05:48 INFO - [mozharness: 2017-05-04 17:05:48.406499Z] Running create-virtualenv step. 10:05:48 INFO - Running pre-action listener: _resource_record_pre_action 10:05:48 INFO - Running main action method: create_virtualenv 10:05:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:48 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 10:05:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:48 INFO - Using real prefix '/usr' 10:05:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:49 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:50 INFO - Installing pip.................done. 10:05:50 INFO - Return code: 0 10:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:05:51 INFO - Reading from file tmpfile_stdout 10:05:51 INFO - Output received: 10:05:51 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) 10:05:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:51 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')]} 10:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:51 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')]} 10:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:51 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 0x253a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2632a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, '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-1493917152.670997-537101294', '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 10:05:51 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 10:05:51 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 10:05:51 INFO - Using env: {'DISPLAY': ':0', 10:05:51 INFO - 'HOME': '/home/cltbld', 10:05:51 INFO - 'LANG': 'en_US.UTF-8', 10:05:51 INFO - 'LANGUAGE': 'en_US:en', 10:05:51 INFO - 'LOGNAME': 'cltbld', 10:05:51 INFO - 'MAIL': '/var/mail/cltbld', 10:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:51 INFO - 'MOZ_NO_REMOTE': '1', 10:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:51 INFO - 'NO_EM_RESTART': '1', 10:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:51 INFO - 'PWD': '/builds/slave/test', 10:05:51 INFO - 'SHELL': '/bin/bash', 10:05:51 INFO - 'SHLVL': '1', 10:05:51 INFO - 'TERM': 'linux', 10:05:51 INFO - 'TMOUT': '86400', 10:05:51 INFO - 'USER': 'cltbld', 10:05:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:51 INFO - '_': '/tools/buildbot/bin/python'} 10:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:51 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 10:05:51 INFO - Cleaning up... 10:05:51 INFO - Return code: 0 10:05:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:05:51 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')]} 10:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:51 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')]} 10:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:51 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 0x253a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2632a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, '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-1493917152.670997-537101294', '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 10:05:51 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 10:05:51 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 10:05:51 INFO - Using env: {'DISPLAY': ':0', 10:05:51 INFO - 'HOME': '/home/cltbld', 10:05:51 INFO - 'LANG': 'en_US.UTF-8', 10:05:51 INFO - 'LANGUAGE': 'en_US:en', 10:05:51 INFO - 'LOGNAME': 'cltbld', 10:05:51 INFO - 'MAIL': '/var/mail/cltbld', 10:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:51 INFO - 'MOZ_NO_REMOTE': '1', 10:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:51 INFO - 'NO_EM_RESTART': '1', 10:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:51 INFO - 'PWD': '/builds/slave/test', 10:05:51 INFO - 'SHELL': '/bin/bash', 10:05:51 INFO - 'SHLVL': '1', 10:05:51 INFO - 'TERM': 'linux', 10:05:51 INFO - 'TMOUT': '86400', 10:05:51 INFO - 'USER': 'cltbld', 10:05:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:51 INFO - '_': '/tools/buildbot/bin/python'} 10:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:51 INFO - Downloading/unpacking psutil>=3.1.1 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:52 INFO - Installing collected packages: psutil 10:05:52 INFO - Running setup.py install for psutil 10:05:52 INFO - building 'psutil._psutil_linux' extension 10:05:52 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 10:05:53 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 10:05:53 INFO - building 'psutil._psutil_posix' extension 10:05:53 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 10:05:53 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 10:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:53 INFO - Successfully installed psutil 10:05:53 INFO - Cleaning up... 10:05:53 INFO - Return code: 0 10:05:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:05:53 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')]} 10:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:53 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')]} 10:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:53 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 0x253a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2632a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, '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-1493917152.670997-537101294', '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 10:05:53 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 10:05:53 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 10:05:53 INFO - Using env: {'DISPLAY': ':0', 10:05:53 INFO - 'HOME': '/home/cltbld', 10:05:53 INFO - 'LANG': 'en_US.UTF-8', 10:05:53 INFO - 'LANGUAGE': 'en_US:en', 10:05:53 INFO - 'LOGNAME': 'cltbld', 10:05:53 INFO - 'MAIL': '/var/mail/cltbld', 10:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:53 INFO - 'MOZ_NO_REMOTE': '1', 10:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:53 INFO - 'NO_EM_RESTART': '1', 10:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:53 INFO - 'PWD': '/builds/slave/test', 10:05:53 INFO - 'SHELL': '/bin/bash', 10:05:53 INFO - 'SHLVL': '1', 10:05:53 INFO - 'TERM': 'linux', 10:05:53 INFO - 'TMOUT': '86400', 10:05:53 INFO - 'USER': 'cltbld', 10:05:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:53 INFO - '_': '/tools/buildbot/bin/python'} 10:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:05:53 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 10:05:53 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 10:05:53 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 10:05:53 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 10:05:53 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 10:05:53 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 10:05:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:05:54 INFO - Installing collected packages: mozsystemmonitor 10:05:54 INFO - Running setup.py install for mozsystemmonitor 10:05:54 INFO - Successfully installed mozsystemmonitor 10:05:54 INFO - Cleaning up... 10:05:54 INFO - Return code: 0 10:05:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:05:54 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')]} 10:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:54 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')]} 10:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:54 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 0x253a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2632a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, '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-1493917152.670997-537101294', '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 10:05:54 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 10:05:54 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 10:05:54 INFO - Using env: {'DISPLAY': ':0', 10:05:54 INFO - 'HOME': '/home/cltbld', 10:05:54 INFO - 'LANG': 'en_US.UTF-8', 10:05:54 INFO - 'LANGUAGE': 'en_US:en', 10:05:54 INFO - 'LOGNAME': 'cltbld', 10:05:54 INFO - 'MAIL': '/var/mail/cltbld', 10:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:54 INFO - 'MOZ_NO_REMOTE': '1', 10:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:54 INFO - 'NO_EM_RESTART': '1', 10:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:54 INFO - 'PWD': '/builds/slave/test', 10:05:54 INFO - 'SHELL': '/bin/bash', 10:05:54 INFO - 'SHLVL': '1', 10:05:54 INFO - 'TERM': 'linux', 10:05:54 INFO - 'TMOUT': '86400', 10:05:54 INFO - 'USER': 'cltbld', 10:05:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:54 INFO - '_': '/tools/buildbot/bin/python'} 10:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:54 INFO - Downloading/unpacking jsonschema==2.5.1 10:05:54 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 10:05:54 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 10:05:54 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 10:05:54 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 10:05:54 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 10:05:54 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 10:05:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:56 INFO - warning: no files found matching '*.txt' 10:05:56 INFO - no previously-included directories found matching 'build' 10:05:56 INFO - no previously-included directories found matching 'dist' 10:05:56 INFO - no previously-included directories found matching '.git*' 10:05:56 INFO - Installing collected packages: jsonschema, functools32 10:05:56 INFO - Running setup.py install for functools32 10:05:56 INFO - warning: no files found matching '*.txt' 10:05:56 INFO - no previously-included directories found matching 'build' 10:05:56 INFO - no previously-included directories found matching 'dist' 10:05:56 INFO - no previously-included directories found matching '.git*' 10:05:56 INFO - Successfully installed jsonschema functools32 10:05:56 INFO - Cleaning up... 10:05:56 INFO - Return code: 0 10:05:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:56 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 0x253a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2632a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, '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-1493917152.670997-537101294', '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 10:05:56 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 10:05:56 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 10:05:56 INFO - Using env: {'DISPLAY': ':0', 10:05:56 INFO - 'HOME': '/home/cltbld', 10:05:56 INFO - 'LANG': 'en_US.UTF-8', 10:05:56 INFO - 'LANGUAGE': 'en_US:en', 10:05:56 INFO - 'LOGNAME': 'cltbld', 10:05:56 INFO - 'MAIL': '/var/mail/cltbld', 10:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:56 INFO - 'MOZ_NO_REMOTE': '1', 10:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:56 INFO - 'NO_EM_RESTART': '1', 10:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:56 INFO - 'PWD': '/builds/slave/test', 10:05:56 INFO - 'SHELL': '/bin/bash', 10:05:56 INFO - 'SHLVL': '1', 10:05:56 INFO - 'TERM': 'linux', 10:05:56 INFO - 'TMOUT': '86400', 10:05:56 INFO - 'USER': 'cltbld', 10:05:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:56 INFO - '_': '/tools/buildbot/bin/python'} 10:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:05:56 INFO - Cleaning up... 10:05:56 INFO - Return code: 0 10:05:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:56 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 0x253a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2632a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, '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-1493917152.670997-537101294', '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 10:05:56 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 10:05:56 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 10:05:56 INFO - Using env: {'DISPLAY': ':0', 10:05:56 INFO - 'HOME': '/home/cltbld', 10:05:56 INFO - 'LANG': 'en_US.UTF-8', 10:05:56 INFO - 'LANGUAGE': 'en_US:en', 10:05:56 INFO - 'LOGNAME': 'cltbld', 10:05:56 INFO - 'MAIL': '/var/mail/cltbld', 10:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:56 INFO - 'MOZ_NO_REMOTE': '1', 10:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:56 INFO - 'NO_EM_RESTART': '1', 10:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:56 INFO - 'PWD': '/builds/slave/test', 10:05:56 INFO - 'SHELL': '/bin/bash', 10:05:56 INFO - 'SHLVL': '1', 10:05:56 INFO - 'TERM': 'linux', 10:05:56 INFO - 'TMOUT': '86400', 10:05:56 INFO - 'USER': 'cltbld', 10:05:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:56 INFO - '_': '/tools/buildbot/bin/python'} 10:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:56 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 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 10:05:57 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:58 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 10:05:58 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 10:05:58 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 10:05:58 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 10:05:58 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 10:05:58 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 10:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:58 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 10:05:58 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 10:05:58 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 10:05:58 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 10:05:58 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 10:05:58 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 10:05:58 INFO - Downloading docopt-0.6.1.tar.gz 10:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:58 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:58 INFO - Running setup.py install for blobuploader 10:05:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:58 INFO - Running setup.py install for requests 10:05:59 INFO - Running setup.py install for docopt 10:05:59 INFO - Successfully installed blobuploader requests docopt 10:05:59 INFO - Cleaning up... 10:05:59 INFO - Return code: 0 10:05:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:59 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 0x253a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2632a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, '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-1493917152.670997-537101294', '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 10:05:59 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 10:05:59 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 10:05:59 INFO - Using env: {'DISPLAY': ':0', 10:05:59 INFO - 'HOME': '/home/cltbld', 10:05:59 INFO - 'LANG': 'en_US.UTF-8', 10:05:59 INFO - 'LANGUAGE': 'en_US:en', 10:05:59 INFO - 'LOGNAME': 'cltbld', 10:05:59 INFO - 'MAIL': '/var/mail/cltbld', 10:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:59 INFO - 'MOZ_NO_REMOTE': '1', 10:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:59 INFO - 'NO_EM_RESTART': '1', 10:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:59 INFO - 'PWD': '/builds/slave/test', 10:05:59 INFO - 'SHELL': '/bin/bash', 10:05:59 INFO - 'SHLVL': '1', 10:05:59 INFO - 'TERM': 'linux', 10:05:59 INFO - 'TMOUT': '86400', 10:05:59 INFO - 'USER': 'cltbld', 10:05:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:59 INFO - '_': '/tools/buildbot/bin/python'} 10:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:59 INFO - Running setup.py (path:/tmp/pip-w5SnFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:59 INFO - Running setup.py (path:/tmp/pip-Z6VlZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:59 INFO - Running setup.py (path:/tmp/pip-t91z10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:59 INFO - Running setup.py (path:/tmp/pip-BDBJBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:59 INFO - Running setup.py (path:/tmp/pip-x64T27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:59 INFO - Running setup.py (path:/tmp/pip-l5c6rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:59 INFO - Running setup.py (path:/tmp/pip-1lRfX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:00 INFO - Running setup.py (path:/tmp/pip-Lgc0BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:00 INFO - Running setup.py (path:/tmp/pip-dwp1MG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:00 INFO - Running setup.py (path:/tmp/pip-XB1A8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:00 INFO - Running setup.py (path:/tmp/pip-ImZp8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:00 INFO - Running setup.py (path:/tmp/pip-7qMnRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:00 INFO - Running setup.py (path:/tmp/pip-TIN2q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:00 INFO - Running setup.py (path:/tmp/pip-aMGPLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:00 INFO - Running setup.py (path:/tmp/pip-b32clc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:00 INFO - Running setup.py (path:/tmp/pip-hDmGdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:00 INFO - Running setup.py (path:/tmp/pip-p43sax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:00 INFO - Running setup.py install for manifestparser 10:06:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:00 INFO - Running setup.py install for mozcrash 10:06:00 INFO - Running setup.py install for mozdebug 10:06:01 INFO - Running setup.py install for mozdevice 10:06:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:01 INFO - Running setup.py install for mozfile 10:06:01 INFO - Running setup.py install for mozhttpd 10:06:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:01 INFO - Running setup.py install for mozinfo 10:06:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:01 INFO - Running setup.py install for mozInstall 10:06:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:01 INFO - Running setup.py install for mozleak 10:06:01 INFO - Running setup.py install for mozlog 10:06:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:01 INFO - Running setup.py install for moznetwork 10:06:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:01 INFO - Running setup.py install for mozprocess 10:06:01 INFO - Running setup.py install for mozprofile 10:06:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:02 INFO - Running setup.py install for mozrunner 10:06:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:02 INFO - Running setup.py install for mozscreenshot 10:06:02 INFO - Running setup.py install for moztest 10:06:02 INFO - Running setup.py install for mozversion 10:06:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:02 INFO - Cleaning up... 10:06:02 INFO - Return code: 0 10:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:02 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 0x253a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2632a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, '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-1493917152.670997-537101294', '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 10:06:02 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 10:06:02 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 10:06:02 INFO - Using env: {'DISPLAY': ':0', 10:06:02 INFO - 'HOME': '/home/cltbld', 10:06:02 INFO - 'LANG': 'en_US.UTF-8', 10:06:02 INFO - 'LANGUAGE': 'en_US:en', 10:06:02 INFO - 'LOGNAME': 'cltbld', 10:06:02 INFO - 'MAIL': '/var/mail/cltbld', 10:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:02 INFO - 'MOZ_NO_REMOTE': '1', 10:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:02 INFO - 'NO_EM_RESTART': '1', 10:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:02 INFO - 'PWD': '/builds/slave/test', 10:06:02 INFO - 'SHELL': '/bin/bash', 10:06:02 INFO - 'SHLVL': '1', 10:06:02 INFO - 'TERM': 'linux', 10:06:02 INFO - 'TMOUT': '86400', 10:06:02 INFO - 'USER': 'cltbld', 10:06:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:02 INFO - '_': '/tools/buildbot/bin/python'} 10:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:02 INFO - Running setup.py (path:/tmp/pip-iEdXqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:02 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)) 10:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:02 INFO - Running setup.py (path:/tmp/pip-oo80L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:02 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)) 10:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:02 INFO - Running setup.py (path:/tmp/pip-76pQXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:02 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)) 10:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:02 INFO - Running setup.py (path:/tmp/pip-ak3dcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:03 INFO - Running setup.py (path:/tmp/pip-oN6wJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:03 INFO - Running setup.py (path:/tmp/pip-l8cagV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:03 INFO - Running setup.py (path:/tmp/pip-uwGOqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:03 INFO - Running setup.py (path:/tmp/pip-7lIcE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:03 INFO - Running setup.py (path:/tmp/pip-steEw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:03 INFO - Running setup.py (path:/tmp/pip-4T9fGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:03 INFO - Running setup.py (path:/tmp/pip-9sgfO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:03 INFO - Running setup.py (path:/tmp/pip-Ts4Irx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:03 INFO - Running setup.py (path:/tmp/pip-xRpNBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:03 INFO - Running setup.py (path:/tmp/pip-5Hc7UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:03 INFO - Running setup.py (path:/tmp/pip-sUO3XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:03 INFO - Running setup.py (path:/tmp/pip-hPvmzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:03 INFO - Running setup.py (path:/tmp/pip-G3hhcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:05 INFO - Downloading blessings-1.6.tar.gz 10:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:05 INFO - Installing collected packages: blessings 10:06:05 INFO - Running setup.py install for blessings 10:06:05 INFO - Successfully installed blessings 10:06:05 INFO - Cleaning up... 10:06:05 INFO - Return code: 0 10:06:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:05 INFO - Reading from file tmpfile_stdout 10:06:05 INFO - Current package versions: 10:06:05 INFO - argparse == 1.2.1 10:06:05 INFO - blessings == 1.6 10:06:05 INFO - blobuploader == 1.2.4 10:06:05 INFO - docopt == 0.6.1 10:06:05 INFO - functools32 == 3.2.3-2 10:06:05 INFO - jsonschema == 2.5.1 10:06:05 INFO - manifestparser == 1.1 10:06:05 INFO - mozInstall == 1.12 10:06:05 INFO - mozcrash == 1.0 10:06:05 INFO - mozdebug == 0.1 10:06:05 INFO - mozdevice == 0.50 10:06:05 INFO - mozfile == 1.2 10:06:05 INFO - mozhttpd == 0.7 10:06:05 INFO - mozinfo == 0.9 10:06:05 INFO - mozleak == 0.1 10:06:05 INFO - mozlog == 3.4 10:06:05 INFO - moznetwork == 0.27 10:06:05 INFO - mozprocess == 0.25 10:06:05 INFO - mozprofile == 0.28 10:06:05 INFO - mozrunner == 6.13 10:06:05 INFO - mozscreenshot == 0.1 10:06:05 INFO - mozsystemmonitor == 0.3 10:06:05 INFO - moztest == 0.8 10:06:05 INFO - mozversion == 1.4 10:06:05 INFO - psutil == 3.1.1 10:06:05 INFO - requests == 1.2.3 10:06:05 INFO - wsgiref == 0.1.2 10:06:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:05 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')]} 10:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:05 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')]} 10:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:05 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 0x253a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2632a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, '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-1493917152.670997-537101294', '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 10:06:05 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 10:06:05 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 10:06:05 INFO - Using env: {'DISPLAY': ':0', 10:06:05 INFO - 'HOME': '/home/cltbld', 10:06:05 INFO - 'LANG': 'en_US.UTF-8', 10:06:05 INFO - 'LANGUAGE': 'en_US:en', 10:06:05 INFO - 'LOGNAME': 'cltbld', 10:06:05 INFO - 'MAIL': '/var/mail/cltbld', 10:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:05 INFO - 'MOZ_NO_REMOTE': '1', 10:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:05 INFO - 'NO_EM_RESTART': '1', 10:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:05 INFO - 'PWD': '/builds/slave/test', 10:06:05 INFO - 'SHELL': '/bin/bash', 10:06:05 INFO - 'SHLVL': '1', 10:06:05 INFO - 'TERM': 'linux', 10:06:05 INFO - 'TMOUT': '86400', 10:06:05 INFO - 'USER': 'cltbld', 10:06:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:05 INFO - '_': '/tools/buildbot/bin/python'} 10:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:05 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)) 10:06:05 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)) 10:06:05 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)) 10:06:05 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)) 10:06:05 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)) 10:06:05 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)) 10:06:05 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)) 10:06:05 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)) 10:06:05 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)) 10:06:05 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)) 10:06:05 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)) 10:06:05 INFO - Cleaning up... 10:06:05 INFO - Return code: 0 10:06:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:05 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')]} 10:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:05 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')]} 10:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:05 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 0x253a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2632a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, '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-1493917152.670997-537101294', '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 10:06:05 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 10:06:05 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 10:06:05 INFO - Using env: {'DISPLAY': ':0', 10:06:05 INFO - 'HOME': '/home/cltbld', 10:06:05 INFO - 'LANG': 'en_US.UTF-8', 10:06:05 INFO - 'LANGUAGE': 'en_US:en', 10:06:05 INFO - 'LOGNAME': 'cltbld', 10:06:05 INFO - 'MAIL': '/var/mail/cltbld', 10:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:05 INFO - 'MOZ_NO_REMOTE': '1', 10:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:05 INFO - 'NO_EM_RESTART': '1', 10:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:05 INFO - 'PWD': '/builds/slave/test', 10:06:05 INFO - 'SHELL': '/bin/bash', 10:06:05 INFO - 'SHLVL': '1', 10:06:05 INFO - 'TERM': 'linux', 10:06:05 INFO - 'TMOUT': '86400', 10:06:05 INFO - 'USER': 'cltbld', 10:06:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:05 INFO - '_': '/tools/buildbot/bin/python'} 10:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:05 INFO - Cleaning up... 10:06:05 INFO - Return code: 0 10:06:05 INFO - Running post-action listener: _resource_record_post_action 10:06:05 INFO - Running post-action listener: _start_resource_monitoring 10:06:06 INFO - Starting resource monitoring. 10:06:06 INFO - [mozharness: 2017-05-04 17:06:06.013403Z] Finished create-virtualenv step (success) 10:06:06 INFO - [mozharness: 2017-05-04 17:06:06.013911Z] Running install step. 10:06:06 INFO - Running pre-action listener: _resource_record_pre_action 10:06:06 INFO - Running main action method: install 10:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:06 INFO - Reading from file tmpfile_stdout 10:06:06 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:06 INFO - Reading from file tmpfile_stdout 10:06:06 INFO - Output received: 10:06:06 INFO - Usage: mozinstall [options] installer 10:06:06 INFO - Options: 10:06:06 INFO - -h, --help show this help message and exit 10:06:06 INFO - -d DEST, --destination=DEST 10:06:06 INFO - Directory to install application into. [default: 10:06:06 INFO - "/builds/slave/test"] 10:06:06 INFO - --app=APP Application being installed. [default: firefox] 10:06:06 INFO - mkdir: /builds/slave/test/build/application 10:06:06 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'] 10:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:06:23 INFO - Reading from file tmpfile_stdout 10:06:23 INFO - Output received: 10:06:23 INFO - /builds/slave/test/build/application/firefox/firefox 10:06:23 INFO - Running post-action listener: _resource_record_post_action 10:06:23 INFO - [mozharness: 2017-05-04 17:06:23.070146Z] Finished install step (success) 10:06:23 INFO - [mozharness: 2017-05-04 17:06:23.070418Z] Running run-tests step. 10:06:23 INFO - Running pre-action listener: _resource_record_pre_action 10:06:23 INFO - Running main action method: run_tests 10:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:23 INFO - Python 2.7.3 10:06:23 INFO - Return code: 0 10:06:23 INFO - grabbing minidump binary from tooltool 10:06:23 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')]} 10:06:23 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 0x27d5290>, '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 0x27d5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d6040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:23 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 10:06:23 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 10:06:23 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 10:06:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:23 INFO - Return code: 0 10:06:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:06:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:23 INFO - ENV: RUST_BACKTRACE is now 1 10:06:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:06:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:23 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/ArH1QPTVQzy70sA-Zlw7xw/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 10:06:23 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/ArH1QPTVQzy70sA-Zlw7xw/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 10:06:23 INFO - Using env: {'DISPLAY': ':0', 10:06:23 INFO - 'HOME': '/home/cltbld', 10:06:23 INFO - 'LANG': 'en_US.UTF-8', 10:06:23 INFO - 'LANGUAGE': 'en_US:en', 10:06:23 INFO - 'LOGNAME': 'cltbld', 10:06:23 INFO - 'MAIL': '/var/mail/cltbld', 10:06:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:23 INFO - 'MOZ_NO_REMOTE': '1', 10:06:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:23 INFO - 'NO_EM_RESTART': '1', 10:06:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:23 INFO - 'PWD': '/builds/slave/test', 10:06:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:23 INFO - 'RUST_BACKTRACE': '1', 10:06:23 INFO - 'SHELL': '/bin/bash', 10:06:23 INFO - 'SHLVL': '1', 10:06:23 INFO - 'TERM': 'linux', 10:06:23 INFO - 'TMOUT': '86400', 10:06:23 INFO - 'USER': 'cltbld', 10:06:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493917152.670997-537101294', 10:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:23 INFO - '_': '/tools/buildbot/bin/python'} 10:06:23 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/ArH1QPTVQzy70sA-Zlw7xw/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 10:06:23 INFO - mozversion application_buildid: 20170504160921 10:06:23 INFO - mozversion application_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:06:23 INFO - mozversion application_display_name: Nightly 10:06:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:23 INFO - mozversion application_name: Firefox 10:06:23 INFO - mozversion application_remotingname: firefox 10:06:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:06:23 INFO - mozversion application_vendor: Mozilla 10:06:23 INFO - mozversion application_version: 55.0a1 10:06:23 INFO - mozversion platform_buildid: 20170504160921 10:06:23 INFO - mozversion platform_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:06:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:06:23 INFO - mozversion platform_version: 55.0a1 10:06:23 INFO - using testdate: 1493917583 10:06:23 INFO - actual date: 1493917583 10:06:23 INFO - starting webserver on 'localhost:55166' 10:06:23 INFO - SUITE-START | Running 2 tests 10:06:23 INFO - TEST-START | dromaeo_css 10:06:23 INFO - operating with platform_type : linux_ 10:06:23 INFO - Initialising browser for dromaeo_css test... 10:06:23 INFO - TEST-INFO | started process 14105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTJFzAZ/profile http://localhost:55166/getInfo.html) 10:06:27 INFO - PID 14105 | __metrics Screen width/height:1600/1200 10:06:27 INFO - PID 14105 | colorDepth:24 10:06:27 INFO - PID 14105 | Browser inner width/height: 1024/695 10:06:27 INFO - PID 14105 | __metrics 10:06:29 INFO - TEST-INFO | 14105: exit 0 10:06:29 INFO - Browser initialized. 10:06:29 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:29 INFO - TEST-INFO | started process 14283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTJFzAZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:41 INFO - PID 14283 | RSS: Main: 157122560 10:06:41 INFO - PID 14283 | 10:09:42 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:55166/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55166/tests/dromaeo/cssquery-ext.html) 10:09:44 INFO - PID 14283 | RSS: Main: 160813056 10:09:44 INFO - PID 14283 | 10:12:45 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:55166/tests/dromaeo/cssquery-ext.html (next: http://localhost:55166/tests/dromaeo/cssquery-jquery.html) 10:12:46 INFO - PID 14283 | RSS: Main: 156217344 10:12:46 INFO - PID 14283 | 10:15:48 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:55166/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55166/tests/dromaeo/cssquery-mootools.html) 10:15:48 INFO - PID 14283 | RSS: Main: 164171776 10:15:48 INFO - PID 14283 | 10:18:50 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:55166/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55166/tests/dromaeo/cssquery-prototype.html) 10:18:51 INFO - PID 14283 | RSS: Main: 158056448 10:18:51 INFO - PID 14283 | 10:21:53 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:55166/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55166/tests/dromaeo/cssquery-yui.html) 10:21:54 INFO - PID 14283 | RSS: Main: 160874496 10:21:54 INFO - PID 14283 | 10:24:55 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:55166/tests/dromaeo/cssquery-yui.html (next: http://localhost:55166/tests/dromaeo/cssquery-dojo.html) 10:24:56 INFO - PID 14283 | RSS: Main: 163364864 10:24:56 INFO - PID 14283 | 10:24:56 INFO - PID 14283 | __start_tp_report 10:24:56 INFO - PID 14283 | _x_x_mozilla_page_load 10:24:56 INFO - PID 14283 | _x_x_mozilla_page_load_details 10:24:56 INFO - PID 14283 | |i|pagename|runs| 10:24:56 INFO - PID 14283 | |0;dojo.html;3365.1923538350798;3373.4265174920247;3394.8302584870758;3399.2861499085193;3412.351653185896;5829.446202610745;5948.791792287271;5958;5959.821205363841;5990.730417131229;5770.798022069229;5867.266591676041;5956.047032474805;5964.910526342108;5967.940320596804;5185.274061631375;5195.19474481456;5244.423113457517;5248.448912864152;5263.552598029172;5315.707636080014;5316.12283973144;5361.276227709268;5367.06076436624;5367.2485851980755;5258.13240815265;5294.205869119624;5312.203169524563;5324.866878328034;5351.411344752074;5302.045631786277;5303.23103150045;5308.203769434577;5309.814156504503;5313.9734301328635;5262.447443018466;5278.551323137538;5291.814786482493;5295.761690723888;5313.681179129226;5862.50168735658;5867.882642347129;5880.176775251425;5909.734061967221;5948.078047902539;6373.808785736435;6388.425041746219;6389.808305750788;6401.231852177769;6403.327650596713;6420.646864422455;6421.8073457796345;6441.3880681335195;6442.581232219937;6447.161868957052;5836.066229403275;5917;5944.375840536682;5952.9702351488395;6009.008513595251;6538.673066346663;6578.309277525791;6597.505187110986;6615.966920165369;6619.073329733841;6155.169052177988;6179.196704428396;6199.287081985539;6272.5922815016875;6340.492760579143;6456.838579035561;6460.967695161494;6470.935290647128;6477.255115661759;6480.287168411565;6237.875242495215;6300;6311.211098612674;6376.171097757262;6418.390252925965;6414.711337989802;6440.6135631862235;6459.935400646027;6461.935380646228;6472.190976127984;4925.975370123198;4937.530934561211;4940.604751619861;4941.925871111936;4982.729404002029;4310.590493903074;4318.438602981592;4381.3208952612395;4382.386465894777;4396.824127034883;6037.54718396122;6044.335123136451;6044.455998960115;6068.575199736064;6090.147379366892;6420.678966051679;6424.293327733945;6484;6484.967575162094;6500.6424646643945;5860.912086318709;6000.33996260411;6035.969820150871;6045.063015232646;6050.576459647782;5504.284443022461;5520.944790552124;5541.362743284493;5541.778328866801;5552.194931734876;6628.801135965929;6708.563943343667;6710.932890671031;6722.630255336004;6747.865042699217;6407.871842563216;6424.100625912282;6456.418922297016;6492.091107245084;6509.316521765147;6662.300458451987;6736.5958042517605;6739.797806065826;6770.526063175727;6771.830704232433;6204.13142160089;6240.219972503437;6273.592216505913;6340.4293613575;6383.96808015957;6239.532035097295;6307.3377295383325;6481.222253329631;6534.052562378523;6544;6183.84540386494;6247.187865577446;6290.559660823881;6296.181496405438;6305.716242769178;6245.0632405139595;6245.500359971283;6248.4064013918605;6255.499560035278;6311.684415779101;6141.240538582634;6155.907661385172;6156.199694039746;6255.030470277115;6264;6346.397092276226;6353.14232578596;6371.267304260069;6381.457576106083;6389.297177310399;6112.297085835008;6170.969145154425;6176.073588961692;6176.536759743127;6201.658908760061 10:24:56 INFO - PID 14283 | |1;ext.html;738.4572339330591;789.6328207383566;817.7138001699404;1108.4180805077333;1126.791543564441;36453.635463645354;37589.43615845765;37598.24803503928;37604.43593346098;37635.43546846793;39116.608833911654;39295.80352098242;39592.40611390824;39597.60402395975;39683.20633587326;7117.466190035768;7124.572525648452;7128.572285662864;7139.78580642579;7342.229065948079;7327.9267207327775;7381.667824947864;7424.703011879518;7426.9628651856665;7453.888191677129;7437.702491900318;7456.701731930716;7482.3639990600595;7499.662515186802;7503.737369192079;7330.230325815766;7394.149672787591;7411.295926886937;7428.814279642998;7457.067866516685;7275.090613673291;7291.744788932362;7321.633918304116;7357.41140708742;7363.484556081076;36979.4453083204;37260.25479490422;37490.81254593737;37593.61657450843;37642;3569.0542006368332;3589.74871758977;3609.4405367168133;3625.4199328107375;3631.0196247013423;29439.11682649524;29633.407331853457;29684;29773.106806795615;29884;3771.8302676379353;3855.6722678572073;3858.594847540996;3870.651641352292;3883.0292426893275;195973;196778;214694;223272;224295.99999999837;47941.68524832712;48082;48224.75887620539;48347;48391;49236.26145607819;49720;49858;49933;50191.24713129306;15735.527934161993;15790.36838526469;15863.52409427696;15870.841291586936;15891.205439728199;12982.870171298355;13004.414801333962;13054.934725326502;13076.150050246704;13080.476780928846;14380.35288412024;14474.782878256834;14529.491467798787;14618.415263389345;14690.55928322152;5576.96826087167;5638.9436105638415;5718.914216286759;5726.455986681259;5786.88426231473;1070.1973519860105;1088.3034857691084;1090.8854570270166;1096.7313008312856;1097.9780404391868;26715.33211669724;26784.33039174036;27025.324366890985;27026.32434189161;27129.45741085207;1178.281248438452;1180.6753142885775;1200.117913333699;1221.5968730318973;1226.8466441694789;13796.172229666252;14042.36809343582;14153.221572813594;14249.358778854976;14252.928735356258;269727;271221;273271;273918;274128;55019.72490137524;55598;55664.44335556593;55765.16352254719;55895;1489.6946126044136;1517.7723341498863;1523.116592376419;1530.8469153084825;1537.36967843186;24809.25572232836;31102;31464.685353146175;31565.684343157194;31680.683193167773;53795.73102134464;53863.19205212003;54006.45993540014;54295.18557221566;54522.727386362814;225247.99008039496;226206;226266;226282;227128;35501.644983549835;35640.4653930186;36647.63352366442;36742.8162859184;37291.44062839005;44236.91275503358;46069.53930460652;46577.53422465732;47166;47347;33606.49590256197;33924;34201.65798341985;34897;35455.82272088623;33686.663133368354;34029.82985085059;34033.829830850686;34567.65432345745;34786.65213347834;40094.39858402068;40438.79780601196;40468;40666.79666601766;40765.18469630532;31605.92170281167;32535.186620333734;33137.66862331346;33566.49650255199;33753.662463375054;25064.37339066538;27293.863530682218;27411.451770964868;27514.724852751217;27657.14058350167 10:24:56 INFO - PID 14283 | |2;jquery.html;445.231974843395;448.93939318192054;451.3635773559282;465.897502549439;474.8860273534351;20044.1982320707;20395.592088158228;20696.372526834628;20907.954602269863;21117.57764844706;21881.562368752617;22444;22488.10047598094;23154.189603363884;23566.350355475082;5403.5136837684695;5470.699111548864;5553.111502159655;5571.359293681217;5581.860453488675;5411.323584551931;5487.780488780444;5517.5585953123655;5518.724063796794;5530.5022547970675;5296.285001524783;5484.122540393538;5511.889762204773;5514.117741161415;5516.668999860021;5417.59368047396;5489.451054894498;5515.227868098469;5521.779128834842;5546.77812887486;4880.6095512358925;5021.774020169101;5030.144875371159;5038.773255203525;5057.342545469065;25141.874290628613;25246.24261272165;25464.49071018569;25559.872200639064;25755.742442575523;2181.4437318483842;2181.520065585569;2190.4085896807933;2210.9668354974688;2212.7787221277904;17111.914440427718;17174.484765457055;17412;17658;17840.821591784046;2006.2175751456944;2064.3394113883564;2068.5759419319;2085.592225247967;2086.029996051828;109850;113549.43225283903;120923;121838;122387;20334.898325508573;21067.8946605266;21119.788802111783;21162.78837211639;21818.18181818188;39203;39388.606113939066;39712;40424.55329913707;40526.39210411846;8959.641614335484;8965.641374344954;9315.813683726288;9358.532073396304;10999.61501347449;8782.824343513093;8836.293096552261;8882.777930551789;9064.184223419923;9128.40665356763;7757.224277572311;7762.6894924203525;7906.841863162819;7982.002249718786;8040.437169398086;2328.371339738295;2344.4256157241243;2370.19413399445;2391.5695174868692;2515.962260566093;1034.4930983818026;1077;1077.42357838556;1081.2809481694742;1083.7507373304184;21549.784502155093;21575.67636485454;21579.67630485544;21731.565368692536;21785.564288714137;1103.9282446640943;1108.0858291909208;1112.8775834658343;1114.3258328711013;1118.4128332625437;10940.56237750481;11548.076153907667;11640.941795291139;11676.941615292038;11767.941160294144;509510;526450;528096;530511;532671;86754;87358;87587;90231;93588;1211.9091068169923;1239.7768401687601;1258.8111783232405;1261.6341261034381;1265.1270623269913;17662.293508259525;17893.37373191932;17922.193501292735;18141.27434902589;18308.359207427675;40566.59433405746;40992.79503602463;41288.38067428931;42155.57844421516;42946;54708.89683273691;55320;55548;55864.720676397985;57919;9769.65528273195;9834.803303933739;9895.604175832887;10169.9491502542;10172.237082218715;15379.923100384427;15551.300191491184;15798.842011580196;16030.839691603402;16229.43196988147;13449;13582;13591.320433978459;13619.114757540729;13875.791863122264;10666.253362264568;10681.305715128492;11018.50416731265;11135.88864111381;12430.81353779676;11271.661850144508;13059.934700326437;13561.186328820302;13763;13969.650758731113;9795.265355098254;9845.310828241954;9896.87632649998;9936.701898943043;10148.441835699108;12036.578719744766;12139.878601213875;12332.876671233173;12551.493820741569;13670.31648417595 10:24:56 INFO - PID 14283 | |3;mootools.html;1371.8285214348207;1425.3372181935404;1432.2480697633748;1438.158677173854;1447.8841692664587;10777.568897244111;11259.268147570403;11276;11284.210105292612;11605.3036817791;11374.943125284362;11485.023772979286;11501.654950351482;11523.423828808567;11551.249168804023;2217.368050105716;2258.153192552793;2273.27255278311;2278.6012447821563;2283.6460348645987;2148.258850696507;2228.866268023916;2230.4981379189717;2236.9888150559223;2238.5858616155983;2155.030236393621;2160.935171944844;2181.4655409424636;2192.177933275022;2200.6038912995655;2196.253273886878;2199.571083638691;2237.328801359594;2238.9216377426874;2241.540484200735;2101.726775519188;2187.245400336881;2195.067096483988;2195.2316689158824;2222;11402.372869492174;11404.201705880592;11532.654020379317;11552.884471155265;11554.711132221677;6393.392627700361;6614.371634694697;6626.93373066268;6650.7339706411685;6662.233843108056;3968.9007774805573;4226.36604509323;4229.6827737919775;4253.340732186516;4285.485741710983;1369.8630136986321;1394.7698629726185;1427.9286035698278;1430.8712215900514;1451.8257809062875;16942.491725248263;17272.82727172725;17301.9618822871;17369;17391.913040434843;5530.972345138249;5673.063944449203;5876.353601103875;5928.555358348055;5930.673812940329;14412.207328596818;14485.78271325931;14486.782698259534;14495.710085798224;14553.345099470549;6814.352636499525;6821.829454263584;6872.244053154149;6874.140732408449;6877.690503927335;6034.456898879122;6143.692815359214;6285.937140628626;6289.40250676185;6299.338569450142;4590.97704511482;4717.5046620104395;4740.786664600101;4836.177849765549;4837.250226214942;1409.1052181864384;1449.6593300574357;1475.513080683372;1487.256371814093;1496.1098146602753;890.4879694175875;906.3655441191192;918.5223683684446;922.5110691333604;936.2369668720107;6433.1636887205295;6493.772717954849;6520.510961677893;6531.510136739764;6667.533272670867;654.1463390275736;657.3919124809532;658.0425480925243;664.5846346033729;674.4705406256065;4248.787560621957;4743.739094349844;4899.118158731462;5210.921836172461;5335.093034184198;15025.173615451036;15029.248537573296;15521.301541430663;15529.223538823013;15572.688546229012;14999;15115.697686046438;15333.693326133414;15395.61510962235;15518.767218491732;9513.904860951441;9524.714258572254;9561.665341713007;9637.662681806243;9770.951145244228;7182.533135346186;7273.454490913097;7314.341709246193;7377.8155546111775;7399.889001664872;13144.277064761147;13183.14309569875;13262.27057511846;13459.79810302866;13494.32528373597;14062.789058163931;14098.718025639635;14112.717745644824;14296.714065718836;14488.275586220858;9320.207782338306;9389.85915211286;9715.514224288898;9799.167070799062;9818.607255709692;11256.099512038854;11276.605318813803;11305.830412543983;11386.43067846621;11396.145289103184;9257.814843702954;9373.718788436357;9379.249660027044;9398.718038458857;9481.525923703924;9058.094190580889;9123.361364704408;9283.814323713354;9448.527573621428;9485.620575176916;8559.61481733336;8661.52361620117;8715.17205865467;8724.083971182934;8727.127287271222;6346;6348.682565871595;6378.968105159444;6447.258565265054;6472;6352.189625956765;6477.4170324671;6512.088307637029;6564.212294524687;6579.572327798678 10:24:56 INFO - PID 14283 | |4;prototype.html;427.73480442125884;427.9743215407075;429.30666972838867;437.6673727966746;440.537435692523;5998.010328295837;6244.157038799761;6273.278572964105;6290.1822763040855;6318.684065796715;6029.3772209089075;6122.785702500413;6141.232345956755;6156.415140561639;6161.691915404234;4547.863564093074;4627.583517483426;4629.629629629621;4636.675432719711;4652.418447694038;4631.374764406813;4634.536546345372;4643.721376717391;4651.186042442576;4670.369500117475;4581.381513495686;4629.768511574424;4641.280601506755;4645.303204519332;4647.72113673179;4547.977260113695;4573.935463239604;4575.748333841638;4586.88532786678;4597.3333866589155;3990.38149086892;3994.520657521087;3996.3406038003695;3999.7200195986293;4012.979935100335;5834.4165583441745;5966.403359664042;5999.430054144849;6019.729112189962;6064.484518815906;5368.114261146906;5385.892282154335;5401.918971215435;5439.673619582838;5458.4814442627885;6468.3208263132165;6502.219733631994;6507.414332710079;6532.542722009462;6533.542652014361;4394.758288294142;4498.595126438636;4503.211937910853;4517.051419201972;4552.772361381951;6674.232463266738;6863.6568171591225;6879.452123272224;6919.515633905628;6919.8962015569805;4584.106099310669;4619.307103934437;4628.190066738307;4640.744759038285;4651.2557990721325;4616.930746038812;4643.187442197602;4685.250359942393;4689.976550117228;4707.670463067621;5264.104742391669;5420.295361602966;5442.619016668875;5445.346558413015;5468.0977638689965;6545;6572.638504882182;6583;6585.506087043491;6608.933910660832;1586.111777404657;1604.9438269660507;1623.7889074420486;1629.54372775623;1630.4619475573033;1059.5602824827765;1078.229066217658;1087.8857719939451;1089.455272363818;1098.423327752936;6308.085327627468;6318.462930650946;6324.747010119636;6326.5958935605095;6344.714487848058;6539.607623542603;6762.357576030269;6780;6809;6813.420859226922;6287.056941458726;6289.591176573508;6289.905651415233;6292.150559674477;6320.936790632127;3492.0746002309406;3561.4301711726;3579.2125732338845;3603.009172477537;3609.5668519777796;7057.6118313492225;7097.787066388017;7111.431085513146;7129.39400150993;7141.321574450419;6809.001157689177;6833.214180369321;6853.7943861684225;6867.141607299088;6916.757913473004;7003.824904377431;7009.509334346547;7059.223485416703;7060.364567188978;7135.571865688075;6484.319146489551;6709.496787741036;6712.563683360566;6714.374237911473;6721.630310332783;6537.8692426152165;6636.668166591748;6670.466362691071;6681.265060843206;6694.330566943267;7088.645567721696;7144.892541656051;7146.499745018007;7150.499465037606;7167.534110282815;4651.837185698484;4673.088747694167;4676.345311656439;4685.367475390779;4693.788779504862;6712.93287067123;6798.966005169942;6801.592733776561;6828.487863410165;6848;6484.351564843478;6594.934050659432;6603;6628.734850605922;6641.103451034049;6440.162778838721;6533.901991470227;6550;6589.8039450865335;6613.570117942319;6602.7689030883685;6603.20761508622;6615.106960560262;6627.900581491378;6642.136522252076;6483.7730679425995;6612.70242839083;6661.500387470862;6665.533412661067;6675.699593518206;6405.615663060231;6428.228612566522;6443.9355606445215;6444.967775161282;6454 10:24:56 INFO - PID 14283 | |5;yui.html;855.9426735853718;877.2630989968425;879.5953861223837;882.285348867417;901.7700486375974;15962;17156.3137474501;17259.223334949926;17312.913435432805;18404.723929141073;17014;17353.826461735378;18045.368412105578;18480;18783.62432751344;994.3089552760816;1014.1227837920183;1017.1100287248657;1021.5913634546166;1022.5705203814416;996;1034.6689059500925;1039.8024375368693;1042.4370839746528;1043.9530221140028;1084.4469320646488;1087.8912108789136;1093.7156339351745;1095.956161753529;1096.1121491591796;1073.3559864081567;1079.0450451350612;1083.9295445796038;1084.8752393474772;1086.896744809242;788.7515432638758;791.4578513718121;793.0879488588112;797.1231645190302;798.7164556582446;16049.2777824997;16273.023618582924;16413.917930410273;17262.741058884127;17405;18168.909155454272;18645.53386165343;18702.90648546762;18798.90600547002;18983.145758440904;13937;13989.160650361011;14124.505642302573;14125.78811317831;14360.138391696531;3382.289719158955;3410.28384039352;3412.3516531859113;3412.744044196695;3415.299863527971;87216.56391718064;87872.56063719641;88172.32116207291;88819.55590222008;88904.11095889023;13493.32533373347;13504.729905401837;13513.66215844592;13519.662008449868;13610.455581776618;22368.664470032963;23175.536489270457;23337;23385.064597415912;25471.872640636677;7300.306470885257;7546.886796698054;7553;7566.886496702554;7593.620318984029;3988.8404463821703;4002.1795531915886;4051.5745846686264;4089.3661482470266;4139.0480189555965;4658.440987081572;4731.053789242165;4734.763261836894;4739.786709598076;4775.355327030876;950.8668786369914;964.3105179796479;965.5220665770348;1008.2639673038723;1014.4521958142668;716.3230746944088;721.5886944441722;732.3299181249098;743.2827321634649;760.5512747479014;11773.23473974206;11961.574217539392;12417.254964702146;12575.434105465276;12816.55142070023;742.3133601418774;750.2272659161073;753.3370633842184;753.9962300188464;762.7063580521539;5079.111155547838;5605.243292155506;5727.342721605461;5847.8245652630485;5918.496927761103;81570;81613;81837;82554;85142;70019.29980700128;70940.2905970944;71847.92228116583;74530;75507.24492755003;64008;65013;65144.67427662831;65661.67169164219;66228.33771662318;10950.34297942126;11032.779344412906;11349.4892729829;12309.32298723543;13458.932705336802;33150.668493314755;33583.16042098967;33986.83006584951;34056;35294;53511.19733204083;53675.463245368606;53679.46320536744;54508.90982180255;57252.713736431055;17257.137143142543;17593.736093958858;17836.821631783518;17900.820991790435;18197.636047279244;17687.292508299524;17814.109294534963;17970.550736231176;18321.083945802922;19741.901290493457;17249.482515524553;18296.634067318846;18602.720959185353;18943.90528047351;19056.237750489825;17530.824691752918;17615.82384176142;17760.289588416836;17805.287788488316;18103.456896293133;16603.66792664116;16669.66660666804;16742.832571674615;16776.916115419346;17231;10229.590816367261;10242.334248274137;10257.948710256402;10571.471426428801;10659.307145035547;11817.231879927776;12462.750744985231;12602.810957835456;12626.053046021769;12759.80860287115 10:24:56 INFO - PID 14283 | __end_tp_report 10:24:56 INFO - PID 14283 | __start_cc_report 10:24:56 INFO - PID 14283 | _x_x_mozilla_cycle_collect,331 10:24:56 INFO - PID 14283 | __end_cc_report 10:24:56 INFO - PID 14283 | __startTimestamp1493918696101__endTimestamp 10:24:56 INFO - PID 14283 | 10:24:56 INFO - PID 14283 | ------- Summary: start ------- 10:24:56 INFO - PID 14283 | Number of tests: 6 10:24:56 INFO - PID 14283 | 10:24:56 INFO - PID 14283 | [#0] dojo.html Cycles:165 Average:5928.65 Median:6176.54 stddev:711.39 (11.5%) stddev-sans-first:684.56 10:24:56 INFO - PID 14283 | Values: 3365.2 3373.4 3394.8 3399.3 3412.4 5829.4 5948.8 5958.0 5959.8 5990.7 5770.8 5867.3 5956.0 5964.9 5967.9 5185.3 5195.2 5244.4 5248.4 5263.6 5315.7 5316.1 5361.3 5367.1 5367.2 5258.1 5294.2 5312.2 5324.9 5351.4 5302.0 5303.2 5308.2 5309.8 5314.0 5262.4 5278.6 5291.8 5295.8 5313.7 5862.5 5867.9 5880.2 5909.7 5948.1 6373.8 6388.4 6389.8 6401.2 6403.3 6420.6 6421.8 6441.4 6442.6 6447.2 5836.1 5917.0 5944.4 5953.0 6009.0 6538.7 6578.3 6597.5 6616.0 6619.1 6155.2 6179.2 6199.3 6272.6 6340.5 6456.8 6461.0 6470.9 6477.3 6480.3 6237.9 6300.0 6311.2 6376.2 6418.4 6414.7 6440.6 6459.9 6461.9 6472.2 4926.0 4937.5 4940.6 4941.9 4982.7 4310.6 4318.4 4381.3 4382.4 4396.8 6037.5 6044.3 6044.5 6068.6 6090.1 6420.7 6424.3 6484.0 6485.0 6500.6 5860.9 6000.3 6036.0 6045.1 6050.6 5504.3 5520.9 5541.4 5541.8 5552.2 6628.8 6708.6 6710.9 6722.6 6747.9 6407.9 6424.1 6456.4 6492.1 6509.3 6662.3 6736.6 6739.8 6770.5 6771.8 6204.1 6240.2 6273.6 6340.4 6384.0 6239.5 6307.3 6481.2 6534.1 6544.0 6183.8 6247.2 6290.6 6296.2 6305.7 6245.1 6245.5 6248.4 6255.5 6311.7 6141.2 6155.9 6156.2 6255.0 6264.0 6346.4 6353.1 6371.3 6381.5 6389.3 6112.3 6171.0 6176.1 6176.5 6201.7 10:24:56 INFO - PID 14283 | 10:24:56 INFO - PID 14283 | [#1] ext.html Cycles:180 Average:41170.85 Median:3599.59 stddev:61906.68 (1719.8%) stddev-sans-first:62005.90 10:24:56 INFO - PID 14283 | Values: 738.5 789.6 817.7 1108.4 1126.8 36453.6 37589.4 37598.2 37604.4 37635.4 39116.6 39295.8 39592.4 39597.6 39683.2 7117.5 7124.6 7128.6 7139.8 7342.2 7327.9 7381.7 7424.7 7427.0 7453.9 7437.7 7456.7 7482.4 7499.7 7503.7 7330.2 7394.1 7411.3 7428.8 7457.1 7275.1 7291.7 7321.6 7357.4 7363.5 36979.4 37260.3 37490.8 37593.6 37642.0 3569.1 3589.7 3609.4 3625.4 3631.0 29439.1 29633.4 29684.0 29773.1 29884.0 3771.8 3855.7 3858.6 3870.7 3883.0 195973.0 196778.0 214694.0 223272.0 224296.0 47941.7 48082.0 48224.8 48347.0 48391.0 49236.3 49720.0 49858.0 49933.0 50191.2 15735.5 15790.4 15863.5 15870.8 15891.2 12982.9 13004.4 13054.9 13076.2 13080.5 14380.4 14474.8 14529.5 14618.4 14690.6 5577.0 5638.9 5718.9 5726.5 5786.9 1070.2 1088.3 1090.9 1096.7 1098.0 26715.3 26784.3 27025.3 27026.3 27129.5 1178.3 1180.7 1200.1 1221.6 1226.8 13796.2 14042.4 14153.2 14249.4 14252.9 269727.0 271221.0 273271.0 273918.0 274128.0 55019.7 55598.0 55664.4 55765.2 55895.0 1489.7 1517.8 1523.1 1530.8 1537.4 24809.3 31102.0 31464.7 31565.7 31680.7 53795.7 53863.2 54006.5 54295.2 54522.7 225248.0 226206.0 226266.0 226282.0 227128.0 35501.6 35640.5 36647.6 36742.8 37291.4 44236.9 46069.5 46577.5 47166.0 47347.0 33606.5 33924.0 34201.7 34897.0 35455.8 33686.7 34029.8 34033.8 34567.7 34786.7 40094.4 40438.8 40468.0 40666.8 40765.2 31605.9 32535.2 33137.7 33566.5 33753.7 25064.4 27293.9 27411.5 27514.7 27657.1 10:24:56 INFO - PID 14283 | 10:24:56 INFO - PID 14283 | [#2] jquery.html Cycles:180 Average:32724.02 Median:22466.05 stddev:86945.66 (387.0%) stddev-sans-first:87155.79 10:24:56 INFO - PID 14283 | Values: 445.2 448.9 451.4 465.9 474.9 20044.2 20395.6 20696.4 20908.0 21117.6 21881.6 22444.0 22488.1 23154.2 23566.4 5403.5 5470.7 5553.1 5571.4 5581.9 5411.3 5487.8 5517.6 5518.7 5530.5 5296.3 5484.1 5511.9 5514.1 5516.7 5417.6 5489.5 5515.2 5521.8 5546.8 4880.6 5021.8 5030.1 5038.8 5057.3 25141.9 25246.2 25464.5 25559.9 25755.7 2181.4 2181.5 2190.4 2211.0 2212.8 17111.9 17174.5 17412.0 17658.0 17840.8 2006.2 2064.3 2068.6 2085.6 2086.0 109850.0 113549.4 120923.0 121838.0 122387.0 20334.9 21067.9 21119.8 21162.8 21818.2 39203.0 39388.6 39712.0 40424.6 40526.4 8959.6 8965.6 9315.8 9358.5 10999.6 8782.8 8836.3 8882.8 9064.2 9128.4 7757.2 7762.7 7906.8 7982.0 8040.4 2328.4 2344.4 2370.2 2391.6 2516.0 1034.5 1077.0 1077.4 1081.3 1083.8 21549.8 21575.7 21579.7 21731.6 21785.6 1103.9 1108.1 1112.9 1114.3 1118.4 10940.6 11548.1 11640.9 11676.9 11767.9 509510.0 526450.0 528096.0 530511.0 532671.0 86754.0 87358.0 87587.0 90231.0 93588.0 1211.9 1239.8 1258.8 1261.6 1265.1 17662.3 17893.4 17922.2 18141.3 18308.4 40566.6 40992.8 41288.4 42155.6 42946.0 54708.9 55320.0 55548.0 55864.7 57919.0 9769.7 9834.8 9895.6 10169.9 10172.2 15379.9 15551.3 15798.8 16030.8 16229.4 13449.0 13582.0 13591.3 13619.1 13875.8 10666.3 10681.3 11018.5 11135.9 12430.8 11271.7 13059.9 13561.2 13763.0 13969.7 9795.3 9845.3 9896.9 9936.7 10148.4 12036.6 12139.9 12332.9 12551.5 13670.3 10:24:56 INFO - PID 14283 | 10:24:56 INFO - PID 14283 | [#3] mootools.html Cycles:180 Average:7358.22 Median:4097.63 stddev:4717.04 (115.1%) stddev-sans-first:4708.82 10:24:56 INFO - PID 14283 | Values: 1371.8 1425.3 1432.2 1438.2 1447.9 10777.6 11259.3 11276.0 11284.2 11605.3 11374.9 11485.0 11501.7 11523.4 11551.2 2217.4 2258.2 2273.3 2278.6 2283.6 2148.3 2228.9 2230.5 2237.0 2238.6 2155.0 2160.9 2181.5 2192.2 2200.6 2196.3 2199.6 2237.3 2238.9 2241.5 2101.7 2187.2 2195.1 2195.2 2222.0 11402.4 11404.2 11532.7 11552.9 11554.7 6393.4 6614.4 6626.9 6650.7 6662.2 3968.9 4226.4 4229.7 4253.3 4285.5 1369.9 1394.8 1427.9 1430.9 1451.8 16942.5 17272.8 17302.0 17369.0 17391.9 5531.0 5673.1 5876.4 5928.6 5930.7 14412.2 14485.8 14486.8 14495.7 14553.3 6814.4 6821.8 6872.2 6874.1 6877.7 6034.5 6143.7 6285.9 6289.4 6299.3 4591.0 4717.5 4740.8 4836.2 4837.3 1409.1 1449.7 1475.5 1487.3 1496.1 890.5 906.4 918.5 922.5 936.2 6433.2 6493.8 6520.5 6531.5 6667.5 654.1 657.4 658.0 664.6 674.5 4248.8 4743.7 4899.1 5210.9 5335.1 15025.2 15029.2 15521.3 15529.2 15572.7 14999.0 15115.7 15333.7 15395.6 15518.8 9513.9 9524.7 9561.7 9637.7 9771.0 7182.5 7273.5 7314.3 7377.8 7399.9 13144.3 13183.1 13262.3 13459.8 13494.3 14062.8 14098.7 14112.7 14296.7 14488.3 9320.2 9389.9 9715.5 9799.2 9818.6 11256.1 11276.6 11305.8 11386.4 11396.1 9257.8 9373.7 9379.2 9398.7 9481.5 9058.1 9123.4 9283.8 9448.5 9485.6 8559.6 8661.5 8715.2 8724.1 8727.1 6346.0 6348.7 6379.0 6447.3 6472.0 6352.2 6477.4 6512.1 6564.2 6579.6 10:24:56 INFO - PID 14283 | 10:24:56 INFO - PID 14283 | [#4] prototype.html Cycles:180 Average:5476.43 Median:6290.04 stddev:1672.70 (26.6%) stddev-sans-first:1633.90 10:24:56 INFO - PID 14283 | Values: 427.7 428.0 429.3 437.7 440.5 5998.0 6244.2 6273.3 6290.2 6318.7 6029.4 6122.8 6141.2 6156.4 6161.7 4547.9 4627.6 4629.6 4636.7 4652.4 4631.4 4634.5 4643.7 4651.2 4670.4 4581.4 4629.8 4641.3 4645.3 4647.7 4548.0 4573.9 4575.7 4586.9 4597.3 3990.4 3994.5 3996.3 3999.7 4013.0 5834.4 5966.4 5999.4 6019.7 6064.5 5368.1 5385.9 5401.9 5439.7 5458.5 6468.3 6502.2 6507.4 6532.5 6533.5 4394.8 4498.6 4503.2 4517.1 4552.8 6674.2 6863.7 6879.5 6919.5 6919.9 4584.1 4619.3 4628.2 4640.7 4651.3 4616.9 4643.2 4685.3 4690.0 4707.7 5264.1 5420.3 5442.6 5445.3 5468.1 6545.0 6572.6 6583.0 6585.5 6608.9 1586.1 1604.9 1623.8 1629.5 1630.5 1059.6 1078.2 1087.9 1089.5 1098.4 6308.1 6318.5 6324.7 6326.6 6344.7 6539.6 6762.4 6780.0 6809.0 6813.4 6287.1 6289.6 6289.9 6292.2 6320.9 3492.1 3561.4 3579.2 3603.0 3609.6 7057.6 7097.8 7111.4 7129.4 7141.3 6809.0 6833.2 6853.8 6867.1 6916.8 7003.8 7009.5 7059.2 7060.4 7135.6 6484.3 6709.5 6712.6 6714.4 6721.6 6537.9 6636.7 6670.5 6681.3 6694.3 7088.6 7144.9 7146.5 7150.5 7167.5 4651.8 4673.1 4676.3 4685.4 4693.8 6712.9 6799.0 6801.6 6828.5 6848.0 6484.4 6594.9 6603.0 6628.7 6641.1 6440.2 6533.9 6550.0 6589.8 6613.6 6602.8 6603.2 6615.1 6627.9 6642.1 6483.8 6612.7 6661.5 6665.5 6675.7 6405.6 6428.2 6443.9 6445.0 6454.0 10:24:56 INFO - PID 14283 | 10:24:56 INFO - PID 14283 | [#5] yui.html Cycles:180 Average:19124.20 Median:18871.41 stddev:23373.95 (123.9%) stddev-sans-first:23399.27 10:24:56 INFO - PID 14283 | Values: 855.9 877.3 879.6 882.3 901.8 15962.0 17156.3 17259.2 17312.9 18404.7 17014.0 17353.8 18045.4 18480.0 18783.6 994.3 1014.1 1017.1 1021.6 1022.6 996.0 1034.7 1039.8 1042.4 1044.0 1084.4 1087.9 1093.7 1096.0 1096.1 1073.4 1079.0 1083.9 1084.9 1086.9 788.8 791.5 793.1 797.1 798.7 16049.3 16273.0 16413.9 17262.7 17405.0 18168.9 18645.5 18702.9 18798.9 18983.1 13937.0 13989.2 14124.5 14125.8 14360.1 3382.3 3410.3 3412.4 3412.7 3415.3 87216.6 87872.6 88172.3 88819.6 88904.1 13493.3 13504.7 13513.7 13519.7 13610.5 22368.7 23175.5 23337.0 23385.1 25471.9 7300.3 7546.9 7553.0 7566.9 7593.6 3988.8 4002.2 4051.6 4089.4 4139.0 4658.4 4731.1 4734.8 4739.8 4775.4 950.9 964.3 965.5 1008.3 1014.5 716.3 721.6 732.3 743.3 760.6 11773.2 11961.6 12417.3 12575.4 12816.6 742.3 750.2 753.3 754.0 762.7 5079.1 5605.2 5727.3 5847.8 5918.5 81570.0 81613.0 81837.0 82554.0 85142.0 70019.3 70940.3 71847.9 74530.0 75507.2 64008.0 65013.0 65144.7 65661.7 66228.3 10950.3 11032.8 11349.5 12309.3 13458.9 33150.7 33583.2 33986.8 34056.0 35294.0 53511.2 53675.5 53679.5 54508.9 57252.7 17257.1 17593.7 17836.8 17900.8 18197.6 17687.3 17814.1 17970.6 18321.1 19741.9 17249.5 18296.6 18602.7 18943.9 19056.2 17530.8 17615.8 17760.3 17805.3 18103.5 16603.7 16669.7 16742.8 16776.9 17231.0 10229.6 10242.3 10257.9 10571.5 10659.3 11817.2 12462.8 12602.8 12626.1 12759.8 10:24:56 INFO - PID 14283 | -------- Summary: end -------- 10:24:56 INFO - PID 14283 | 10:24:56 INFO - TEST-INFO | 14283: exit 0 10:24:56 INFO - TEST-OK | dromaeo_css | took 1113548ms 10:24:56 INFO - TEST-START | kraken 10:24:56 INFO - operating with platform_type : linux_ 10:24:56 INFO - Initialising browser for kraken test... 10:24:56 INFO - TEST-INFO | started process 14704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4auDMP/profile http://localhost:55166/getInfo.html) 10:25:00 INFO - PID 14704 | __metrics Screen width/height:1600/1200 10:25:00 INFO - PID 14704 | colorDepth:24 10:25:00 INFO - PID 14704 | Browser inner width/height: 1024/695 10:25:00 INFO - PID 14704 | __metrics 10:25:02 INFO - TEST-INFO | 14704: exit 0 10:25:02 INFO - Browser initialized. 10:25:02 INFO - Running cycle 1/1 for kraken test... 10:25:02 INFO - TEST-INFO | started process 14882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4auDMP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:14 INFO - PID 14882 | RSS: Main: 156553216 10:25:14 INFO - PID 14882 | 10:25:17 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55166/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:18 INFO - PID 14882 | RSS: Main: 163176448 10:25:18 INFO - PID 14882 | 10:25:20 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55166/tests/kraken/driver.html?testName=audio-dft) 10:25:21 INFO - PID 14882 | RSS: Main: 160804864 10:25:21 INFO - PID 14882 | 10:25:24 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55166/tests/kraken/driver.html?testName=audio-fft) 10:25:24 INFO - PID 14882 | RSS: Main: 157315072 10:25:24 INFO - PID 14882 | 10:25:26 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55166/tests/kraken/driver.html?testName=audio-oscillator) 10:25:27 INFO - PID 14882 | RSS: Main: 158470144 10:25:27 INFO - PID 14882 | 10:25:29 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55166/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:29 INFO - PID 14882 | RSS: Main: 158408704 10:25:29 INFO - PID 14882 | 10:25:32 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55166/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:33 INFO - PID 14882 | RSS: Main: 163655680 10:25:33 INFO - PID 14882 | 10:25:36 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55166/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:37 INFO - PID 14882 | RSS: Main: 165707776 10:25:37 INFO - PID 14882 | 10:25:40 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55166/tests/kraken/driver.html?testName=json-parse-financial) 10:25:40 INFO - PID 14882 | RSS: Main: 165052416 10:25:40 INFO - PID 14882 | 10:25:42 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55166/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:42 INFO - PID 14882 | RSS: Main: 165306368 10:25:42 INFO - PID 14882 | 10:25:44 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55166/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:45 INFO - PID 14882 | RSS: Main: 164790272 10:25:45 INFO - PID 14882 | 10:25:47 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55166/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:47 INFO - PID 14882 | RSS: Main: 164720640 10:25:47 INFO - PID 14882 | 10:25:50 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:51 INFO - PID 14882 | RSS: Main: 164683776 10:25:51 INFO - PID 14882 | 10:25:54 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:54 INFO - PID 14882 | RSS: Main: 164720640 10:25:54 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | Cycle 1(1): loaded http://localhost:55166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55166/tests/kraken/driver.html?testName=ai-astar) 10:25:56 INFO - PID 14882 | RSS: Main: 166400000 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | __start_tp_report 10:25:56 INFO - PID 14882 | _x_x_mozilla_page_load 10:25:56 INFO - PID 14882 | _x_x_mozilla_page_load_details 10:25:56 INFO - PID 14882 | |i|pagename|runs| 10:25:56 INFO - PID 14882 | |0;ai-astar;102;111;110;110;110;110;111;111;112;110 10:25:56 INFO - PID 14882 | |1;audio-beat-detection;149;116;125;164;122;118;118;118;143;120 10:25:56 INFO - PID 14882 | |2;audio-dft;162;162;163;164;163;163;165;167;172;160 10:25:56 INFO - PID 14882 | |3;audio-fft;74;76;75;100;76;74;75;76;97;74 10:25:56 INFO - PID 14882 | |4;audio-oscillator;82;80;102;82;82;82;97;82;81;106 10:25:56 INFO - PID 14882 | |5;imaging-gaussian-blur;114;113;114;114;114;115;115;114;114;115 10:25:56 INFO - PID 14882 | |6;imaging-darkroom;148;148;149;148;148;148;149;150;148;148 10:25:56 INFO - PID 14882 | |7;imaging-desaturate;94;94;94;95;95;95;94;94;95;95 10:25:56 INFO - PID 14882 | |8;json-parse-financial;49;47;47;47;50;51;48;52;48;47 10:25:56 INFO - PID 14882 | |9;json-stringify-tinderbox;54;53;54;54;54;55;54;54;54;54 10:25:56 INFO - PID 14882 | |10;stanford-crypto-aes;83;82;82;81;81;80;83;83;82;81 10:25:56 INFO - PID 14882 | |11;stanford-crypto-ccm;129;126;131;127;125;127;130;126;173;141 10:25:56 INFO - PID 14882 | |12;stanford-crypto-pbkdf2;183;184;193;187;189;178;180;182;182;180 10:25:56 INFO - PID 14882 | |13;stanford-crypto-sha256-iterative;76;70;71;69;65;67;68;68;66;65 10:25:56 INFO - PID 14882 | __end_tp_report 10:25:56 INFO - PID 14882 | __start_cc_report 10:25:56 INFO - PID 14882 | _x_x_mozilla_cycle_collect,763 10:25:56 INFO - PID 14882 | __end_cc_report 10:25:56 INFO - PID 14882 | __startTimestamp1493918756891__endTimestamp 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | ------- Summary: start ------- 10:25:56 INFO - PID 14882 | Number of tests: 14 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.79 (2.5%) stddev-sans-first:0.73 10:25:56 INFO - PID 14882 | Values: 102.0 111.0 110.0 110.0 110.0 110.0 111.0 111.0 112.0 110.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:123.50 stddev:16.66 (13.5%) stddev-sans-first:16.07 10:25:56 INFO - PID 14882 | Values: 149.0 116.0 125.0 164.0 122.0 118.0 118.0 118.0 143.0 120.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.35 (2.0%) stddev-sans-first:3.46 10:25:56 INFO - PID 14882 | Values: 162.0 162.0 163.0 164.0 163.0 163.0 165.0 167.0 172.0 160.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#3] audio-fft Cycles:10 Average:79.70 Median:75.50 stddev:9.97 (13.2%) stddev-sans-first:10.36 10:25:56 INFO - PID 14882 | Values: 74.0 76.0 75.0 100.0 76.0 74.0 75.0 76.0 97.0 74.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:82.00 stddev:9.96 (12.1%) stddev-sans-first:10.35 10:25:56 INFO - PID 14882 | Values: 82.0 80.0 102.0 82.0 82.0 82.0 97.0 82.0 81.0 106.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 10:25:56 INFO - PID 14882 | Values: 114.0 113.0 114.0 114.0 114.0 115.0 115.0 114.0 114.0 115.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:25:56 INFO - PID 14882 | Values: 148.0 148.0 149.0 148.0 148.0 148.0 149.0 150.0 148.0 148.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 10:25:56 INFO - PID 14882 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#8] json-parse-financial Cycles:10 Average:48.60 Median:48.50 stddev:1.84 (3.8%) stddev-sans-first:1.94 10:25:56 INFO - PID 14882 | Values: 49.0 47.0 47.0 47.0 50.0 51.0 48.0 52.0 48.0 47.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 10:25:56 INFO - PID 14882 | Values: 54.0 53.0 54.0 54.0 54.0 55.0 54.0 54.0 54.0 54.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.03 (1.3%) stddev-sans-first:1.00 10:25:56 INFO - PID 14882 | Values: 83.0 82.0 82.0 81.0 81.0 80.0 83.0 83.0 82.0 81.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:129.50 stddev:14.62 (11.3%) stddev-sans-first:15.42 10:25:56 INFO - PID 14882 | Values: 129.0 126.0 131.0 127.0 125.0 127.0 130.0 126.0 173.0 141.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:183.50 stddev:4.61 (2.5%) stddev-sans-first:4.88 10:25:56 INFO - PID 14882 | Values: 183.0 184.0 193.0 187.0 189.0 178.0 180.0 182.0 182.0 180.0 10:25:56 INFO - PID 14882 | 10:25:56 INFO - PID 14882 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:3.31 (4.8%) stddev-sans-first:2.12 10:25:56 INFO - PID 14882 | Values: 76.0 70.0 71.0 69.0 65.0 67.0 68.0 68.0 66.0 65.0 10:25:56 INFO - PID 14882 | -------- Summary: end -------- 10:25:56 INFO - PID 14882 | 10:25:58 INFO - TEST-INFO | 14882: exit 0 10:25:58 INFO - TEST-OK | kraken | took 61184ms 10:25:58 INFO - SUITE-END | took 1174s 10:25:58 INFO - Completed test suite (00:19:35) 10:25:58 INFO - javascript benchmark 10:25:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7943.305776722084, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3365.1923538350798, 3373.4265174920247, 3394.8302584870758, 3399.2861499085193, 3412.351653185896, 5829.446202610745, 5948.791792287271, 5958.0, 5959.821205363841, 5990.730417131229, 5770.798022069229, 5867.266591676041, 5956.047032474805, 5964.910526342108, 5967.940320596804, 5185.274061631375, 5195.19474481456, 5244.423113457517, 5248.448912864152, 5263.552598029172, 5315.707636080014, 5316.12283973144, 5361.276227709268, 5367.06076436624, 5367.2485851980755, 5258.13240815265, 5294.205869119624, 5312.203169524563, 5324.866878328034, 5351.411344752074, 5302.045631786277, 5303.23103150045, 5308.203769434577, 5309.814156504503, 5313.9734301328635, 5262.447443018466, 5278.551323137538, 5291.814786482493, 5295.761690723888, 5313.681179129226, 5862.50168735658, 5867.882642347129, 5880.176775251425, 5909.734061967221, 5948.078047902539, 6373.808785736435, 6388.425041746219, 6389.808305750788, 6401.231852177769, 6403.327650596713, 6420.646864422455, 6421.8073457796345, 6441.3880681335195, 6442.581232219937, 6447.161868957052, 5836.066229403275, 5917.0, 5944.375840536682, 5952.9702351488395, 6009.008513595251, 6538.673066346663, 6578.309277525791, 6597.505187110986, 6615.966920165369, 6619.073329733841, 6155.169052177988, 6179.196704428396, 6199.287081985539, 6272.5922815016875, 6340.492760579143, 6456.838579035561, 6460.967695161494, 6470.935290647128, 6477.255115661759, 6480.287168411565, 6237.875242495215, 6300.0, 6311.211098612674, 6376.171097757262, 6418.390252925965, 6414.711337989802, 6440.6135631862235, 6459.935400646027, 6461.935380646228, 6472.190976127984, 4925.975370123198, 4937.530934561211, 4940.604751619861, 4941.925871111936, 4982.729404002029, 4310.590493903074, 4318.438602981592, 4381.3208952612395, 4382.386465894777, 4396.824127034883, 6037.54718396122, 6044.335123136451, 6044.455998960115, 6068.575199736064, 6090.147379366892, 6420.678966051679, 6424.293327733945, 6484.0, 6484.967575162094, 6500.6424646643945, 5860.912086318709, 6000.33996260411, 6035.969820150871, 6045.063015232646, 6050.576459647782, 5504.284443022461, 5520.944790552124, 5541.362743284493, 5541.778328866801, 5552.194931734876, 6628.801135965929, 6708.563943343667, 6710.932890671031, 6722.630255336004, 6747.865042699217, 6407.871842563216, 6424.100625912282, 6456.418922297016, 6492.091107245084, 6509.316521765147, 6662.300458451987, 6736.5958042517605, 6739.797806065826, 6770.526063175727, 6771.830704232433, 6204.13142160089, 6240.219972503437, 6273.592216505913, 6340.4293613575, 6383.96808015957, 6239.532035097295, 6307.3377295383325, 6481.222253329631, 6534.052562378523, 6544.0, 6183.84540386494, 6247.187865577446, 6290.559660823881, 6296.181496405438, 6305.716242769178, 6245.0632405139595, 6245.500359971283, 6248.4064013918605, 6255.499560035278, 6311.684415779101, 6141.240538582634, 6155.907661385172, 6156.199694039746, 6255.030470277115, 6264.0, 6346.397092276226, 6353.14232578596, 6371.267304260069, 6381.457576106083, 6389.297177310399, 6112.297085835008, 6170.969145154425, 6176.073588961692, 6176.536759743127, 6201.658908760061], "value": 5878.150077117111, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.4572339330591, 789.6328207383566, 817.7138001699404, 1108.4180805077333, 1126.791543564441, 36453.635463645354, 37589.43615845765, 37598.24803503928, 37604.43593346098, 37635.43546846793, 39116.608833911654, 39295.80352098242, 39592.40611390824, 39597.60402395975, 39683.20633587326, 7117.466190035768, 7124.572525648452, 7128.572285662864, 7139.78580642579, 7342.229065948079, 7327.9267207327775, 7381.667824947864, 7424.703011879518, 7426.9628651856665, 7453.888191677129, 7437.702491900318, 7456.701731930716, 7482.3639990600595, 7499.662515186802, 7503.737369192079, 7330.230325815766, 7394.149672787591, 7411.295926886937, 7428.814279642998, 7457.067866516685, 7275.090613673291, 7291.744788932362, 7321.633918304116, 7357.41140708742, 7363.484556081076, 36979.4453083204, 37260.25479490422, 37490.81254593737, 37593.61657450843, 37642.0, 3569.0542006368332, 3589.74871758977, 3609.4405367168133, 3625.4199328107375, 3631.0196247013423, 29439.11682649524, 29633.407331853457, 29684.0, 29773.106806795615, 29884.0, 3771.8302676379353, 3855.6722678572073, 3858.594847540996, 3870.651641352292, 3883.0292426893275, 195973.0, 196778.0, 214694.0, 223272.0, 224295.99999999837, 47941.68524832712, 48082.0, 48224.75887620539, 48347.0, 48391.0, 49236.26145607819, 49720.0, 49858.0, 49933.0, 50191.24713129306, 15735.527934161993, 15790.36838526469, 15863.52409427696, 15870.841291586936, 15891.205439728199, 12982.870171298355, 13004.414801333962, 13054.934725326502, 13076.150050246704, 13080.476780928846, 14380.35288412024, 14474.782878256834, 14529.491467798787, 14618.415263389345, 14690.55928322152, 5576.96826087167, 5638.9436105638415, 5718.914216286759, 5726.455986681259, 5786.88426231473, 1070.1973519860105, 1088.3034857691084, 1090.8854570270166, 1096.7313008312856, 1097.9780404391868, 26715.33211669724, 26784.33039174036, 27025.324366890985, 27026.32434189161, 27129.45741085207, 1178.281248438452, 1180.6753142885775, 1200.117913333699, 1221.5968730318973, 1226.8466441694789, 13796.172229666252, 14042.36809343582, 14153.221572813594, 14249.358778854976, 14252.928735356258, 269727.0, 271221.0, 273271.0, 273918.0, 274128.0, 55019.72490137524, 55598.0, 55664.44335556593, 55765.16352254719, 55895.0, 1489.6946126044136, 1517.7723341498863, 1523.116592376419, 1530.8469153084825, 1537.36967843186, 24809.25572232836, 31102.0, 31464.685353146175, 31565.684343157194, 31680.683193167773, 53795.73102134464, 53863.19205212003, 54006.45993540014, 54295.18557221566, 54522.727386362814, 225247.99008039496, 226206.0, 226266.0, 226282.0, 227128.0, 35501.644983549835, 35640.4653930186, 36647.63352366442, 36742.8162859184, 37291.44062839005, 44236.91275503358, 46069.53930460652, 46577.53422465732, 47166.0, 47347.0, 33606.49590256197, 33924.0, 34201.65798341985, 34897.0, 35455.82272088623, 33686.663133368354, 34029.82985085059, 34033.829830850686, 34567.65432345745, 34786.65213347834, 40094.39858402068, 40438.79780601196, 40468.0, 40666.79666601766, 40765.18469630532, 31605.92170281167, 32535.186620333734, 33137.66862331346, 33566.49650255199, 33753.662463375054, 25064.37339066538, 27293.863530682218, 27411.451770964868, 27514.724852751217, 27657.14058350167], "value": 17859.407158783342, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.231974843395, 448.93939318192054, 451.3635773559282, 465.897502549439, 474.8860273534351, 20044.1982320707, 20395.592088158228, 20696.372526834628, 20907.954602269863, 21117.57764844706, 21881.562368752617, 22444.0, 22488.10047598094, 23154.189603363884, 23566.350355475082, 5403.5136837684695, 5470.699111548864, 5553.111502159655, 5571.359293681217, 5581.860453488675, 5411.323584551931, 5487.780488780444, 5517.5585953123655, 5518.724063796794, 5530.5022547970675, 5296.285001524783, 5484.122540393538, 5511.889762204773, 5514.117741161415, 5516.668999860021, 5417.59368047396, 5489.451054894498, 5515.227868098469, 5521.779128834842, 5546.77812887486, 4880.6095512358925, 5021.774020169101, 5030.144875371159, 5038.773255203525, 5057.342545469065, 25141.874290628613, 25246.24261272165, 25464.49071018569, 25559.872200639064, 25755.742442575523, 2181.4437318483842, 2181.520065585569, 2190.4085896807933, 2210.9668354974688, 2212.7787221277904, 17111.914440427718, 17174.484765457055, 17412.0, 17658.0, 17840.821591784046, 2006.2175751456944, 2064.3394113883564, 2068.5759419319, 2085.592225247967, 2086.029996051828, 109850.0, 113549.43225283903, 120923.0, 121838.0, 122387.0, 20334.898325508573, 21067.8946605266, 21119.788802111783, 21162.78837211639, 21818.18181818188, 39203.0, 39388.606113939066, 39712.0, 40424.55329913707, 40526.39210411846, 8959.641614335484, 8965.641374344954, 9315.813683726288, 9358.532073396304, 10999.61501347449, 8782.824343513093, 8836.293096552261, 8882.777930551789, 9064.184223419923, 9128.40665356763, 7757.224277572311, 7762.6894924203525, 7906.841863162819, 7982.002249718786, 8040.437169398086, 2328.371339738295, 2344.4256157241243, 2370.19413399445, 2391.5695174868692, 2515.962260566093, 1034.4930983818026, 1077.0, 1077.42357838556, 1081.2809481694742, 1083.7507373304184, 21549.784502155093, 21575.67636485454, 21579.67630485544, 21731.565368692536, 21785.564288714137, 1103.9282446640943, 1108.0858291909208, 1112.8775834658343, 1114.3258328711013, 1118.4128332625437, 10940.56237750481, 11548.076153907667, 11640.941795291139, 11676.941615292038, 11767.941160294144, 509510.0, 526450.0, 528096.0, 530511.0, 532671.0, 86754.0, 87358.0, 87587.0, 90231.0, 93588.0, 1211.9091068169923, 1239.7768401687601, 1258.8111783232405, 1261.6341261034381, 1265.1270623269913, 17662.293508259525, 17893.37373191932, 17922.193501292735, 18141.27434902589, 18308.359207427675, 40566.59433405746, 40992.79503602463, 41288.38067428931, 42155.57844421516, 42946.0, 54708.89683273691, 55320.0, 55548.0, 55864.720676397985, 57919.0, 9769.65528273195, 9834.803303933739, 9895.604175832887, 10169.9491502542, 10172.237082218715, 15379.923100384427, 15551.300191491184, 15798.842011580196, 16030.839691603402, 16229.43196988147, 13449.0, 13582.0, 13591.320433978459, 13619.114757540729, 13875.791863122264, 10666.253362264568, 10681.305715128492, 11018.50416731265, 11135.88864111381, 12430.81353779676, 11271.661850144508, 13059.934700326437, 13561.186328820302, 13763.0, 13969.650758731113, 9795.265355098254, 9845.310828241954, 9896.87632649998, 9936.701898943043, 10148.441835699108, 12036.578719744766, 12139.878601213875, 12332.876671233173, 12551.493820741569, 13670.31648417595], "value": 10625.693811753508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.8285214348207, 1425.3372181935404, 1432.2480697633748, 1438.158677173854, 1447.8841692664587, 10777.568897244111, 11259.268147570403, 11276.0, 11284.210105292612, 11605.3036817791, 11374.943125284362, 11485.023772979286, 11501.654950351482, 11523.423828808567, 11551.249168804023, 2217.368050105716, 2258.153192552793, 2273.27255278311, 2278.6012447821563, 2283.6460348645987, 2148.258850696507, 2228.866268023916, 2230.4981379189717, 2236.9888150559223, 2238.5858616155983, 2155.030236393621, 2160.935171944844, 2181.4655409424636, 2192.177933275022, 2200.6038912995655, 2196.253273886878, 2199.571083638691, 2237.328801359594, 2238.9216377426874, 2241.540484200735, 2101.726775519188, 2187.245400336881, 2195.067096483988, 2195.2316689158824, 2222.0, 11402.372869492174, 11404.201705880592, 11532.654020379317, 11552.884471155265, 11554.711132221677, 6393.392627700361, 6614.371634694697, 6626.93373066268, 6650.7339706411685, 6662.233843108056, 3968.9007774805573, 4226.36604509323, 4229.6827737919775, 4253.340732186516, 4285.485741710983, 1369.8630136986321, 1394.7698629726185, 1427.9286035698278, 1430.8712215900514, 1451.8257809062875, 16942.491725248263, 17272.82727172725, 17301.9618822871, 17369.0, 17391.913040434843, 5530.972345138249, 5673.063944449203, 5876.353601103875, 5928.555358348055, 5930.673812940329, 14412.207328596818, 14485.78271325931, 14486.782698259534, 14495.710085798224, 14553.345099470549, 6814.352636499525, 6821.829454263584, 6872.244053154149, 6874.140732408449, 6877.690503927335, 6034.456898879122, 6143.692815359214, 6285.937140628626, 6289.40250676185, 6299.338569450142, 4590.97704511482, 4717.5046620104395, 4740.786664600101, 4836.177849765549, 4837.250226214942, 1409.1052181864384, 1449.6593300574357, 1475.513080683372, 1487.256371814093, 1496.1098146602753, 890.4879694175875, 906.3655441191192, 918.5223683684446, 922.5110691333604, 936.2369668720107, 6433.1636887205295, 6493.772717954849, 6520.510961677893, 6531.510136739764, 6667.533272670867, 654.1463390275736, 657.3919124809532, 658.0425480925243, 664.5846346033729, 674.4705406256065, 4248.787560621957, 4743.739094349844, 4899.118158731462, 5210.921836172461, 5335.093034184198, 15025.173615451036, 15029.248537573296, 15521.301541430663, 15529.223538823013, 15572.688546229012, 14999.0, 15115.697686046438, 15333.693326133414, 15395.61510962235, 15518.767218491732, 9513.904860951441, 9524.714258572254, 9561.665341713007, 9637.662681806243, 9770.951145244228, 7182.533135346186, 7273.454490913097, 7314.341709246193, 7377.8155546111775, 7399.889001664872, 13144.277064761147, 13183.14309569875, 13262.27057511846, 13459.79810302866, 13494.32528373597, 14062.789058163931, 14098.718025639635, 14112.717745644824, 14296.714065718836, 14488.275586220858, 9320.207782338306, 9389.85915211286, 9715.514224288898, 9799.167070799062, 9818.607255709692, 11256.099512038854, 11276.605318813803, 11305.830412543983, 11386.43067846621, 11396.145289103184, 9257.814843702954, 9373.718788436357, 9379.249660027044, 9398.718038458857, 9481.525923703924, 9058.094190580889, 9123.361364704408, 9283.814323713354, 9448.527573621428, 9485.620575176916, 8559.61481733336, 8661.52361620117, 8715.17205865467, 8724.083971182934, 8727.127287271222, 6346.0, 6348.682565871595, 6378.968105159444, 6447.258565265054, 6472.0, 6352.189625956765, 6477.4170324671, 6512.088307637029, 6564.212294524687, 6579.572327798678], "value": 5476.114173625296, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.73480442125884, 427.9743215407075, 429.30666972838867, 437.6673727966746, 440.537435692523, 5998.010328295837, 6244.157038799761, 6273.278572964105, 6290.1822763040855, 6318.684065796715, 6029.3772209089075, 6122.785702500413, 6141.232345956755, 6156.415140561639, 6161.691915404234, 4547.863564093074, 4627.583517483426, 4629.629629629621, 4636.675432719711, 4652.418447694038, 4631.374764406813, 4634.536546345372, 4643.721376717391, 4651.186042442576, 4670.369500117475, 4581.381513495686, 4629.768511574424, 4641.280601506755, 4645.303204519332, 4647.72113673179, 4547.977260113695, 4573.935463239604, 4575.748333841638, 4586.88532786678, 4597.3333866589155, 3990.38149086892, 3994.520657521087, 3996.3406038003695, 3999.7200195986293, 4012.979935100335, 5834.4165583441745, 5966.403359664042, 5999.430054144849, 6019.729112189962, 6064.484518815906, 5368.114261146906, 5385.892282154335, 5401.918971215435, 5439.673619582838, 5458.4814442627885, 6468.3208263132165, 6502.219733631994, 6507.414332710079, 6532.542722009462, 6533.542652014361, 4394.758288294142, 4498.595126438636, 4503.211937910853, 4517.051419201972, 4552.772361381951, 6674.232463266738, 6863.6568171591225, 6879.452123272224, 6919.515633905628, 6919.8962015569805, 4584.106099310669, 4619.307103934437, 4628.190066738307, 4640.744759038285, 4651.2557990721325, 4616.930746038812, 4643.187442197602, 4685.250359942393, 4689.976550117228, 4707.670463067621, 5264.104742391669, 5420.295361602966, 5442.619016668875, 5445.346558413015, 5468.0977638689965, 6545.0, 6572.638504882182, 6583.0, 6585.506087043491, 6608.933910660832, 1586.111777404657, 1604.9438269660507, 1623.7889074420486, 1629.54372775623, 1630.4619475573033, 1059.5602824827765, 1078.229066217658, 1087.8857719939451, 1089.455272363818, 1098.423327752936, 6308.085327627468, 6318.462930650946, 6324.747010119636, 6326.5958935605095, 6344.714487848058, 6539.607623542603, 6762.357576030269, 6780.0, 6809.0, 6813.420859226922, 6287.056941458726, 6289.591176573508, 6289.905651415233, 6292.150559674477, 6320.936790632127, 3492.0746002309406, 3561.4301711726, 3579.2125732338845, 3603.009172477537, 3609.5668519777796, 7057.6118313492225, 7097.787066388017, 7111.431085513146, 7129.39400150993, 7141.321574450419, 6809.001157689177, 6833.214180369321, 6853.7943861684225, 6867.141607299088, 6916.757913473004, 7003.824904377431, 7009.509334346547, 7059.223485416703, 7060.364567188978, 7135.571865688075, 6484.319146489551, 6709.496787741036, 6712.563683360566, 6714.374237911473, 6721.630310332783, 6537.8692426152165, 6636.668166591748, 6670.466362691071, 6681.265060843206, 6694.330566943267, 7088.645567721696, 7144.892541656051, 7146.499745018007, 7150.499465037606, 7167.534110282815, 4651.837185698484, 4673.088747694167, 4676.345311656439, 4685.367475390779, 4693.788779504862, 6712.93287067123, 6798.966005169942, 6801.592733776561, 6828.487863410165, 6848.0, 6484.351564843478, 6594.934050659432, 6603.0, 6628.734850605922, 6641.103451034049, 6440.162778838721, 6533.901991470227, 6550.0, 6589.8039450865335, 6613.570117942319, 6602.7689030883685, 6603.20761508622, 6615.106960560262, 6627.900581491378, 6642.136522252076, 6483.7730679425995, 6612.70242839083, 6661.500387470862, 6665.533412661067, 6675.699593518206, 6405.615663060231, 6428.228612566522, 6443.9355606445215, 6444.967775161282, 6454.0], "value": 4955.2984748950985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [855.9426735853718, 877.2630989968425, 879.5953861223837, 882.285348867417, 901.7700486375974, 15962.0, 17156.3137474501, 17259.223334949926, 17312.913435432805, 18404.723929141073, 17014.0, 17353.826461735378, 18045.368412105578, 18480.0, 18783.62432751344, 994.3089552760816, 1014.1227837920183, 1017.1100287248657, 1021.5913634546166, 1022.5705203814416, 996.0, 1034.6689059500925, 1039.8024375368693, 1042.4370839746528, 1043.9530221140028, 1084.4469320646488, 1087.8912108789136, 1093.7156339351745, 1095.956161753529, 1096.1121491591796, 1073.3559864081567, 1079.0450451350612, 1083.9295445796038, 1084.8752393474772, 1086.896744809242, 788.7515432638758, 791.4578513718121, 793.0879488588112, 797.1231645190302, 798.7164556582446, 16049.2777824997, 16273.023618582924, 16413.917930410273, 17262.741058884127, 17405.0, 18168.909155454272, 18645.53386165343, 18702.90648546762, 18798.90600547002, 18983.145758440904, 13937.0, 13989.160650361011, 14124.505642302573, 14125.78811317831, 14360.138391696531, 3382.289719158955, 3410.28384039352, 3412.3516531859113, 3412.744044196695, 3415.299863527971, 87216.56391718064, 87872.56063719641, 88172.32116207291, 88819.55590222008, 88904.11095889023, 13493.32533373347, 13504.729905401837, 13513.66215844592, 13519.662008449868, 13610.455581776618, 22368.664470032963, 23175.536489270457, 23337.0, 23385.064597415912, 25471.872640636677, 7300.306470885257, 7546.886796698054, 7553.0, 7566.886496702554, 7593.620318984029, 3988.8404463821703, 4002.1795531915886, 4051.5745846686264, 4089.3661482470266, 4139.0480189555965, 4658.440987081572, 4731.053789242165, 4734.763261836894, 4739.786709598076, 4775.355327030876, 950.8668786369914, 964.3105179796479, 965.5220665770348, 1008.2639673038723, 1014.4521958142668, 716.3230746944088, 721.5886944441722, 732.3299181249098, 743.2827321634649, 760.5512747479014, 11773.23473974206, 11961.574217539392, 12417.254964702146, 12575.434105465276, 12816.55142070023, 742.3133601418774, 750.2272659161073, 753.3370633842184, 753.9962300188464, 762.7063580521539, 5079.111155547838, 5605.243292155506, 5727.342721605461, 5847.8245652630485, 5918.496927761103, 81570.0, 81613.0, 81837.0, 82554.0, 85142.0, 70019.29980700128, 70940.2905970944, 71847.92228116583, 74530.0, 75507.24492755003, 64008.0, 65013.0, 65144.67427662831, 65661.67169164219, 66228.33771662318, 10950.34297942126, 11032.779344412906, 11349.4892729829, 12309.32298723543, 13458.932705336802, 33150.668493314755, 33583.16042098967, 33986.83006584951, 34056.0, 35294.0, 53511.19733204083, 53675.463245368606, 53679.46320536744, 54508.90982180255, 57252.713736431055, 17257.137143142543, 17593.736093958858, 17836.821631783518, 17900.820991790435, 18197.636047279244, 17687.292508299524, 17814.109294534963, 17970.550736231176, 18321.083945802922, 19741.901290493457, 17249.482515524553, 18296.634067318846, 18602.720959185353, 18943.90528047351, 19056.237750489825, 17530.824691752918, 17615.82384176142, 17760.289588416836, 17805.287788488316, 18103.456896293133, 16603.66792664116, 16669.66660666804, 16742.832571674615, 16776.916115419346, 17231.0, 10229.590816367261, 10242.334248274137, 10257.948710256402, 10571.471426428801, 10659.307145035547, 11817.231879927776, 12462.750744985231, 12602.810957835456, 12626.053046021769, 12759.80860287115], "value": 8297.935618276293, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 112.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 125.0, 164.0, 122.0, 118.0, 118.0, 118.0, 143.0, 120.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 164.0, 163.0, 163.0, 165.0, 167.0, 172.0, 160.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 100.0, 76.0, 74.0, 75.0, 76.0, 97.0, 74.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 102.0, 82.0, 82.0, 82.0, 97.0, 82.0, 81.0, 106.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 150.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 47.0, 47.0, 47.0, 50.0, 51.0, 48.0, 52.0, 48.0, 47.0], "value": 48.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 81.0, 81.0, 80.0, 83.0, 83.0, 82.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 126.0, 131.0, 127.0, 125.0, 127.0, 130.0, 126.0, 173.0, 141.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 193.0, 187.0, 189.0, 178.0, 180.0, 182.0, 182.0, 180.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 70.0, 71.0, 69.0, 65.0, 67.0, 68.0, 68.0, 66.0, 65.0], "value": 68.5, "unit": "score"}]}]} 10:25:58 INFO - Return code: 0 10:25:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:25:58 INFO - # TBPL SUCCESS # 10:25:58 INFO - Running post-action listener: _resource_record_post_action 10:25:58 INFO - [mozharness: 2017-05-04 17:25:58.721286Z] Finished run-tests step (success) 10:25:58 INFO - Running post-run listener: _resource_record_post_run 10:25:58 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 217088; Write bytes: 355627008; Read time: 36; Write time: 283380 10:25:58 INFO - TinderboxPrint: CPU usage
13.2% 10:25:58 INFO - TinderboxPrint: I/O read bytes / time
217,088 / 36 10:25:58 INFO - TinderboxPrint: I/O write bytes / time
355,627,008 / 283,380 10:25:58 INFO - TinderboxPrint: CPU idle
8,251.2 (86.7%) 10:25:58 INFO - TinderboxPrint: CPU user
1,204.0 (12.7%) 10:25:58 INFO - TinderboxPrint: Swap in / out
0 / 0 10:25:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103297024; Read time: 0; Write time: 118076 10:25:58 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 212992; Write bytes: 251265024; Read time: 24; Write time: 165224 10:25:59 INFO - Running post-run listener: _upload_blobber_files 10:25:59 INFO - Blob upload gear active. 10:25:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:59 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 10:25:59 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'] 10:25:59 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 10:25:59 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:03 INFO - (blobuploader) - INFO - Done attempting. 10:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:26:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:04 INFO - (blobuploader) - INFO - Done attempting. 10:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:26:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:05 INFO - (blobuploader) - INFO - Done attempting. 10:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:07 INFO - (blobuploader) - INFO - Done attempting. 10:26:07 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:07 INFO - Return code: 0 10:26:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:07 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25acd169976f8c1cd44b840e1e32c7f7d149d07b051a59afaaa0a6ed3756ef4ec647d7843435dec78e963ace1f1a22f3f1c2aac23ce2e1f889b41de6874b7a28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a726acdfd23c1d2ef977dc4d90b7a47e3ed1bf7964b60969aaf2365e1f8516e3afc66949b3f5b97ca70f82ef778fa5149ac0906d098a920149e8a830bcf6f4c3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/756f4a7831f7bc854f48418c079f3432268e7516bc4d2d4b957a02ebe7d4c7dc743ee418b67d1e77378c734140d4e1e502486970fbbe89d512834cef22180470", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d0363a6c923948179ff1c62e2d5767c41af88b15787b76ee9909da617e0893728a2da1eccc5d22f9f0104ffe3b9be275762554c9702e233854a7249f4ea78c"} 10:26:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:07 INFO - Contents: 10:26:07 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25acd169976f8c1cd44b840e1e32c7f7d149d07b051a59afaaa0a6ed3756ef4ec647d7843435dec78e963ace1f1a22f3f1c2aac23ce2e1f889b41de6874b7a28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a726acdfd23c1d2ef977dc4d90b7a47e3ed1bf7964b60969aaf2365e1f8516e3afc66949b3f5b97ca70f82ef778fa5149ac0906d098a920149e8a830bcf6f4c3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/756f4a7831f7bc854f48418c079f3432268e7516bc4d2d4b957a02ebe7d4c7dc743ee418b67d1e77378c734140d4e1e502486970fbbe89d512834cef22180470", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d0363a6c923948179ff1c62e2d5767c41af88b15787b76ee9909da617e0893728a2da1eccc5d22f9f0104ffe3b9be275762554c9702e233854a7249f4ea78c"} 10:26:07 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:07 INFO - Copying logs to upload dir... 10:26:07 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.205519 ========= master_lag: -0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-05-04 10:26:06.955371) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:26:06.960979) ========= 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-1493917152.670997-537101294 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/25acd169976f8c1cd44b840e1e32c7f7d149d07b051a59afaaa0a6ed3756ef4ec647d7843435dec78e963ace1f1a22f3f1c2aac23ce2e1f889b41de6874b7a28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a726acdfd23c1d2ef977dc4d90b7a47e3ed1bf7964b60969aaf2365e1f8516e3afc66949b3f5b97ca70f82ef778fa5149ac0906d098a920149e8a830bcf6f4c3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/756f4a7831f7bc854f48418c079f3432268e7516bc4d2d4b957a02ebe7d4c7dc743ee418b67d1e77378c734140d4e1e502486970fbbe89d512834cef22180470", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d0363a6c923948179ff1c62e2d5767c41af88b15787b76ee9909da617e0893728a2da1eccc5d22f9f0104ffe3b9be275762554c9702e233854a7249f4ea78c"} build_url:https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/ArH1QPTVQzy70sA-Zlw7xw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25acd169976f8c1cd44b840e1e32c7f7d149d07b051a59afaaa0a6ed3756ef4ec647d7843435dec78e963ace1f1a22f3f1c2aac23ce2e1f889b41de6874b7a28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a726acdfd23c1d2ef977dc4d90b7a47e3ed1bf7964b60969aaf2365e1f8516e3afc66949b3f5b97ca70f82ef778fa5149ac0906d098a920149e8a830bcf6f4c3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/756f4a7831f7bc854f48418c079f3432268e7516bc4d2d4b957a02ebe7d4c7dc743ee418b67d1e77378c734140d4e1e502486970fbbe89d512834cef22180470", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d0363a6c923948179ff1c62e2d5767c41af88b15787b76ee9909da617e0893728a2da1eccc5d22f9f0104ffe3b9be275762554c9702e233854a7249f4ea78c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:26:06.992089) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:26:06.992570) ========= 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-1493917152.670997-537101294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:26:07.042283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:26:07.044873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:26:07.045299) ========= ========= Total master_lag: 0.00 =========