builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1489760099.41 results: success (0) revision: 9a95ade0ec97a871f97c397261fc7297e897331f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 07:14:59.406384) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 07:14:59.406878) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 07:14:59.407192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 07:14:59.427668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 07:14:59.427974) ========= 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=03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-17 07:14:59-- 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% 222M=0s 2017-03-17 07:14:59 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083945 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 07:14:59.525320) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 07:14:59.525681) ========= 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=03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017389 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 07:14:59.575510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 07:14:59.575897) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9a95ade0ec97a871f97c397261fc7297e897331f --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 9a95ade0ec97a871f97c397261fc7297e897331f --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=03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-17 07:14:59,600 truncating revision to first 12 chars 2017-03-17 07:14:59,601 Setting DEBUG logging. 2017-03-17 07:14:59,601 attempt 1/10 2017-03-17 07:14:59,601 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9a95ade0ec97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-17 07:14:59,914 unpacking tar archive at: mozilla-central-9a95ade0ec97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617192 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 07:15:00.208158) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 07:15:00.208696) ========= script_repo_revision: 9a95ade0ec97a871f97c397261fc7297e897331f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 07:15:00.209585) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 07:15:00.210281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 07:15:00.221036) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-17 07:15:00.221391) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:15:00 INFO - MultiFileLogger online at 20170317 07:15:00 in /builds/slave/test 07:15:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:15:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:00 INFO - {'append_to_log': False, 07:15:00 INFO - 'base_work_dir': '/builds/slave/test', 07:15:00 INFO - 'blob_upload_branch': 'Firefox', 07:15:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:00 INFO - 'branch': 'Firefox', 07:15:00 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:00 INFO - 'config_files': ('talos/linux_config.py',), 07:15:00 INFO - 'default_actions': ('clobber', 07:15:00 INFO - 'read-buildbot-config', 07:15:00 INFO - 'download-and-extract', 07:15:00 INFO - 'populate-webroot', 07:15:00 INFO - 'create-virtualenv', 07:15:00 INFO - 'install', 07:15:00 INFO - 'run-tests'), 07:15:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:00 INFO - 'download_minidump_stackwalk': True, 07:15:00 INFO - 'download_symbols': 'ondemand', 07:15:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:00 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:00 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:00 INFO - 'gecko_profile': False, 07:15:00 INFO - 'gecko_profile_interval': 0, 07:15:00 INFO - 'installer_path': 'installer.exe', 07:15:00 INFO - 'log_level': 'info', 07:15:00 INFO - 'log_name': 'talos', 07:15:00 INFO - 'log_to_console': True, 07:15:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:15:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:15:00 INFO - 'opt_config_files': (), 07:15:00 INFO - 'pip_index': False, 07:15:00 INFO - 'suite': 'dromaeojs', 07:15:00 INFO - 'system_bits': '32', 07:15:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:00 INFO - 'title': 'talos-linux64-ix-047', 07:15:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:00 INFO - 'use_talos_json': True, 07:15:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:00 INFO - 'work_dir': 'build'} 07:15:00 INFO - [mozharness: 2017-03-17 14:15:00.351816Z] Running clobber step. 07:15:00 INFO - Running pre-action listener: _resource_record_pre_action 07:15:00 INFO - Running main action method: clobber 07:15:00 INFO - rmtree: /builds/slave/test/build 07:15:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:01 INFO - Running post-action listener: _resource_record_post_action 07:15:01 INFO - [mozharness: 2017-03-17 14:15:01.301717Z] Finished clobber step (success) 07:15:01 INFO - [mozharness: 2017-03-17 14:15:01.301817Z] Running read-buildbot-config step. 07:15:01 INFO - Running pre-action listener: _resource_record_pre_action 07:15:01 INFO - Running main action method: read_buildbot_config 07:15:01 INFO - Using buildbot properties: 07:15:01 INFO - { 07:15:01 INFO - "project": "", 07:15:01 INFO - "product": "firefox", 07:15:01 INFO - "who": "cbook@mozilla.com", 07:15:01 INFO - "installer_path": "public/build/target.tar.bz2", 07:15:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:15:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:15:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:15:01 INFO - "stage_platform": "linux64-pgo", 07:15:01 INFO - "basedir": "/builds/slave/test", 07:15:01 INFO - "buildnumber": 81, 07:15:01 INFO - "platform": "ubuntu64_hw", 07:15:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:15:01 INFO - "slavebuilddir": "test", 07:15:01 INFO - "taskId": "MUpN6R2oShinB5BofpzfPA", 07:15:01 INFO - "branch": "mozilla-central", 07:15:01 INFO - "script_repo_revision": "production", 07:15:01 INFO - "revision": "9a95ade0ec97a871f97c397261fc7297e897331f", 07:15:01 INFO - "slavename": "talos-linux64-ix-047", 07:15:01 INFO - "repo_path": "mozilla-central" 07:15:01 INFO - } 07:15:01 INFO - Finding installer, test and symbols from parent task. 07:15:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MUpN6R2oShinB5BofpzfPA'}, attempt #1 07:15:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MUpN6R2oShinB5BofpzfPA'}, attempt #1 07:15:02 INFO - Task dependencies: ayhMZyiVST2oVMGpInjhIA 07:15:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA'}, attempt #1 07:15:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.tar.bz2 07:15:02 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/test_packages.json 07:15:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.crashreporter-symbols.zip 07:15:02 INFO - Running post-action listener: _resource_record_post_action 07:15:02 INFO - [mozharness: 2017-03-17 14:15:02.696144Z] Finished read-buildbot-config step (success) 07:15:02 INFO - [mozharness: 2017-03-17 14:15:02.696364Z] Running download-and-extract step. 07:15:02 INFO - Running pre-action listener: _resource_record_pre_action 07:15:02 INFO - Running main action method: download_and_extract 07:15:02 INFO - mkdir: /builds/slave/test/build/tests 07:15: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')]} 07:15:02 INFO - trying https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.test_packages.json 07:15:02 INFO - Downloading https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:15:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:15:03 INFO - Downloaded 986 bytes. 07:15:03 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:15:03 INFO - Using the following test package requirements: 07:15:03 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:15:03 INFO - u'common': [u'target.common.tests.zip'], 07:15:03 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:15:03 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:15:03 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:15:03 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:15:03 INFO - u'mozbase': [u'target.common.tests.zip'], 07:15:03 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:15:03 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:15:03 INFO - u'web-platform': [u'target.common.tests.zip', 07:15:03 INFO - u'target.web-platform.tests.zip'], 07:15:03 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:15:03 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:15:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.common.tests.zip 07:15:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:15:03 INFO - Fetch https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.common.tests.zip into memory 07:15:04 INFO - Expected file size: 60317670 07:15:04 INFO - Obtained file size: 60317670 07:15:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:15:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.common.tests.zip 07:15:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:15:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.common.tests.zip into memory 07:15:15 INFO - Expected file size: 60317670 07:15:15 INFO - Obtained file size: 60317670 07:15:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.talos.tests.zip 07:15:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:15:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.talos.tests.zip into memory 07:15:26 INFO - Expected file size: 14404171 07:15:26 INFO - Obtained file size: 14404171 07:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:27 INFO - trying https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.tar.bz2 07:15:27 INFO - Downloading https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:15:28 INFO - Downloaded 67050392 bytes. 07:15:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.tar.bz2 07:15:28 INFO - mkdir: /builds/slave/test/properties 07:15:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:28 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:28 INFO - Contents: 07:15:28 INFO - build_url:https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.tar.bz2 07:15:28 INFO - Running post-action listener: _resource_record_post_action 07:15:28 INFO - Running post-action listener: set_extra_try_arguments 07:15:28 INFO - [mozharness: 2017-03-17 14:15:28.337875Z] Finished download-and-extract step (success) 07:15:28 INFO - [mozharness: 2017-03-17 14:15:28.337971Z] Running populate-webroot step. 07:15:28 INFO - Running pre-action listener: _resource_record_pre_action 07:15:28 INFO - Running main action method: populate_webroot 07:15:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:28 INFO - '--tppagecycles', 07:15:28 INFO - '7'], 07:15:28 INFO - 'tests': ['tsvgm']}}, 07:15:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['damp', 'tps']}, 07:15:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'tests': ['damp', 'tps']}, 07:15:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['dromaeo_dom']}, 07:15:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['basic_compositor_video']}, 07:15:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:15:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['tsvgx', 07:15:28 INFO - 'tsvgr_opacity', 07:15:28 INFO - 'tart', 07:15:28 INFO - 'tscrollx', 07:15:28 INFO - 'cart', 07:15:28 INFO - 'tsvg_static']}, 07:15:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:28 INFO - 'tsvgr_opacity', 07:15:28 INFO - 'tart', 07:15:28 INFO - 'tscrollx', 07:15:28 INFO - 'cart', 07:15:28 INFO - 'tsvg_static']}, 07:15:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['tp5o']}, 07:15:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:15:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'talos_options': ['--disable-e10s', 07:15:28 INFO - '--xperf_path', 07:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:28 INFO - 'tests': ['tp5n']}, 07:15:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'talos_options': ['--xperf_path', 07:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:28 INFO - 'tests': ['tp5n']}}, 07:15:28 INFO - 'talos.zip': {'path': '', 07:15:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:28 INFO - Running post-action listener: _resource_record_post_action 07:15:28 INFO - [mozharness: 2017-03-17 14:15:28.351156Z] Finished populate-webroot step (success) 07:15:28 INFO - [mozharness: 2017-03-17 14:15:28.351247Z] Running create-virtualenv step. 07:15:28 INFO - Running pre-action listener: _resource_record_pre_action 07:15:28 INFO - Running main action method: create_virtualenv 07:15:28 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:15:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:28 INFO - Using real prefix '/usr' 07:15:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:28 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:30 INFO - Installing pip.................done. 07:15:30 INFO - Return code: 0 07:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:15:31 INFO - Reading from file tmpfile_stdout 07:15:31 INFO - Output received: 07:15:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:15:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, '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': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:15:31 INFO - Using env: {'DISPLAY': ':0', 07:15:31 INFO - 'HOME': '/home/cltbld', 07:15:31 INFO - 'LANG': 'en_US.UTF-8', 07:15:31 INFO - 'LANGUAGE': 'en_US:en', 07:15:31 INFO - 'LOGNAME': 'cltbld', 07:15:31 INFO - 'MAIL': '/var/mail/cltbld', 07:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:31 INFO - 'MOZ_NO_REMOTE': '1', 07:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:31 INFO - 'NO_EM_RESTART': '1', 07:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:31 INFO - 'PWD': '/builds/slave/test', 07:15:31 INFO - 'SHELL': '/bin/bash', 07:15:31 INFO - 'SHLVL': '1', 07:15:31 INFO - 'TERM': 'linux', 07:15:31 INFO - 'TMOUT': '86400', 07:15:31 INFO - 'USER': 'cltbld', 07:15:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:31 INFO - '_': '/tools/buildbot/bin/python'} 07:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:15:31 INFO - Cleaning up... 07:15:31 INFO - Return code: 0 07:15:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, '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': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:15:31 INFO - Using env: {'DISPLAY': ':0', 07:15:31 INFO - 'HOME': '/home/cltbld', 07:15:31 INFO - 'LANG': 'en_US.UTF-8', 07:15:31 INFO - 'LANGUAGE': 'en_US:en', 07:15:31 INFO - 'LOGNAME': 'cltbld', 07:15:31 INFO - 'MAIL': '/var/mail/cltbld', 07:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:31 INFO - 'MOZ_NO_REMOTE': '1', 07:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:31 INFO - 'NO_EM_RESTART': '1', 07:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:31 INFO - 'PWD': '/builds/slave/test', 07:15:31 INFO - 'SHELL': '/bin/bash', 07:15:31 INFO - 'SHLVL': '1', 07:15:31 INFO - 'TERM': 'linux', 07:15:31 INFO - 'TMOUT': '86400', 07:15:31 INFO - 'USER': 'cltbld', 07:15:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:31 INFO - '_': '/tools/buildbot/bin/python'} 07:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:31 INFO - Downloading/unpacking psutil>=3.1.1 07:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:33 INFO - Installing collected packages: psutil 07:15:33 INFO - Running setup.py install for psutil 07:15:33 INFO - building 'psutil._psutil_linux' extension 07:15:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:15:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:15:33 INFO - building 'psutil._psutil_posix' extension 07:15:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:15:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:34 INFO - Successfully installed psutil 07:15:34 INFO - Cleaning up... 07:15:34 INFO - Return code: 0 07:15:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, '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': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:15:34 INFO - Using env: {'DISPLAY': ':0', 07:15:34 INFO - 'HOME': '/home/cltbld', 07:15:34 INFO - 'LANG': 'en_US.UTF-8', 07:15:34 INFO - 'LANGUAGE': 'en_US:en', 07:15:34 INFO - 'LOGNAME': 'cltbld', 07:15:34 INFO - 'MAIL': '/var/mail/cltbld', 07:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:34 INFO - 'MOZ_NO_REMOTE': '1', 07:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:34 INFO - 'NO_EM_RESTART': '1', 07:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:34 INFO - 'PWD': '/builds/slave/test', 07:15:34 INFO - 'SHELL': '/bin/bash', 07:15:34 INFO - 'SHLVL': '1', 07:15:34 INFO - 'TERM': 'linux', 07:15:34 INFO - 'TMOUT': '86400', 07:15:34 INFO - 'USER': 'cltbld', 07:15:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:34 INFO - '_': '/tools/buildbot/bin/python'} 07:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:15:36 INFO - Installing collected packages: mozsystemmonitor 07:15:36 INFO - Running setup.py install for mozsystemmonitor 07:15:36 INFO - Successfully installed mozsystemmonitor 07:15:36 INFO - Cleaning up... 07:15:36 INFO - Return code: 0 07:15:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, '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': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:15:36 INFO - Using env: {'DISPLAY': ':0', 07:15:36 INFO - 'HOME': '/home/cltbld', 07:15:36 INFO - 'LANG': 'en_US.UTF-8', 07:15:36 INFO - 'LANGUAGE': 'en_US:en', 07:15:36 INFO - 'LOGNAME': 'cltbld', 07:15:36 INFO - 'MAIL': '/var/mail/cltbld', 07:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:36 INFO - 'MOZ_NO_REMOTE': '1', 07:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:36 INFO - 'NO_EM_RESTART': '1', 07:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:36 INFO - 'PWD': '/builds/slave/test', 07:15:36 INFO - 'SHELL': '/bin/bash', 07:15:36 INFO - 'SHLVL': '1', 07:15:36 INFO - 'TERM': 'linux', 07:15:36 INFO - 'TMOUT': '86400', 07:15:36 INFO - 'USER': 'cltbld', 07:15:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:36 INFO - '_': '/tools/buildbot/bin/python'} 07:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:36 INFO - Downloading/unpacking jsonschema==2.5.1 07:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:39 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:39 INFO - warning: no files found matching '*.txt' 07:15:39 INFO - no previously-included directories found matching 'build' 07:15:39 INFO - no previously-included directories found matching 'dist' 07:15:39 INFO - no previously-included directories found matching '.git*' 07:15:39 INFO - Installing collected packages: jsonschema, functools32 07:15:39 INFO - Running setup.py install for functools32 07:15:39 INFO - warning: no files found matching '*.txt' 07:15:39 INFO - no previously-included directories found matching 'build' 07:15:39 INFO - no previously-included directories found matching 'dist' 07:15:39 INFO - no previously-included directories found matching '.git*' 07:15:39 INFO - Successfully installed jsonschema functools32 07:15:39 INFO - Cleaning up... 07:15:39 INFO - Return code: 0 07:15:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:39 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 0x24b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, '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': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:15:39 INFO - Using env: {'DISPLAY': ':0', 07:15:39 INFO - 'HOME': '/home/cltbld', 07:15:39 INFO - 'LANG': 'en_US.UTF-8', 07:15:39 INFO - 'LANGUAGE': 'en_US:en', 07:15:39 INFO - 'LOGNAME': 'cltbld', 07:15:39 INFO - 'MAIL': '/var/mail/cltbld', 07:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:39 INFO - 'MOZ_NO_REMOTE': '1', 07:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:39 INFO - 'NO_EM_RESTART': '1', 07:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:39 INFO - 'PWD': '/builds/slave/test', 07:15:39 INFO - 'SHELL': '/bin/bash', 07:15:39 INFO - 'SHLVL': '1', 07:15:39 INFO - 'TERM': 'linux', 07:15:39 INFO - 'TMOUT': '86400', 07:15:39 INFO - 'USER': 'cltbld', 07:15:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:39 INFO - '_': '/tools/buildbot/bin/python'} 07:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:15:39 INFO - Cleaning up... 07:15:39 INFO - Return code: 0 07:15:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:39 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 0x24b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, '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': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:15:39 INFO - Using env: {'DISPLAY': ':0', 07:15:39 INFO - 'HOME': '/home/cltbld', 07:15:39 INFO - 'LANG': 'en_US.UTF-8', 07:15:39 INFO - 'LANGUAGE': 'en_US:en', 07:15:39 INFO - 'LOGNAME': 'cltbld', 07:15:39 INFO - 'MAIL': '/var/mail/cltbld', 07:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:39 INFO - 'MOZ_NO_REMOTE': '1', 07:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:39 INFO - 'NO_EM_RESTART': '1', 07:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:39 INFO - 'PWD': '/builds/slave/test', 07:15:39 INFO - 'SHELL': '/bin/bash', 07:15:39 INFO - 'SHLVL': '1', 07:15:39 INFO - 'TERM': 'linux', 07:15:39 INFO - 'TMOUT': '86400', 07:15:39 INFO - 'USER': 'cltbld', 07:15:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:39 INFO - '_': '/tools/buildbot/bin/python'} 07:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:39 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:41 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:42 INFO - Downloading docopt-0.6.1.tar.gz 07:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:42 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:42 INFO - Running setup.py install for blobuploader 07:15:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:42 INFO - Running setup.py install for requests 07:15:43 INFO - Running setup.py install for docopt 07:15:43 INFO - Successfully installed blobuploader requests docopt 07:15:43 INFO - Cleaning up... 07:15:43 INFO - Return code: 0 07:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:43 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 0x24b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, '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': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:15:43 INFO - Using env: {'DISPLAY': ':0', 07:15:43 INFO - 'HOME': '/home/cltbld', 07:15:43 INFO - 'LANG': 'en_US.UTF-8', 07:15:43 INFO - 'LANGUAGE': 'en_US:en', 07:15:43 INFO - 'LOGNAME': 'cltbld', 07:15:43 INFO - 'MAIL': '/var/mail/cltbld', 07:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:43 INFO - 'MOZ_NO_REMOTE': '1', 07:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:43 INFO - 'NO_EM_RESTART': '1', 07:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:43 INFO - 'PWD': '/builds/slave/test', 07:15:43 INFO - 'SHELL': '/bin/bash', 07:15:43 INFO - 'SHLVL': '1', 07:15:43 INFO - 'TERM': 'linux', 07:15:43 INFO - 'TMOUT': '86400', 07:15:43 INFO - 'USER': 'cltbld', 07:15:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:43 INFO - '_': '/tools/buildbot/bin/python'} 07:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:43 INFO - Running setup.py (path:/tmp/pip-9rmzY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:43 INFO - Running setup.py (path:/tmp/pip-olTQaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:43 INFO - Running setup.py (path:/tmp/pip-IZf48k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:43 INFO - Running setup.py (path:/tmp/pip-EORufG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:43 INFO - Running setup.py (path:/tmp/pip-KaoqiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:43 INFO - Running setup.py (path:/tmp/pip-DmXck5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:43 INFO - Running setup.py (path:/tmp/pip-WzU490-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:44 INFO - Running setup.py (path:/tmp/pip-uYF7sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:44 INFO - Running setup.py (path:/tmp/pip-2nYYam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:44 INFO - Running setup.py (path:/tmp/pip-h_zUYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:44 INFO - Running setup.py (path:/tmp/pip-Tn1Hlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:44 INFO - Running setup.py (path:/tmp/pip-v5bNYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:44 INFO - Running setup.py (path:/tmp/pip-sCPrzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:44 INFO - Running setup.py (path:/tmp/pip-S4GQDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:44 INFO - Running setup.py (path:/tmp/pip-EAQ9K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:44 INFO - Running setup.py (path:/tmp/pip-PyB3uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:44 INFO - Running setup.py (path:/tmp/pip-xoVDz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:44 INFO - Running setup.py install for manifestparser 07:15:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:44 INFO - Running setup.py install for mozcrash 07:15:44 INFO - Running setup.py install for mozdebug 07:15:45 INFO - Running setup.py install for mozdevice 07:15:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozfile 07:15:45 INFO - Running setup.py install for mozhttpd 07:15:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozinfo 07:15:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozInstall 07:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozleak 07:15:45 INFO - Running setup.py install for mozlog 07:15:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for moznetwork 07:15:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozprocess 07:15:45 INFO - Running setup.py install for mozprofile 07:15:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Running setup.py install for mozrunner 07:15:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Running setup.py install for mozscreenshot 07:15:46 INFO - Running setup.py install for moztest 07:15:46 INFO - Running setup.py install for mozversion 07:15:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:46 INFO - Cleaning up... 07:15:46 INFO - Return code: 0 07:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:46 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 0x24b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, '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': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:15:46 INFO - Using env: {'DISPLAY': ':0', 07:15:46 INFO - 'HOME': '/home/cltbld', 07:15:46 INFO - 'LANG': 'en_US.UTF-8', 07:15:46 INFO - 'LANGUAGE': 'en_US:en', 07:15:46 INFO - 'LOGNAME': 'cltbld', 07:15:46 INFO - 'MAIL': '/var/mail/cltbld', 07:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:46 INFO - 'MOZ_NO_REMOTE': '1', 07:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:46 INFO - 'NO_EM_RESTART': '1', 07:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:46 INFO - 'PWD': '/builds/slave/test', 07:15:46 INFO - 'SHELL': '/bin/bash', 07:15:46 INFO - 'SHLVL': '1', 07:15:46 INFO - 'TERM': 'linux', 07:15:46 INFO - 'TMOUT': '86400', 07:15:46 INFO - 'USER': 'cltbld', 07:15:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:46 INFO - '_': '/tools/buildbot/bin/python'} 07:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:46 INFO - Running setup.py (path:/tmp/pip-hjHAMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:46 INFO - Running setup.py (path:/tmp/pip-5CC4Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:46 INFO - Running setup.py (path:/tmp/pip-0xqUMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:46 INFO - Running setup.py (path:/tmp/pip-eeBdUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:47 INFO - Running setup.py (path:/tmp/pip-F0bBZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:47 INFO - Running setup.py (path:/tmp/pip-HnIIdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:47 INFO - Running setup.py (path:/tmp/pip-otmlHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:47 INFO - Running setup.py (path:/tmp/pip-jJYhoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:47 INFO - Running setup.py (path:/tmp/pip-PifDiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:47 INFO - Running setup.py (path:/tmp/pip-PISPFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:47 INFO - Running setup.py (path:/tmp/pip-fBoHod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:47 INFO - Running setup.py (path:/tmp/pip-c8Ae5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:47 INFO - Running setup.py (path:/tmp/pip-T_khTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:47 INFO - Running setup.py (path:/tmp/pip-ktEwwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:47 INFO - Running setup.py (path:/tmp/pip-G0O9L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:47 INFO - Running setup.py (path:/tmp/pip-dfvPZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:47 INFO - Running setup.py (path:/tmp/pip-GTe_oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:15:47 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:15:47 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:15:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:49 INFO - Downloading blessings-1.6.tar.gz 07:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:50 INFO - Installing collected packages: blessings 07:15:50 INFO - Running setup.py install for blessings 07:15:50 INFO - Successfully installed blessings 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:50 INFO - Reading from file tmpfile_stdout 07:15:50 INFO - Current package versions: 07:15:50 INFO - argparse == 1.2.1 07:15:50 INFO - blessings == 1.6 07:15:50 INFO - blobuploader == 1.2.4 07:15:50 INFO - docopt == 0.6.1 07:15:50 INFO - functools32 == 3.2.3-2 07:15:50 INFO - jsonschema == 2.5.1 07:15:50 INFO - manifestparser == 1.1 07:15:50 INFO - mozInstall == 1.12 07:15:50 INFO - mozcrash == 1.0 07:15:50 INFO - mozdebug == 0.1 07:15:50 INFO - mozdevice == 0.49 07:15:50 INFO - mozfile == 1.2 07:15:50 INFO - mozhttpd == 0.7 07:15:50 INFO - mozinfo == 0.9 07:15:50 INFO - mozleak == 0.1 07:15:50 INFO - mozlog == 3.4 07:15:50 INFO - moznetwork == 0.27 07:15:50 INFO - mozprocess == 0.25 07:15:50 INFO - mozprofile == 0.28 07:15:50 INFO - mozrunner == 6.13 07:15:50 INFO - mozscreenshot == 0.1 07:15:50 INFO - mozsystemmonitor == 0.3 07:15:50 INFO - moztest == 0.8 07:15:50 INFO - mozversion == 1.4 07:15:50 INFO - psutil == 3.1.1 07:15:50 INFO - requests == 1.2.3 07:15:50 INFO - wsgiref == 0.1.2 07:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 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 0x24b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, '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': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:15:50 INFO - Using env: {'DISPLAY': ':0', 07:15:50 INFO - 'HOME': '/home/cltbld', 07:15:50 INFO - 'LANG': 'en_US.UTF-8', 07:15:50 INFO - 'LANGUAGE': 'en_US:en', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MAIL': '/var/mail/cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SHLVL': '1', 07:15:50 INFO - 'TERM': 'linux', 07:15:50 INFO - 'TMOUT': '86400', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - '_': '/tools/buildbot/bin/python'} 07:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 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 0x24b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, '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': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:15:50 INFO - Using env: {'DISPLAY': ':0', 07:15:50 INFO - 'HOME': '/home/cltbld', 07:15:50 INFO - 'LANG': 'en_US.UTF-8', 07:15:50 INFO - 'LANGUAGE': 'en_US:en', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MAIL': '/var/mail/cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SHLVL': '1', 07:15:50 INFO - 'TERM': 'linux', 07:15:50 INFO - 'TMOUT': '86400', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - '_': '/tools/buildbot/bin/python'} 07:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Running post-action listener: _resource_record_post_action 07:15:50 INFO - Running post-action listener: _start_resource_monitoring 07:15:50 INFO - Starting resource monitoring. 07:15:50 INFO - [mozharness: 2017-03-17 14:15:50.928179Z] Finished create-virtualenv step (success) 07:15:50 INFO - [mozharness: 2017-03-17 14:15:50.928650Z] Running install step. 07:15:50 INFO - Running pre-action listener: _resource_record_pre_action 07:15:50 INFO - Running main action method: install 07:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:51 INFO - Reading from file tmpfile_stdout 07:15:51 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:51 INFO - Reading from file tmpfile_stdout 07:15:51 INFO - Output received: 07:15:51 INFO - Usage: mozinstall [options] installer 07:15:51 INFO - Options: 07:15:51 INFO - -h, --help show this help message and exit 07:15:51 INFO - -d DEST, --destination=DEST 07:15:51 INFO - Directory to install application into. [default: 07:15:51 INFO - "/builds/slave/test"] 07:15:51 INFO - --app=APP Application being installed. [default: firefox] 07:15:51 INFO - mkdir: /builds/slave/test/build/application 07:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:16:07 INFO - Reading from file tmpfile_stdout 07:16:07 INFO - Output received: 07:16:07 INFO - /builds/slave/test/build/application/firefox/firefox 07:16:07 INFO - Running post-action listener: _resource_record_post_action 07:16:07 INFO - [mozharness: 2017-03-17 14:16:07.901239Z] Finished install step (success) 07:16:07 INFO - [mozharness: 2017-03-17 14:16:07.901579Z] Running run-tests step. 07:16:07 INFO - Running pre-action listener: _resource_record_pre_action 07:16:07 INFO - Running main action method: run_tests 07:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:07 INFO - Python 2.7.3 07:16:07 INFO - Return code: 0 07:16:07 INFO - grabbing minidump binary from tooltool 07:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:07 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 0x2750400>, '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 0x27513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2751840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:16:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:16:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:16:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:07 INFO - Return code: 0 07:16:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:16:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:07 INFO - ENV: RUST_BACKTRACE is now 1 07:16:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:16:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:16:07 INFO - Using env: {'DISPLAY': ':0', 07:16:07 INFO - 'HOME': '/home/cltbld', 07:16:07 INFO - 'LANG': 'en_US.UTF-8', 07:16:07 INFO - 'LANGUAGE': 'en_US:en', 07:16:07 INFO - 'LOGNAME': 'cltbld', 07:16:07 INFO - 'MAIL': '/var/mail/cltbld', 07:16:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:07 INFO - 'MOZ_NO_REMOTE': '1', 07:16:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:07 INFO - 'NO_EM_RESTART': '1', 07:16:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:07 INFO - 'PWD': '/builds/slave/test', 07:16:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:07 INFO - 'RUST_BACKTRACE': '1', 07:16:07 INFO - 'SHELL': '/bin/bash', 07:16:07 INFO - 'SHLVL': '1', 07:16:07 INFO - 'TERM': 'linux', 07:16:07 INFO - 'TMOUT': '86400', 07:16:07 INFO - 'USER': 'cltbld', 07:16:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182', 07:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:07 INFO - '_': '/tools/buildbot/bin/python'} 07:16:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:16:08 INFO - mozversion application_buildid: 20170317132824 07:16:08 INFO - mozversion application_changeset: 9a95ade0ec97a871f97c397261fc7297e897331f 07:16:08 INFO - mozversion application_display_name: Nightly 07:16:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:08 INFO - mozversion application_name: Firefox 07:16:08 INFO - mozversion application_remotingname: firefox 07:16:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:16:08 INFO - mozversion application_vendor: Mozilla 07:16:08 INFO - mozversion application_version: 55.0a1 07:16:08 INFO - mozversion platform_buildid: 20170317132824 07:16:08 INFO - mozversion platform_changeset: 9a95ade0ec97a871f97c397261fc7297e897331f 07:16:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:16:08 INFO - mozversion platform_version: 55.0a1 07:16:08 INFO - using testdate: 1489760168 07:16:08 INFO - actual date: 1489760168 07:16:08 INFO - starting webserver on 'localhost:43305' 07:16:08 INFO - SUITE-START | Running 2 tests 07:16:08 INFO - TEST-START | dromaeo_css 07:16:08 INFO - operating with platform_type : linux_ 07:16:08 INFO - Initialising browser for dromaeo_css test... 07:16:08 INFO - TEST-INFO | started process 19431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAOC23t/profile http://localhost:43305/getInfo.html) 07:16:11 INFO - PID 19431 | __metrics Screen width/height:1600/1200 07:16:11 INFO - PID 19431 | colorDepth:24 07:16:11 INFO - PID 19431 | Browser inner width/height: 1024/697 07:16:11 INFO - PID 19431 | __metrics 07:16:13 INFO - PID 19431 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:16:13 INFO - PID 19431 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:16:14 INFO - TEST-INFO | 19431: exit 0 07:16:14 INFO - Browser initialized. 07:16:14 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:14 INFO - TEST-INFO | started process 19525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAOC23t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:25 INFO - PID 19525 | RSS: Main: 144584704 07:16:25 INFO - PID 19525 | 07:19:27 INFO - PID 19525 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43305/tests/dromaeo/cssquery-ext.html) 07:19:29 INFO - PID 19525 | RSS: Main: 302456832 07:19:29 INFO - PID 19525 | 07:21:16 INFO - PID 19525 | ************************* 07:21:16 INFO - PID 19525 | A coding exception was thrown and uncaught in a Task. 07:21:16 INFO - PID 19525 | 07:21:16 ERROR - PID 19525 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:21:16 INFO - PID 19525 | Full stack: 07:21:16 INFO - PID 19525 | ************************* 07:22:31 INFO - PID 19525 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-ext.html (next: http://localhost:43305/tests/dromaeo/cssquery-jquery.html) 07:22:32 INFO - PID 19525 | RSS: Main: 237080576 07:22:32 INFO - PID 19525 | 07:25:34 INFO - PID 19525 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43305/tests/dromaeo/cssquery-mootools.html) 07:25:35 INFO - PID 19525 | RSS: Main: 218492928 07:25:35 INFO - PID 19525 | 07:28:37 INFO - PID 19525 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43305/tests/dromaeo/cssquery-prototype.html) 07:28:37 INFO - PID 19525 | RSS: Main: 175730688 07:28:37 INFO - PID 19525 | 07:31:40 INFO - PID 19525 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43305/tests/dromaeo/cssquery-yui.html) 07:31:41 INFO - PID 19525 | RSS: Main: 182956032 07:31:41 INFO - PID 19525 | 07:34:43 INFO - PID 19525 | Cycle 1(1): loaded http://localhost:43305/tests/dromaeo/cssquery-yui.html (next: http://localhost:43305/tests/dromaeo/cssquery-dojo.html) 07:34:44 INFO - PID 19525 | RSS: Main: 243290112 07:34:44 INFO - PID 19525 | 07:34:44 INFO - PID 19525 | __start_tp_report 07:34:44 INFO - PID 19525 | _x_x_mozilla_page_load 07:34:44 INFO - PID 19525 | _x_x_mozilla_page_load_details 07:34:44 INFO - PID 19525 | |i|pagename|runs| 07:34:44 INFO - PID 19525 | |0;dojo.html;3158.4630612795822;3179.6661350558193;3232.4343239933005;3234.0782876880094;3241.98379008105;5277.12927366984;5387.545362752059;5390.1375779875225;5391.32608423947;5421.810236641718;5420.674759514432;5440.047991601474;5460.453954604538;5482.095454250044;5485.369182544008;4806.3511425957395;4853.538913803201;4888.584470320018;4937.481564435737;4969.304297398349;4917.852464426073;4922.458529561745;4966.404031516223;4974.552290293873;4997.975010124963;4826.686265392738;4839.516048395168;4873.244647079709;4880.975595122001;4903.901921961558;4824.565789078964;4860.465348811663;4867.148249056401;4903.8774030649165;4935.111679897617;4801.423829140525;4841.951580484185;4864.100141473838;4872.171730805771;4875.756212189376;5281.52466278033;5292.788288468457;5338;5374.179344268778;5429.755660995225;5724.141378793172;5733.340665823442;5786.247787787603;5788.450097240755;5792.7972520961985;5742;5742.081266997302;5755.280589926259;5761.855953601152;5824.446677565625;5348.304720386403;5428.9185662215095;5437.619366644337;5439.374471935738;5439.809606663748;5855.824325270249;5991.161237426677;6038.33578306386;6043.214382130295;6043.909341359883;5630.971845140748;5673.177389278531;5694.4590263924865;5694.686792226385;5746.454086861825;5784.59507834456;5836.941630583639;5837.066069428871;5849.61977471463;5895.233619629421;5579.637323573955;5790.334111577138;5790.565707571865;5793.710314484259;5797.623154494944;5680;5683.0338842396895;5699.74351154199;5701.914471282934;5733.283339582552;4466.59800617946;4474.597286244254;4476.552344765562;4476.776161191992;4478.104379124188;4044.15072834708;4055.4930633670792;4058.2086493134148;4059.6955228357992;4062.8171732272117;5420.512153906088;5456.072467680504;5497.615166938356;5508.504234618904;5515.227868098469;5791.449812267828;5822.912656310159;5836.299644042742;5837.3287071986415;5844.912326315109;5481.616286859881;5483.396826349099;5494.1758736189895;5528.143137813645;5552.666839989613;4989.476105008995;4993.051320249141;4998.6500944933505;5001.8499445016705;5026.2460630904925;6013.849653758691;6015.909761353583;6015.939840601625;6018.8194354169445;6078.118672792509;5684.687342196054;5739.62692424991;5744.425557444222;5797.594168408171;5821.534277257894;6006.189164462741;6033.5173186145885;6035.305939816802;6039.698015099139;6087.05650624154;5718.485336319751;5718.857028574319;5719.685417302088;5721.256236689203;5723.055695810312;5700.059490184239;5748.971255143698;5809.680467574324;5813.302403711582;5837.67892765885;5659.490645841729;5674.914876276776;5680.857978550404;5682.005649011489;5701.458361455655;5658.122990936411;5659.801906933238;5663.773449061991;5668.886622267614;5676.120201368794;5543.778248870161;5560.082586373365;5639.436056394327;5655.943440565542;5679.943200567942;5677.801276955287;5705.657660540215;5736.0822268438515;5754.251947246831;5756.798512052058;5537.584681148849;5545.667259964415;5549.195366671891;5549.38956714753;5558.722063896708 07:34:44 INFO - PID 19525 | |1;ext.html;682.4506272450675;752.2665401233797;769.8498792735417;823.6170180865896;830.9542975136372;29772.87384824595;38088;38336.616633833655;38511.80744096279;38571;39392.60607393925;39887.800560997224;39900.600993990054;39931;39934.60065399345;7207.24323945986;8908.198262156404;9093.499857507835;9133.17801397874;9136.817263654722;7353.338199562038;10032.247581431386;10291.279610427273;10292.845607315896;10295.58817647297;10499;10521.368717876914;10557.73605659857;10567.73580660482;10569.471526423686;10700.839487407695;10710.143188544898;10713;10778.407187604678;10808;9790.412575245437;9965.10314071737;9967.950160249153;9973.401595904197;9977.401355918595;40445.797771010955;40660.39009414861;40759.1848163038;40807.591924080676;40824;3853.556840963297;3881.4565960765517;3887;3899.688024958025;3916.549596796348;28966.855165724246;29020.41959160805;29022.41955160885;29154.708452915624;29212.269693257625;4116.300228961054;4215.777181647323;4224.387463817729;4279.957200428018;4405.31717583775;213669;213796;214544;215403;215508.99999999843;50788;50830.23754643683;50859.745701272;51047.234291485656;51055.744721276154;53055;53461.39615811532;53737.731311343196;53756;53788;15693;15791.684166316609;15803.130827804582;15807.288672009787;15841.603959901095;10974.615888443866;11129.777404452028;12892.742145157044;12901.354932253349;12903;12907.225566466042;13149.079564430398;13152.342382880817;13156.736865262641;13166.144200626928;4916.59876935079;5412.485813847678;5459.508644222039;5555.638883472642;5561.6663000219305;900.7162743735834;927.2118699105706;928.9024652411534;936.6487567162314;952.2096659772373;24274.878625606758;24908.12821551237;26857.328566785985;27158.864205678845;27272.727272727414;980.7940332530248;981.3866333541537;990.1435258501344;991.7371896447447;1019.2304809868501;13472.595822125351;14256.35846386915;14496.492622758364;14502.274886255645;14529.564113076625;271872;273880;274098;274474;274767;39775.80112099421;40532;46662;47561.286580701315;47645.52354476411;1384.861513848607;1407.8310602727738;1423.011007349882;1429.371076726237;1504.5561559340022;27164;28441.715582843906;29156.979505717198;29516.852415737783;29823.403531928805;37352.62647373491;37380;37404.25191496209;37420.25159496849;37445.2510949774;240134;240145;240505;240804;241907;30558.694413056473;30748.692513074584;31116.066518004496;31152.688473115886;31265.905693300625;30134;40317.193656126125;40650.59349406586;41209.58790412178;43718.78140609276;35608.82195589005;36136.4579531302;37222;42190.367144492244;42948.78525607352;38368.42447363347;38557.614423855404;39219;39361.80319098386;40617.390739139526;38445.807770960964;38923.80538097292;39034.414483782195;41750;41942.790286048374;30570.694293056786;32764.508532371558;32851.67148328486;33112.834435827666;35702.4644630336;25988.740112598633;26439.471210576066;26594.384900405035;26631.60052599251;28099.65266498397 07:34:44 INFO - PID 19525 | |2;jquery.html;426.90390184195587;427.40590579095044;428.1992673700181;442.316620820832;451.8463722334406;21245.57508849822;21378.679319810217;21993.34019979403;22272.665910011343;22298.21956231528;20503;20718.964051797426;20725.68911466329;20979.265725699603;21521.139154433804;5189.884174902395;6326.272478664955;6657.400833924946;6663.400293973541;6667;6532.836679083037;6606.669666516679;6630.336966303355;6637.568558043736;6637.93362066378;6361.491080713555;6572.441342485894;6634.203895532519;6640.974502776651;6643.6346000969925;6586.9670651646675;6592.241892182413;6640.369164929324;6646.567973081758;6654.567453115532;6337.7781777637565;6489.1888513935755;6493.870122597522;6497.285298617148;6500.642464664442;23132.53734925309;24568.631470527776;24588.508229835483;24605.38486537851;24654.630180547305;3257;3343.130785995634;3410.7100896423585;3421.8973430797114;3448.603410607762;15956.122413267265;16020.35918563256;16307.184640767915;16332.836671633251;16361.263743131469;2224.610693128696;2228.5320082782637;2260.220224022726;2268.478250002492;2342.9179978700663;90643.59058959926;91264;91810.5409472955;98157;107682;17835.28658853657;18156.636867262845;18166.364177253734;18357.816421835876;18690.813091868906;32566.185845354055;32599.837000814845;32619;32923.3415331692;32950.83524582362;9945.850812237823;10095.192384609214;10119.342242754345;10236.747915458587;10253.282270241012;8330.8333833323;8355.832883342298;8381.580920953927;8538.743837684879;8602.655893764178;9612.711618651312;9883.406995580288;9910.653127140515;9984.80030399388;10030.548625311878;3673.81630918453;3754.267917756066;3763.247350529905;3767.246550689873;3768.9434658480145;899.9190072893471;909.9226565741853;914.5610107148606;918.1782304837267;924.8658944453151;20580.897095514425;21692.891535542538;21791.237306694507;21874.562508749736;21886.781132188793;909.481595490564;909.5969938564904;930.3348106104168;935.5369092299355;937.6811883959487;11261.718457038476;11709.941450292865;11850.762984740257;11903.166778325434;12042.458089385998;608413;618035;619486;619869;620104;69899;96407.51796240974;103084.48457757663;107544;111392.4430377843;1210.0138387214392;1227.96930076747;1264.386772415378;1273.5415250509993;1282.7819270723999;19569.217231310588;19639.410817675493;20369;20440.79559204389;20487.4878128048;48531;48846.755766220944;49824;49878;51014.74492627662;62656.37343626505;63004.68497657666;63803.3619663816;64321.67839160774;65708.14377843171;10654.467276636293;10750.838737418788;10813.51339189754;10830;11180.440977951233;12379.133460657667;12445.377731113227;12449.93775031119;12501.187422817487;12518.937405312916;10336.534855931652;10740.785184296426;11091.833622495507;11495.930732468236;11533.67362753294;10506.106980906708;10845.349279043283;11138.3873886937;11171.162162837982;11181.161412894227;10802.243842930919;10957.178211634;10977.451127443755;11159.49782259784;11292.7741445169;10612.416317102325;10625.681229563126;10639.308444951053;10766.515506802056;10884.238103333008;10227.130693891102;10706.73233169177;10770.569177232823;11048.779024419306;11189.272697274651 07:34:44 INFO - PID 19525 | |3;mootools.html;1509.366066252174;1527.1600619659184;1557.1591340676036;1562.3281988744839;1624.9918750406248;10319;10688.09151222147;10702;10708.25042247043;10708.78582428351;10374.740631484217;10480.423576703279;10688.786224275509;10702.143828493721;10705.250632455713;2209.2930262316104;2217.201807349361;2246.3485589179118;2246.415931857721;2250.077468238023;2133.4986278224683;2149.892505374733;2165.415337858777;2167.371462275938;2172.2397160993683;2102.484891201658;2111.356036408895;2120.2473122041683;2123.787621237879;2126.6916297136904;2115.6932244824493;2169.143188440565;2173.1090252996196;2177.150911144655;2177.6515757478887;2026.7567891852925;2091.5816836632735;2103.5897999890026;2104.610647030289;2107.2940564910773;10873.510692018877;10943.726406839813;10946.288491248044;10953.17851161158;10963.671089867317;5133.153029750087;5340.759665815048;5346.251524786533;5347.6256662033675;5349.679019258857;2928.809627374214;3047.8628461719277;3098.163495856129;3101.984490077558;3117.0492999635103;1140.1334985411065;1191.2316555821533;1201.1771936223715;1227.061298106949;1271.8600953895063;15799.763003554956;15935;16011.359545618161;16102.194890255558;16208;3959.148783011666;4117.835286588503;4197.580241975778;4204.66362690984;4299.785010749512;12183.208091474025;12213.389330533439;12237.53149622051;12244.755104897853;12246.693832654077;5323.121684922022;5333.280007199056;5339.759710812945;5349.86625334362;5358.2498450217;4517.525659805673;4620.399348084795;4647;4658.510856360102;4690.554397332248;3448.758586898943;3466.809325487072;3481.686648201674;3515.8026233603996;3540.061883600848;900.2392977933636;903.1059251341256;905.7871400220943;912.5528491039476;914.3736540469799;764.9655765490567;784;792.9326007289329;796.7410591557767;805.1465446626595;6305.8108256752375;6377.362263773585;6415.743370265231;6423.42189202974;6432.4532414744335;967.298708436378;980.1032055669126;988.3921388346259;992.7567745902156;1003.3377970539409;4091.9335735453406;4108.856190033334;4169.6455801256625;4190.350495673115;4208.894777630584;12542.623721288375;12721.745565088831;12915.741685166431;12984.545540906023;13125.081244312998;10546;11499.3675347855;13026.80459793104;13074.542391016459;13424.93287533556;8326.29226515753;9876.259280553988;9902.801943961225;9955.502224888727;9966.950165249127;6402.743890244338;6426.871462570629;6433.292337842927;6515.641639709672;6541.771038013647;11872.643820685393;12120.393980301125;12148.878511214774;12229.205101668364;12260.386980650754;11900.166988310735;12092.758144836878;12269.570565030539;12373.876261237272;12434.564790232298;8169.959150204211;8258.958705206436;8357.749267521984;8367.874481882654;8420.284275836377;9897.802043958936;10028.448435336126;10132.696019119438;10184.541695623862;10212.693619191436;8691.695790647296;8706.782330441789;8721.91278087211;8735.388522803343;8778.56107194625;8505.74482765518;8635.827283454422;8728.869066963875;8750.956245218733;8881.822363552821;7119.288071192839;7143.749968751069;7172.569645821059;7181;7388.741394051182;5497.945020549903;5511.255980442589;5616.269884914935;5683.857903552444;5740.253767010262;5621.437856214346;5632.85917852057;5698.344690360495;5843.2695913010875;5893.675847828411 07:34:44 INFO - PID 19525 | |4;prototype.html;401.25567073079435;402.416496080683;413.98758037258875;421.831784627017;426.17535069640246;5680.119581464869;5687.516561092307;5706.172604972282;5709.800156994506;5711.485966263031;5408.540274076709;5458.699771512565;5543;5589.804356847511;5596.58025648076;4442.7112237704605;4459.907322705925;4481.932771008437;4485.5962963333295;4499;4451.688381813275;4473.955260447403;4475.462944446671;4477.395551600524;4483.663725220606;4357.477102747659;4424.712393694415;4464.129494748526;4473.105378924212;4474.172278128541;4435.246008178618;4444.799824087066;4460.375547423363;4472.709273897202;4473.977630111861;4050.1697152083752;4062.756234625932;4068.9796551017057;4080.9591904080876;4082.9591704082877;5269.6311258211945;5453.318335208099;5468.234447177399;5506.697131657757;5532.174382453821;5212.869678258036;5214.739263036871;5221;5230.189320655304;5240.4759524047295;5772.191893134965;5924.437178468082;5935.465808077251;5948.196993405922;5958.195643588104;4480.977595112036;4495.370648109268;4510.391097201868;4515.187266292066;4524.547545245482;5928.64428134309;6092.908606370864;6146.29317628474;6152.815415537541;6183.783567575113;4918.606511479073;5152.175651895679;5152.639315247897;5153.098207813618;5304.575633949275;5429.972850135724;5450.890982180414;5466.043442397565;5468.671879687232;5475.260839786658;5173.922391164136;5270.446603106619;5554.50009499147;5601.795613942941;5678.630888992202;5909.704514774244;5920.703964801829;5935.109733540004;5962.85092872673;5969.910451343233;1848.7042073268212;1861.692820684599;1874.4189301316362;1886.6038131992161;1888.5278680329918;1521.68044710612;1524.7331716949489;1547.5666813292296;1566.772817941392;1579.3682526989296;5649.615844118135;5669.092945128759;5671.773129074873;5711.257536520226;5726.198332233491;6043.3050199227655;6065.423784740443;6110.114033465123;6111;6129.233845769279;5537.8061767837935;5669.574781891375;5689.317281926195;5710.400407957105;5716.399778023331;3213.4055199788113;3225.774195806318;3226.6125566006845;3233.2725136844024;3254.1051210917185;6072.787452439144;6362.363763623601;6382.393672601095;6389.616623002635;6399.296077431479;6330.335314791972;6340.778072767431;6344.397282258178;6362.586431881913;6369.968150159312;6229.781957631461;6435.678216089177;6461.25695545009;6464.450521705614;6470.838229044311;6162.753489860355;6163.161917894431;6163.537734669828;6171.84570385744;6186.133941248138;6057.333693293646;6077.392260773887;6103.542234332354;6121.173641558511;6130.448259656652;5883.323417807007;6078.848028799315;6234.844128896814;6341.858465476074;6384.680765961591;4967.975160124176;4994.625403094709;4996.975015124901;5011.173156429149;5039.319691841554;5942.524598032233;6175;6176.320604733565;6189.133521306931;6194.659293738888;5938.495227905676;5966.313873904556;5979.910301345571;5987;6019.18740969981;5845.736941837713;5938.406159384027;5964.433378829004;5983.132445795422;5994.580379373402;5920.230370051866;5926.555508336978;5969.73136208863;5974.342822289632;5994.670293133745;6020.518358531394;6023.247094113236;6027.879442411215;6036.336003039574;6038.154658347747;5569.387367389503;5830;5863.706814659336;5864.182103547913;5894.852628684317 07:34:44 INFO - PID 19525 | |5;yui.html;772.7334069745939;779.364817673596;812.4800127918131;823.89289392379;862.6980556805123;16228.594285142863;16501.917490412532;16583.585410364747;16639.833601663995;16711.331546738133;15781.763273550878;15808.841911580881;15815;15949.441769538069;16007.119608421532;832.1013305629921;837.5058715357937;854.2141230068352;859.1108203009886;867.6225841758824;869.8999615044256;874.0647507167333;878.4685265414428;878.8681697745358;878.9428687135347;907.3421769217331;909.4452384045727;909.4634165842152;909.5088652127876;910.3945875992457;895.3687650206654;902.4179404284265;902.9864552031725;903.9683611073614;905.651324240169;655.6164643683451;656.8292244016542;657.4346062386344;657.5298661457081;664.8437617159964;16908.57728556796;17127.143642817933;17144.485665430057;17248.655026899516;17779.555511112325;16296.348146074142;16335.509934701979;16396.83603163965;16423.260953257013;16782.328706851833;11891.94054029733;12153.331566763825;12240.409846307635;12564.183328083645;12909.677258068623;3873.9418908716393;3992.86024989124;4001.8599349022934;4050.2911990401562;4127.876163715094;70152;79355;80499;82371;83085.58457207735;11591.988211537418;11869.703257418461;12124.515019399125;12270.263784172977;12569.434375453127;22699.773002269765;23558.175463859025;23808.761912380654;23854.88072559626;24704.258872233862;8601.935635377044;8732.345074119467;8741.30069594431;8803.647854085764;8921.197092261727;4501.504834468205;4550.13547425988;4562.110388474216;4680.67235293533;4728.219843725747;3399.048266485388;3454.4300190468293;3459.4810778383444;3463.8614455421502;3485.4074807282823;585.0872638683667;586.3755100817701;589.2457654202627;589.7817807411285;589.8053642298117;760.8592410403983;782.4483738964017;789.1556035042564;793.2939683681528;796.8207153390557;10509.474526273656;10977.152010791537;11150.944245278723;11184.664460066047;11517.424128793527;659.3340725866909;777.7472321495536;806.2944923192207;817.6320655704957;831.4346244553641;4678.415198100238;5239.240310155083;5271.262023316739;5340.519353258225;5385.461453854583;72280;73974;74957.25042749612;75219.62390188014;76533;66093;67082.66458667675;67373.32626673671;67434.3256567428;67447.32552674509;58219.4178058214;58870.41129588649;59163.11255331174;59207.703961479914;60077.39922600718;9780.951095244478;10241.692749217535;10256.333338332985;10273.743156420851;10278.897211028094;38486.80756596199;39184.608153918096;39440;40183;40955.38566921558;45266.32100518561;45981.080378391576;47403.762981184875;48222.51777482321;48473.27290090581;12707.428165732748;12712.237265763713;12747.298898560297;13117.60647180586;13359.53241636538;13476.460941562227;13623.18260904349;13762.174269543859;13810.171389716648;13978.521341993433;12931.482740690268;12933.224006559636;13021.348932553145;13374.465021399035;13505.12216705911;12255.571055013032;12439;12621.432035558239;13015.219086854819;13063.216207027608;11921.642350729491;11993.160478766402;12032;12321.630351089481;12764.553240636533;10750.569977201138;10961;10991.120710343313;11119.332840029625;11384.14618903602;10731.517081731185;10982.495344506518;11015.504302306255;11038.834417483904;11084.667459976214 07:34:44 INFO - PID 19525 | __end_tp_report 07:34:44 INFO - PID 19525 | __start_cc_report 07:34:44 INFO - PID 19525 | _x_x_mozilla_cycle_collect,1645 07:34:44 INFO - PID 19525 | __end_cc_report 07:34:44 INFO - PID 19525 | __startTimestamp1489761284216__endTimestamp 07:34:44 INFO - PID 19525 | 07:34:44 INFO - PID 19525 | ------- Summary: start ------- 07:34:44 INFO - PID 19525 | Number of tests: 6 07:34:44 INFO - PID 19525 | 07:34:44 INFO - PID 19525 | [#0] dojo.html Cycles:165 Average:5383.56 Median:5579.64 stddev:599.69 (10.7%) stddev-sans-first:575.56 07:34:44 INFO - PID 19525 | Values: 3158.5 3179.7 3232.4 3234.1 3242.0 5277.1 5387.5 5390.1 5391.3 5421.8 5420.7 5440.0 5460.5 5482.1 5485.4 4806.4 4853.5 4888.6 4937.5 4969.3 4917.9 4922.5 4966.4 4974.6 4998.0 4826.7 4839.5 4873.2 4881.0 4903.9 4824.6 4860.5 4867.1 4903.9 4935.1 4801.4 4842.0 4864.1 4872.2 4875.8 5281.5 5292.8 5338.0 5374.2 5429.8 5724.1 5733.3 5786.2 5788.5 5792.8 5742.0 5742.1 5755.3 5761.9 5824.4 5348.3 5428.9 5437.6 5439.4 5439.8 5855.8 5991.2 6038.3 6043.2 6043.9 5631.0 5673.2 5694.5 5694.7 5746.5 5784.6 5836.9 5837.1 5849.6 5895.2 5579.6 5790.3 5790.6 5793.7 5797.6 5680.0 5683.0 5699.7 5701.9 5733.3 4466.6 4474.6 4476.6 4476.8 4478.1 4044.2 4055.5 4058.2 4059.7 4062.8 5420.5 5456.1 5497.6 5508.5 5515.2 5791.4 5822.9 5836.3 5837.3 5844.9 5481.6 5483.4 5494.2 5528.1 5552.7 4989.5 4993.1 4998.7 5001.8 5026.2 6013.8 6015.9 6015.9 6018.8 6078.1 5684.7 5739.6 5744.4 5797.6 5821.5 6006.2 6033.5 6035.3 6039.7 6087.1 5718.5 5718.9 5719.7 5721.3 5723.1 5700.1 5749.0 5809.7 5813.3 5837.7 5659.5 5674.9 5680.9 5682.0 5701.5 5658.1 5659.8 5663.8 5668.9 5676.1 5543.8 5560.1 5639.4 5655.9 5679.9 5677.8 5705.7 5736.1 5754.3 5756.8 5537.6 5545.7 5549.2 5549.4 5558.7 07:34:44 INFO - PID 19525 | 07:34:44 INFO - PID 19525 | [#1] ext.html Cycles:180 Average:41307.62 Median:37366.31 stddev:63346.59 (169.5%) stddev-sans-first:63450.86 07:34:44 INFO - PID 19525 | Values: 682.5 752.3 769.8 823.6 831.0 29772.9 38088.0 38336.6 38511.8 38571.0 39392.6 39887.8 39900.6 39931.0 39934.6 7207.2 8908.2 9093.5 9133.2 9136.8 7353.3 10032.2 10291.3 10292.8 10295.6 10499.0 10521.4 10557.7 10567.7 10569.5 10700.8 10710.1 10713.0 10778.4 10808.0 9790.4 9965.1 9968.0 9973.4 9977.4 40445.8 40660.4 40759.2 40807.6 40824.0 3853.6 3881.5 3887.0 3899.7 3916.5 28966.9 29020.4 29022.4 29154.7 29212.3 4116.3 4215.8 4224.4 4280.0 4405.3 213669.0 213796.0 214544.0 215403.0 215509.0 50788.0 50830.2 50859.7 51047.2 51055.7 53055.0 53461.4 53737.7 53756.0 53788.0 15693.0 15791.7 15803.1 15807.3 15841.6 10974.6 11129.8 12892.7 12901.4 12903.0 12907.2 13149.1 13152.3 13156.7 13166.1 4916.6 5412.5 5459.5 5555.6 5561.7 900.7 927.2 928.9 936.6 952.2 24274.9 24908.1 26857.3 27158.9 27272.7 980.8 981.4 990.1 991.7 1019.2 13472.6 14256.4 14496.5 14502.3 14529.6 271872.0 273880.0 274098.0 274474.0 274767.0 39775.8 40532.0 46662.0 47561.3 47645.5 1384.9 1407.8 1423.0 1429.4 1504.6 27164.0 28441.7 29157.0 29516.9 29823.4 37352.6 37380.0 37404.3 37420.3 37445.3 240134.0 240145.0 240505.0 240804.0 241907.0 30558.7 30748.7 31116.1 31152.7 31265.9 30134.0 40317.2 40650.6 41209.6 43718.8 35608.8 36136.5 37222.0 42190.4 42948.8 38368.4 38557.6 39219.0 39361.8 40617.4 38445.8 38923.8 39034.4 41750.0 41942.8 30570.7 32764.5 32851.7 33112.8 35702.5 25988.7 26439.5 26594.4 26631.6 28099.7 07:34:44 INFO - PID 19525 | 07:34:44 INFO - PID 19525 | [#2] jquery.html Cycles:180 Average:35102.32 Median:24578.57 stddev:101343.52 (412.3%) stddev-sans-first:101594.37 07:34:44 INFO - PID 19525 | Values: 426.9 427.4 428.2 442.3 451.8 21245.6 21378.7 21993.3 22272.7 22298.2 20503.0 20719.0 20725.7 20979.3 21521.1 5189.9 6326.3 6657.4 6663.4 6667.0 6532.8 6606.7 6630.3 6637.6 6637.9 6361.5 6572.4 6634.2 6641.0 6643.6 6587.0 6592.2 6640.4 6646.6 6654.6 6337.8 6489.2 6493.9 6497.3 6500.6 23132.5 24568.6 24588.5 24605.4 24654.6 3257.0 3343.1 3410.7 3421.9 3448.6 15956.1 16020.4 16307.2 16332.8 16361.3 2224.6 2228.5 2260.2 2268.5 2342.9 90643.6 91264.0 91810.5 98157.0 107682.0 17835.3 18156.6 18166.4 18357.8 18690.8 32566.2 32599.8 32619.0 32923.3 32950.8 9945.9 10095.2 10119.3 10236.7 10253.3 8330.8 8355.8 8381.6 8538.7 8602.7 9612.7 9883.4 9910.7 9984.8 10030.5 3673.8 3754.3 3763.2 3767.2 3768.9 899.9 909.9 914.6 918.2 924.9 20580.9 21692.9 21791.2 21874.6 21886.8 909.5 909.6 930.3 935.5 937.7 11261.7 11709.9 11850.8 11903.2 12042.5 608413.0 618035.0 619486.0 619869.0 620104.0 69899.0 96407.5 103084.5 107544.0 111392.4 1210.0 1228.0 1264.4 1273.5 1282.8 19569.2 19639.4 20369.0 20440.8 20487.5 48531.0 48846.8 49824.0 49878.0 51014.7 62656.4 63004.7 63803.4 64321.7 65708.1 10654.5 10750.8 10813.5 10830.0 11180.4 12379.1 12445.4 12449.9 12501.2 12518.9 10336.5 10740.8 11091.8 11495.9 11533.7 10506.1 10845.3 11138.4 11171.2 11181.2 10802.2 10957.2 10977.5 11159.5 11292.8 10612.4 10625.7 10639.3 10766.5 10884.2 10227.1 10706.7 10770.6 11048.8 11189.3 07:34:44 INFO - PID 19525 | 07:34:44 INFO - PID 19525 | [#3] mootools.html Cycles:180 Average:6474.36 Median:3457.78 stddev:4208.61 (121.7%) stddev-sans-first:4203.88 07:34:44 INFO - PID 19525 | Values: 1509.4 1527.2 1557.2 1562.3 1625.0 10319.0 10688.1 10702.0 10708.3 10708.8 10374.7 10480.4 10688.8 10702.1 10705.3 2209.3 2217.2 2246.3 2246.4 2250.1 2133.5 2149.9 2165.4 2167.4 2172.2 2102.5 2111.4 2120.2 2123.8 2126.7 2115.7 2169.1 2173.1 2177.2 2177.7 2026.8 2091.6 2103.6 2104.6 2107.3 10873.5 10943.7 10946.3 10953.2 10963.7 5133.2 5340.8 5346.3 5347.6 5349.7 2928.8 3047.9 3098.2 3102.0 3117.0 1140.1 1191.2 1201.2 1227.1 1271.9 15799.8 15935.0 16011.4 16102.2 16208.0 3959.1 4117.8 4197.6 4204.7 4299.8 12183.2 12213.4 12237.5 12244.8 12246.7 5323.1 5333.3 5339.8 5349.9 5358.2 4517.5 4620.4 4647.0 4658.5 4690.6 3448.8 3466.8 3481.7 3515.8 3540.1 900.2 903.1 905.8 912.6 914.4 765.0 784.0 792.9 796.7 805.1 6305.8 6377.4 6415.7 6423.4 6432.5 967.3 980.1 988.4 992.8 1003.3 4091.9 4108.9 4169.6 4190.4 4208.9 12542.6 12721.7 12915.7 12984.5 13125.1 10546.0 11499.4 13026.8 13074.5 13424.9 8326.3 9876.3 9902.8 9955.5 9967.0 6402.7 6426.9 6433.3 6515.6 6541.8 11872.6 12120.4 12148.9 12229.2 12260.4 11900.2 12092.8 12269.6 12373.9 12434.6 8170.0 8259.0 8357.7 8367.9 8420.3 9897.8 10028.4 10132.7 10184.5 10212.7 8691.7 8706.8 8721.9 8735.4 8778.6 8505.7 8635.8 8728.9 8751.0 8881.8 7119.3 7143.7 7172.6 7181.0 7388.7 5497.9 5511.3 5616.3 5683.9 5740.3 5621.4 5632.9 5698.3 5843.3 5893.7 07:34:44 INFO - PID 19525 | 07:34:44 INFO - PID 19525 | [#4] prototype.html Cycles:180 Average:5144.35 Median:5679.38 stddev:1391.75 (24.5%) stddev-sans-first:1349.36 07:34:44 INFO - PID 19525 | Values: 401.3 402.4 414.0 421.8 426.2 5680.1 5687.5 5706.2 5709.8 5711.5 5408.5 5458.7 5543.0 5589.8 5596.6 4442.7 4459.9 4481.9 4485.6 4499.0 4451.7 4474.0 4475.5 4477.4 4483.7 4357.5 4424.7 4464.1 4473.1 4474.2 4435.2 4444.8 4460.4 4472.7 4474.0 4050.2 4062.8 4069.0 4081.0 4083.0 5269.6 5453.3 5468.2 5506.7 5532.2 5212.9 5214.7 5221.0 5230.2 5240.5 5772.2 5924.4 5935.5 5948.2 5958.2 4481.0 4495.4 4510.4 4515.2 4524.5 5928.6 6092.9 6146.3 6152.8 6183.8 4918.6 5152.2 5152.6 5153.1 5304.6 5430.0 5450.9 5466.0 5468.7 5475.3 5173.9 5270.4 5554.5 5601.8 5678.6 5909.7 5920.7 5935.1 5962.9 5969.9 1848.7 1861.7 1874.4 1886.6 1888.5 1521.7 1524.7 1547.6 1566.8 1579.4 5649.6 5669.1 5671.8 5711.3 5726.2 6043.3 6065.4 6110.1 6111.0 6129.2 5537.8 5669.6 5689.3 5710.4 5716.4 3213.4 3225.8 3226.6 3233.3 3254.1 6072.8 6362.4 6382.4 6389.6 6399.3 6330.3 6340.8 6344.4 6362.6 6370.0 6229.8 6435.7 6461.3 6464.5 6470.8 6162.8 6163.2 6163.5 6171.8 6186.1 6057.3 6077.4 6103.5 6121.2 6130.4 5883.3 6078.8 6234.8 6341.9 6384.7 4968.0 4994.6 4997.0 5011.2 5039.3 5942.5 6175.0 6176.3 6189.1 6194.7 5938.5 5966.3 5979.9 5987.0 6019.2 5845.7 5938.4 5964.4 5983.1 5994.6 5920.2 5926.6 5969.7 5974.3 5994.7 6020.5 6023.2 6027.9 6036.3 6038.2 5569.4 5830.0 5863.7 5864.2 5894.9 07:34:44 INFO - PID 19525 | 07:34:44 INFO - PID 19525 | [#5] yui.html Cycles:180 Average:17276.80 Median:22116.65 stddev:21340.45 (96.5%) stddev-sans-first:21364.32 07:34:44 INFO - PID 19525 | Values: 772.7 779.4 812.5 823.9 862.7 16228.6 16501.9 16583.6 16639.8 16711.3 15781.8 15808.8 15815.0 15949.4 16007.1 832.1 837.5 854.2 859.1 867.6 869.9 874.1 878.5 878.9 878.9 907.3 909.4 909.5 909.5 910.4 895.4 902.4 903.0 904.0 905.7 655.6 656.8 657.4 657.5 664.8 16908.6 17127.1 17144.5 17248.7 17779.6 16296.3 16335.5 16396.8 16423.3 16782.3 11891.9 12153.3 12240.4 12564.2 12909.7 3873.9 3992.9 4001.9 4050.3 4127.9 70152.0 79355.0 80499.0 82371.0 83085.6 11592.0 11869.7 12124.5 12270.3 12569.4 22699.8 23558.2 23808.8 23854.9 24704.3 8601.9 8732.3 8741.3 8803.6 8921.2 4501.5 4550.1 4562.1 4680.7 4728.2 3399.0 3454.4 3459.5 3463.9 3485.4 585.1 586.4 589.2 589.8 589.8 760.9 782.4 789.2 793.3 796.8 10509.5 10977.2 11150.9 11184.7 11517.4 659.3 777.7 806.3 817.6 831.4 4678.4 5239.2 5271.3 5340.5 5385.5 72280.0 73974.0 74957.3 75219.6 76533.0 66093.0 67082.7 67373.3 67434.3 67447.3 58219.4 58870.4 59163.1 59207.7 60077.4 9781.0 10241.7 10256.3 10273.7 10278.9 38486.8 39184.6 39440.0 40183.0 40955.4 45266.3 45981.1 47403.8 48222.5 48473.3 12707.4 12712.2 12747.3 13117.6 13359.5 13476.5 13623.2 13762.2 13810.2 13978.5 12931.5 12933.2 13021.3 13374.5 13505.1 12255.6 12439.0 12621.4 13015.2 13063.2 11921.6 11993.2 12032.0 12321.6 12764.6 10750.6 10961.0 10991.1 11119.3 11384.1 10731.5 10982.5 11015.5 11038.8 11084.7 07:34:44 INFO - PID 19525 | -------- Summary: end -------- 07:34:44 INFO - PID 19525 | 07:34:45 INFO - TEST-INFO | 19525: exit 0 07:34:45 INFO - TEST-OK | dromaeo_css | took 1116870ms 07:34:45 INFO - TEST-START | kraken 07:34:45 INFO - operating with platform_type : linux_ 07:34:45 INFO - Initialising browser for kraken test... 07:34:45 INFO - TEST-INFO | started process 19861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGu9KvS/profile http://localhost:43305/getInfo.html) 07:34:48 INFO - PID 19861 | __metrics Screen width/height:1600/1200 07:34:48 INFO - PID 19861 | colorDepth:24 07:34:48 INFO - PID 19861 | Browser inner width/height: 1024/697 07:34:48 INFO - PID 19861 | __metrics 07:34:49 INFO - PID 19861 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:34:49 INFO - PID 19861 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:34:50 INFO - TEST-INFO | 19861: exit 0 07:34:50 INFO - Browser initialized. 07:34:50 INFO - Running cycle 1/1 for kraken test... 07:34:50 INFO - TEST-INFO | started process 19957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGu9KvS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:02 INFO - PID 19957 | RSS: Main: 144531456 07:35:02 INFO - PID 19957 | 07:35:05 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43305/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:06 INFO - PID 19957 | RSS: Main: 198885376 07:35:06 INFO - PID 19957 | 07:35:08 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43305/tests/kraken/driver.html?testName=audio-dft) 07:35:09 INFO - PID 19957 | RSS: Main: 179691520 07:35:09 INFO - PID 19957 | 07:35:12 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43305/tests/kraken/driver.html?testName=audio-fft) 07:35:12 INFO - PID 19957 | RSS: Main: 261230592 07:35:12 INFO - PID 19957 | 07:35:15 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43305/tests/kraken/driver.html?testName=audio-oscillator) 07:35:15 INFO - PID 19957 | RSS: Main: 173252608 07:35:15 INFO - PID 19957 | 07:35:17 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43305/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:18 INFO - PID 19957 | RSS: Main: 176087040 07:35:18 INFO - PID 19957 | 07:35:21 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43305/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:22 INFO - PID 19957 | RSS: Main: 215216128 07:35:22 INFO - PID 19957 | 07:35:25 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43305/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:26 INFO - PID 19957 | RSS: Main: 230350848 07:35:26 INFO - PID 19957 | 07:35:28 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43305/tests/kraken/driver.html?testName=json-parse-financial) 07:35:29 INFO - PID 19957 | RSS: Main: 244252672 07:35:29 INFO - PID 19957 | 07:35:31 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43305/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:31 INFO - PID 19957 | RSS: Main: 178147328 07:35:31 INFO - PID 19957 | 07:35:33 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:33 INFO - PID 19957 | RSS: Main: 184578048 07:35:33 INFO - PID 19957 | 07:35:36 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:36 INFO - PID 19957 | RSS: Main: 194183168 07:35:36 INFO - PID 19957 | 07:35:39 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:39 INFO - PID 19957 | RSS: Main: 202379264 07:35:39 INFO - PID 19957 | 07:35:42 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:43 INFO - PID 19957 | RSS: Main: 199196672 07:35:43 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | Cycle 1(1): loaded http://localhost:43305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43305/tests/kraken/driver.html?testName=ai-astar) 07:35:45 INFO - PID 19957 | RSS: Main: 267841536 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | __start_tp_report 07:35:45 INFO - PID 19957 | _x_x_mozilla_page_load 07:35:45 INFO - PID 19957 | _x_x_mozilla_page_load_details 07:35:45 INFO - PID 19957 | |i|pagename|runs| 07:35:45 INFO - PID 19957 | |0;ai-astar;105;113;114;115;116;116;114;114;113;114 07:35:45 INFO - PID 19957 | |1;audio-beat-detection;144;126;122;168;118;120;124;118;143;119 07:35:45 INFO - PID 19957 | |2;audio-dft;163;163;162;163;161;161;163;161;162;161 07:35:45 INFO - PID 19957 | |3;audio-fft;73;74;73;111;75;74;77;73;97;75 07:35:45 INFO - PID 19957 | |4;audio-oscillator;82;83;105;83;83;82;100;84;83;114 07:35:45 INFO - PID 19957 | |5;imaging-gaussian-blur;113;114;113;113;113;113;113;113;112;113 07:35:45 INFO - PID 19957 | |6;imaging-darkroom;147;148;147;147;147;147;148;147;147;148 07:35:45 INFO - PID 19957 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 07:35:45 INFO - PID 19957 | |8;json-parse-financial;57;56;57;57;59;59;59;58;59;58 07:35:45 INFO - PID 19957 | |9;json-stringify-tinderbox;54;54;54;53;54;54;54;54;54;55 07:35:45 INFO - PID 19957 | |10;stanford-crypto-aes;80;80;79;78;88;78;77;78;80;79 07:35:45 INFO - PID 19957 | |11;stanford-crypto-ccm;128;126;145;133;124;132;127;124;173;131 07:35:45 INFO - PID 19957 | |12;stanford-crypto-pbkdf2;184;187;185;179;178;181;179;181;180;188 07:35:45 INFO - PID 19957 | |13;stanford-crypto-sha256-iterative;66;63;65;65;64;65;64;64;64;64 07:35:45 INFO - PID 19957 | __end_tp_report 07:35:45 INFO - PID 19957 | __start_cc_report 07:35:45 INFO - PID 19957 | _x_x_mozilla_cycle_collect,1754 07:35:45 INFO - PID 19957 | __end_cc_report 07:35:45 INFO - PID 19957 | __startTimestamp1489761345452__endTimestamp 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | ------- Summary: start ------- 07:35:45 INFO - PID 19957 | Number of tests: 14 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:3.13 (2.7%) stddev-sans-first:1.12 07:35:45 INFO - PID 19957 | Values: 105.0 113.0 114.0 115.0 116.0 116.0 114.0 114.0 113.0 114.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:125.00 stddev:16.44 (13.2%) stddev-sans-first:16.67 07:35:45 INFO - PID 19957 | Values: 144.0 126.0 122.0 168.0 118.0 120.0 124.0 118.0 143.0 119.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 07:35:45 INFO - PID 19957 | Values: 163.0 163.0 162.0 163.0 161.0 161.0 163.0 161.0 162.0 161.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.50 stddev:13.03 (17.5%) stddev-sans-first:13.56 07:35:45 INFO - PID 19957 | Values: 73.0 74.0 73.0 111.0 75.0 74.0 77.0 73.0 97.0 75.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:83.00 stddev:11.84 (14.3%) stddev-sans-first:12.20 07:35:45 INFO - PID 19957 | Values: 82.0 83.0 105.0 83.0 83.0 82.0 100.0 84.0 83.0 114.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:35:45 INFO - PID 19957 | Values: 113.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:35:45 INFO - PID 19957 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:35:45 INFO - PID 19957 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.50 stddev:1.10 (1.9%) stddev-sans-first:1.12 07:35:45 INFO - PID 19957 | Values: 57.0 56.0 57.0 57.0 59.0 59.0 59.0 58.0 59.0 58.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 07:35:45 INFO - PID 19957 | Values: 54.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 54.0 55.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:3.09 (3.9%) stddev-sans-first:3.28 07:35:45 INFO - PID 19957 | Values: 80.0 80.0 79.0 78.0 88.0 78.0 77.0 78.0 80.0 79.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:131.50 stddev:14.92 (11.3%) stddev-sans-first:15.65 07:35:45 INFO - PID 19957 | Values: 128.0 126.0 145.0 133.0 124.0 132.0 127.0 124.0 173.0 131.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:182.50 stddev:3.55 (1.9%) stddev-sans-first:3.71 07:35:45 INFO - PID 19957 | Values: 184.0 187.0 185.0 179.0 178.0 181.0 179.0 181.0 180.0 188.0 07:35:45 INFO - PID 19957 | 07:35:45 INFO - PID 19957 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.67 07:35:45 INFO - PID 19957 | Values: 66.0 63.0 65.0 65.0 64.0 65.0 64.0 64.0 64.0 64.0 07:35:45 INFO - PID 19957 | -------- Summary: end -------- 07:35:45 INFO - PID 19957 | 07:35:46 INFO - TEST-INFO | 19957: exit 0 07:35:46 INFO - TEST-OK | kraken | took 61500ms 07:35:46 INFO - SUITE-END | took 1178s 07:35:46 INFO - Completed test suite (00:19:38) 07:35:46 INFO - javascript benchmark 07:35:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7513.887833978507, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3158.4630612795822, 3179.6661350558193, 3232.4343239933005, 3234.0782876880094, 3241.98379008105, 5277.12927366984, 5387.545362752059, 5390.1375779875225, 5391.32608423947, 5421.810236641718, 5420.674759514432, 5440.047991601474, 5460.453954604538, 5482.095454250044, 5485.369182544008, 4806.3511425957395, 4853.538913803201, 4888.584470320018, 4937.481564435737, 4969.304297398349, 4917.852464426073, 4922.458529561745, 4966.404031516223, 4974.552290293873, 4997.975010124963, 4826.686265392738, 4839.516048395168, 4873.244647079709, 4880.975595122001, 4903.901921961558, 4824.565789078964, 4860.465348811663, 4867.148249056401, 4903.8774030649165, 4935.111679897617, 4801.423829140525, 4841.951580484185, 4864.100141473838, 4872.171730805771, 4875.756212189376, 5281.52466278033, 5292.788288468457, 5338.0, 5374.179344268778, 5429.755660995225, 5724.141378793172, 5733.340665823442, 5786.247787787603, 5788.450097240755, 5792.7972520961985, 5742.0, 5742.081266997302, 5755.280589926259, 5761.855953601152, 5824.446677565625, 5348.304720386403, 5428.9185662215095, 5437.619366644337, 5439.374471935738, 5439.809606663748, 5855.824325270249, 5991.161237426677, 6038.33578306386, 6043.214382130295, 6043.909341359883, 5630.971845140748, 5673.177389278531, 5694.4590263924865, 5694.686792226385, 5746.454086861825, 5784.59507834456, 5836.941630583639, 5837.066069428871, 5849.61977471463, 5895.233619629421, 5579.637323573955, 5790.334111577138, 5790.565707571865, 5793.710314484259, 5797.623154494944, 5680.0, 5683.0338842396895, 5699.74351154199, 5701.914471282934, 5733.283339582552, 4466.59800617946, 4474.597286244254, 4476.552344765562, 4476.776161191992, 4478.104379124188, 4044.15072834708, 4055.4930633670792, 4058.2086493134148, 4059.6955228357992, 4062.8171732272117, 5420.512153906088, 5456.072467680504, 5497.615166938356, 5508.504234618904, 5515.227868098469, 5791.449812267828, 5822.912656310159, 5836.299644042742, 5837.3287071986415, 5844.912326315109, 5481.616286859881, 5483.396826349099, 5494.1758736189895, 5528.143137813645, 5552.666839989613, 4989.476105008995, 4993.051320249141, 4998.6500944933505, 5001.8499445016705, 5026.2460630904925, 6013.849653758691, 6015.909761353583, 6015.939840601625, 6018.8194354169445, 6078.118672792509, 5684.687342196054, 5739.62692424991, 5744.425557444222, 5797.594168408171, 5821.534277257894, 6006.189164462741, 6033.5173186145885, 6035.305939816802, 6039.698015099139, 6087.05650624154, 5718.485336319751, 5718.857028574319, 5719.685417302088, 5721.256236689203, 5723.055695810312, 5700.059490184239, 5748.971255143698, 5809.680467574324, 5813.302403711582, 5837.67892765885, 5659.490645841729, 5674.914876276776, 5680.857978550404, 5682.005649011489, 5701.458361455655, 5658.122990936411, 5659.801906933238, 5663.773449061991, 5668.886622267614, 5676.120201368794, 5543.778248870161, 5560.082586373365, 5639.436056394327, 5655.943440565542, 5679.943200567942, 5677.801276955287, 5705.657660540215, 5736.0822268438515, 5754.251947246831, 5756.798512052058, 5537.584681148849, 5545.667259964415, 5549.195366671891, 5549.38956714753, 5558.722063896708], "value": 5344.358002695447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.4506272450675, 752.2665401233797, 769.8498792735417, 823.6170180865896, 830.9542975136372, 29772.87384824595, 38088.0, 38336.616633833655, 38511.80744096279, 38571.0, 39392.60607393925, 39887.800560997224, 39900.600993990054, 39931.0, 39934.60065399345, 7207.24323945986, 8908.198262156404, 9093.499857507835, 9133.17801397874, 9136.817263654722, 7353.338199562038, 10032.247581431386, 10291.279610427273, 10292.845607315896, 10295.58817647297, 10499.0, 10521.368717876914, 10557.73605659857, 10567.73580660482, 10569.471526423686, 10700.839487407695, 10710.143188544898, 10713.0, 10778.407187604678, 10808.0, 9790.412575245437, 9965.10314071737, 9967.950160249153, 9973.401595904197, 9977.401355918595, 40445.797771010955, 40660.39009414861, 40759.1848163038, 40807.591924080676, 40824.0, 3853.556840963297, 3881.4565960765517, 3887.0, 3899.688024958025, 3916.549596796348, 28966.855165724246, 29020.41959160805, 29022.41955160885, 29154.708452915624, 29212.269693257625, 4116.300228961054, 4215.777181647323, 4224.387463817729, 4279.957200428018, 4405.31717583775, 213669.0, 213796.0, 214544.0, 215403.0, 215508.99999999843, 50788.0, 50830.23754643683, 50859.745701272, 51047.234291485656, 51055.744721276154, 53055.0, 53461.39615811532, 53737.731311343196, 53756.0, 53788.0, 15693.0, 15791.684166316609, 15803.130827804582, 15807.288672009787, 15841.603959901095, 10974.615888443866, 11129.777404452028, 12892.742145157044, 12901.354932253349, 12903.0, 12907.225566466042, 13149.079564430398, 13152.342382880817, 13156.736865262641, 13166.144200626928, 4916.59876935079, 5412.485813847678, 5459.508644222039, 5555.638883472642, 5561.6663000219305, 900.7162743735834, 927.2118699105706, 928.9024652411534, 936.6487567162314, 952.2096659772373, 24274.878625606758, 24908.12821551237, 26857.328566785985, 27158.864205678845, 27272.727272727414, 980.7940332530248, 981.3866333541537, 990.1435258501344, 991.7371896447447, 1019.2304809868501, 13472.595822125351, 14256.35846386915, 14496.492622758364, 14502.274886255645, 14529.564113076625, 271872.0, 273880.0, 274098.0, 274474.0, 274767.0, 39775.80112099421, 40532.0, 46662.0, 47561.286580701315, 47645.52354476411, 1384.861513848607, 1407.8310602727738, 1423.011007349882, 1429.371076726237, 1504.5561559340022, 27164.0, 28441.715582843906, 29156.979505717198, 29516.852415737783, 29823.403531928805, 37352.62647373491, 37380.0, 37404.25191496209, 37420.25159496849, 37445.2510949774, 240134.0, 240145.0, 240505.0, 240804.0, 241907.0, 30558.694413056473, 30748.692513074584, 31116.066518004496, 31152.688473115886, 31265.905693300625, 30134.0, 40317.193656126125, 40650.59349406586, 41209.58790412178, 43718.78140609276, 35608.82195589005, 36136.4579531302, 37222.0, 42190.367144492244, 42948.78525607352, 38368.42447363347, 38557.614423855404, 39219.0, 39361.80319098386, 40617.390739139526, 38445.807770960964, 38923.80538097292, 39034.414483782195, 41750.0, 41942.790286048374, 30570.694293056786, 32764.508532371558, 32851.67148328486, 33112.834435827666, 35702.4644630336, 25988.740112598633, 26439.471210576066, 26594.384900405035, 26631.60052599251, 28099.65266498397], "value": 18038.706222491866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.90390184195587, 427.40590579095044, 428.1992673700181, 442.316620820832, 451.8463722334406, 21245.57508849822, 21378.679319810217, 21993.34019979403, 22272.665910011343, 22298.21956231528, 20503.0, 20718.964051797426, 20725.68911466329, 20979.265725699603, 21521.139154433804, 5189.884174902395, 6326.272478664955, 6657.400833924946, 6663.400293973541, 6667.0, 6532.836679083037, 6606.669666516679, 6630.336966303355, 6637.568558043736, 6637.93362066378, 6361.491080713555, 6572.441342485894, 6634.203895532519, 6640.974502776651, 6643.6346000969925, 6586.9670651646675, 6592.241892182413, 6640.369164929324, 6646.567973081758, 6654.567453115532, 6337.7781777637565, 6489.1888513935755, 6493.870122597522, 6497.285298617148, 6500.642464664442, 23132.53734925309, 24568.631470527776, 24588.508229835483, 24605.38486537851, 24654.630180547305, 3257.0, 3343.130785995634, 3410.7100896423585, 3421.8973430797114, 3448.603410607762, 15956.122413267265, 16020.35918563256, 16307.184640767915, 16332.836671633251, 16361.263743131469, 2224.610693128696, 2228.5320082782637, 2260.220224022726, 2268.478250002492, 2342.9179978700663, 90643.59058959926, 91264.0, 91810.5409472955, 98157.0, 107682.0, 17835.28658853657, 18156.636867262845, 18166.364177253734, 18357.816421835876, 18690.813091868906, 32566.185845354055, 32599.837000814845, 32619.0, 32923.3415331692, 32950.83524582362, 9945.850812237823, 10095.192384609214, 10119.342242754345, 10236.747915458587, 10253.282270241012, 8330.8333833323, 8355.832883342298, 8381.580920953927, 8538.743837684879, 8602.655893764178, 9612.711618651312, 9883.406995580288, 9910.653127140515, 9984.80030399388, 10030.548625311878, 3673.81630918453, 3754.267917756066, 3763.247350529905, 3767.246550689873, 3768.9434658480145, 899.9190072893471, 909.9226565741853, 914.5610107148606, 918.1782304837267, 924.8658944453151, 20580.897095514425, 21692.891535542538, 21791.237306694507, 21874.562508749736, 21886.781132188793, 909.481595490564, 909.5969938564904, 930.3348106104168, 935.5369092299355, 937.6811883959487, 11261.718457038476, 11709.941450292865, 11850.762984740257, 11903.166778325434, 12042.458089385998, 608413.0, 618035.0, 619486.0, 619869.0, 620104.0, 69899.0, 96407.51796240974, 103084.48457757663, 107544.0, 111392.4430377843, 1210.0138387214392, 1227.96930076747, 1264.386772415378, 1273.5415250509993, 1282.7819270723999, 19569.217231310588, 19639.410817675493, 20369.0, 20440.79559204389, 20487.4878128048, 48531.0, 48846.755766220944, 49824.0, 49878.0, 51014.74492627662, 62656.37343626505, 63004.68497657666, 63803.3619663816, 64321.67839160774, 65708.14377843171, 10654.467276636293, 10750.838737418788, 10813.51339189754, 10830.0, 11180.440977951233, 12379.133460657667, 12445.377731113227, 12449.93775031119, 12501.187422817487, 12518.937405312916, 10336.534855931652, 10740.785184296426, 11091.833622495507, 11495.930732468236, 11533.67362753294, 10506.106980906708, 10845.349279043283, 11138.3873886937, 11171.162162837982, 11181.161412894227, 10802.243842930919, 10957.178211634, 10977.451127443755, 11159.49782259784, 11292.7741445169, 10612.416317102325, 10625.681229563126, 10639.308444951053, 10766.515506802056, 10884.238103333008, 10227.130693891102, 10706.73233169177, 10770.569177232823, 11048.779024419306, 11189.272697274651], "value": 10963.348232750477, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.366066252174, 1527.1600619659184, 1557.1591340676036, 1562.3281988744839, 1624.9918750406248, 10319.0, 10688.09151222147, 10702.0, 10708.25042247043, 10708.78582428351, 10374.740631484217, 10480.423576703279, 10688.786224275509, 10702.143828493721, 10705.250632455713, 2209.2930262316104, 2217.201807349361, 2246.3485589179118, 2246.415931857721, 2250.077468238023, 2133.4986278224683, 2149.892505374733, 2165.415337858777, 2167.371462275938, 2172.2397160993683, 2102.484891201658, 2111.356036408895, 2120.2473122041683, 2123.787621237879, 2126.6916297136904, 2115.6932244824493, 2169.143188440565, 2173.1090252996196, 2177.150911144655, 2177.6515757478887, 2026.7567891852925, 2091.5816836632735, 2103.5897999890026, 2104.610647030289, 2107.2940564910773, 10873.510692018877, 10943.726406839813, 10946.288491248044, 10953.17851161158, 10963.671089867317, 5133.153029750087, 5340.759665815048, 5346.251524786533, 5347.6256662033675, 5349.679019258857, 2928.809627374214, 3047.8628461719277, 3098.163495856129, 3101.984490077558, 3117.0492999635103, 1140.1334985411065, 1191.2316555821533, 1201.1771936223715, 1227.061298106949, 1271.8600953895063, 15799.763003554956, 15935.0, 16011.359545618161, 16102.194890255558, 16208.0, 3959.148783011666, 4117.835286588503, 4197.580241975778, 4204.66362690984, 4299.785010749512, 12183.208091474025, 12213.389330533439, 12237.53149622051, 12244.755104897853, 12246.693832654077, 5323.121684922022, 5333.280007199056, 5339.759710812945, 5349.86625334362, 5358.2498450217, 4517.525659805673, 4620.399348084795, 4647.0, 4658.510856360102, 4690.554397332248, 3448.758586898943, 3466.809325487072, 3481.686648201674, 3515.8026233603996, 3540.061883600848, 900.2392977933636, 903.1059251341256, 905.7871400220943, 912.5528491039476, 914.3736540469799, 764.9655765490567, 784.0, 792.9326007289329, 796.7410591557767, 805.1465446626595, 6305.8108256752375, 6377.362263773585, 6415.743370265231, 6423.42189202974, 6432.4532414744335, 967.298708436378, 980.1032055669126, 988.3921388346259, 992.7567745902156, 1003.3377970539409, 4091.9335735453406, 4108.856190033334, 4169.6455801256625, 4190.350495673115, 4208.894777630584, 12542.623721288375, 12721.745565088831, 12915.741685166431, 12984.545540906023, 13125.081244312998, 10546.0, 11499.3675347855, 13026.80459793104, 13074.542391016459, 13424.93287533556, 8326.29226515753, 9876.259280553988, 9902.801943961225, 9955.502224888727, 9966.950165249127, 6402.743890244338, 6426.871462570629, 6433.292337842927, 6515.641639709672, 6541.771038013647, 11872.643820685393, 12120.393980301125, 12148.878511214774, 12229.205101668364, 12260.386980650754, 11900.166988310735, 12092.758144836878, 12269.570565030539, 12373.876261237272, 12434.564790232298, 8169.959150204211, 8258.958705206436, 8357.749267521984, 8367.874481882654, 8420.284275836377, 9897.802043958936, 10028.448435336126, 10132.696019119438, 10184.541695623862, 10212.693619191436, 8691.695790647296, 8706.782330441789, 8721.91278087211, 8735.388522803343, 8778.56107194625, 8505.74482765518, 8635.827283454422, 8728.869066963875, 8750.956245218733, 8881.822363552821, 7119.288071192839, 7143.749968751069, 7172.569645821059, 7181.0, 7388.741394051182, 5497.945020549903, 5511.255980442589, 5616.269884914935, 5683.857903552444, 5740.253767010262, 5621.437856214346, 5632.85917852057, 5698.344690360495, 5843.2695913010875, 5893.675847828411], "value": 4850.9727409633915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.25567073079435, 402.416496080683, 413.98758037258875, 421.831784627017, 426.17535069640246, 5680.119581464869, 5687.516561092307, 5706.172604972282, 5709.800156994506, 5711.485966263031, 5408.540274076709, 5458.699771512565, 5543.0, 5589.804356847511, 5596.58025648076, 4442.7112237704605, 4459.907322705925, 4481.932771008437, 4485.5962963333295, 4499.0, 4451.688381813275, 4473.955260447403, 4475.462944446671, 4477.395551600524, 4483.663725220606, 4357.477102747659, 4424.712393694415, 4464.129494748526, 4473.105378924212, 4474.172278128541, 4435.246008178618, 4444.799824087066, 4460.375547423363, 4472.709273897202, 4473.977630111861, 4050.1697152083752, 4062.756234625932, 4068.9796551017057, 4080.9591904080876, 4082.9591704082877, 5269.6311258211945, 5453.318335208099, 5468.234447177399, 5506.697131657757, 5532.174382453821, 5212.869678258036, 5214.739263036871, 5221.0, 5230.189320655304, 5240.4759524047295, 5772.191893134965, 5924.437178468082, 5935.465808077251, 5948.196993405922, 5958.195643588104, 4480.977595112036, 4495.370648109268, 4510.391097201868, 4515.187266292066, 4524.547545245482, 5928.64428134309, 6092.908606370864, 6146.29317628474, 6152.815415537541, 6183.783567575113, 4918.606511479073, 5152.175651895679, 5152.639315247897, 5153.098207813618, 5304.575633949275, 5429.972850135724, 5450.890982180414, 5466.043442397565, 5468.671879687232, 5475.260839786658, 5173.922391164136, 5270.446603106619, 5554.50009499147, 5601.795613942941, 5678.630888992202, 5909.704514774244, 5920.703964801829, 5935.109733540004, 5962.85092872673, 5969.910451343233, 1848.7042073268212, 1861.692820684599, 1874.4189301316362, 1886.6038131992161, 1888.5278680329918, 1521.68044710612, 1524.7331716949489, 1547.5666813292296, 1566.772817941392, 1579.3682526989296, 5649.615844118135, 5669.092945128759, 5671.773129074873, 5711.257536520226, 5726.198332233491, 6043.3050199227655, 6065.423784740443, 6110.114033465123, 6111.0, 6129.233845769279, 5537.8061767837935, 5669.574781891375, 5689.317281926195, 5710.400407957105, 5716.399778023331, 3213.4055199788113, 3225.774195806318, 3226.6125566006845, 3233.2725136844024, 3254.1051210917185, 6072.787452439144, 6362.363763623601, 6382.393672601095, 6389.616623002635, 6399.296077431479, 6330.335314791972, 6340.778072767431, 6344.397282258178, 6362.586431881913, 6369.968150159312, 6229.781957631461, 6435.678216089177, 6461.25695545009, 6464.450521705614, 6470.838229044311, 6162.753489860355, 6163.161917894431, 6163.537734669828, 6171.84570385744, 6186.133941248138, 6057.333693293646, 6077.392260773887, 6103.542234332354, 6121.173641558511, 6130.448259656652, 5883.323417807007, 6078.848028799315, 6234.844128896814, 6341.858465476074, 6384.680765961591, 4967.975160124176, 4994.625403094709, 4996.975015124901, 5011.173156429149, 5039.319691841554, 5942.524598032233, 6175.0, 6176.320604733565, 6189.133521306931, 6194.659293738888, 5938.495227905676, 5966.313873904556, 5979.910301345571, 5987.0, 6019.18740969981, 5845.736941837713, 5938.406159384027, 5964.433378829004, 5983.132445795422, 5994.580379373402, 5920.230370051866, 5926.555508336978, 5969.73136208863, 5974.342822289632, 5994.670293133745, 6020.518358531394, 6023.247094113236, 6027.879442411215, 6036.336003039574, 6038.154658347747, 5569.387367389503, 5830.0, 5863.706814659336, 5864.182103547913, 5894.852628684317], "value": 4744.510759989516, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.7334069745939, 779.364817673596, 812.4800127918131, 823.89289392379, 862.6980556805123, 16228.594285142863, 16501.917490412532, 16583.585410364747, 16639.833601663995, 16711.331546738133, 15781.763273550878, 15808.841911580881, 15815.0, 15949.441769538069, 16007.119608421532, 832.1013305629921, 837.5058715357937, 854.2141230068352, 859.1108203009886, 867.6225841758824, 869.8999615044256, 874.0647507167333, 878.4685265414428, 878.8681697745358, 878.9428687135347, 907.3421769217331, 909.4452384045727, 909.4634165842152, 909.5088652127876, 910.3945875992457, 895.3687650206654, 902.4179404284265, 902.9864552031725, 903.9683611073614, 905.651324240169, 655.6164643683451, 656.8292244016542, 657.4346062386344, 657.5298661457081, 664.8437617159964, 16908.57728556796, 17127.143642817933, 17144.485665430057, 17248.655026899516, 17779.555511112325, 16296.348146074142, 16335.509934701979, 16396.83603163965, 16423.260953257013, 16782.328706851833, 11891.94054029733, 12153.331566763825, 12240.409846307635, 12564.183328083645, 12909.677258068623, 3873.9418908716393, 3992.86024989124, 4001.8599349022934, 4050.2911990401562, 4127.876163715094, 70152.0, 79355.0, 80499.0, 82371.0, 83085.58457207735, 11591.988211537418, 11869.703257418461, 12124.515019399125, 12270.263784172977, 12569.434375453127, 22699.773002269765, 23558.175463859025, 23808.761912380654, 23854.88072559626, 24704.258872233862, 8601.935635377044, 8732.345074119467, 8741.30069594431, 8803.647854085764, 8921.197092261727, 4501.504834468205, 4550.13547425988, 4562.110388474216, 4680.67235293533, 4728.219843725747, 3399.048266485388, 3454.4300190468293, 3459.4810778383444, 3463.8614455421502, 3485.4074807282823, 585.0872638683667, 586.3755100817701, 589.2457654202627, 589.7817807411285, 589.8053642298117, 760.8592410403983, 782.4483738964017, 789.1556035042564, 793.2939683681528, 796.8207153390557, 10509.474526273656, 10977.152010791537, 11150.944245278723, 11184.664460066047, 11517.424128793527, 659.3340725866909, 777.7472321495536, 806.2944923192207, 817.6320655704957, 831.4346244553641, 4678.415198100238, 5239.240310155083, 5271.262023316739, 5340.519353258225, 5385.461453854583, 72280.0, 73974.0, 74957.25042749612, 75219.62390188014, 76533.0, 66093.0, 67082.66458667675, 67373.32626673671, 67434.3256567428, 67447.32552674509, 58219.4178058214, 58870.41129588649, 59163.11255331174, 59207.703961479914, 60077.39922600718, 9780.951095244478, 10241.692749217535, 10256.333338332985, 10273.743156420851, 10278.897211028094, 38486.80756596199, 39184.608153918096, 39440.0, 40183.0, 40955.38566921558, 45266.32100518561, 45981.080378391576, 47403.762981184875, 48222.51777482321, 48473.27290090581, 12707.428165732748, 12712.237265763713, 12747.298898560297, 13117.60647180586, 13359.53241636538, 13476.460941562227, 13623.18260904349, 13762.174269543859, 13810.171389716648, 13978.521341993433, 12931.482740690268, 12933.224006559636, 13021.348932553145, 13374.465021399035, 13505.12216705911, 12255.571055013032, 12439.0, 12621.432035558239, 13015.219086854819, 13063.216207027608, 11921.642350729491, 11993.160478766402, 12032.0, 12321.630351089481, 12764.553240636533, 10750.569977201138, 10961.0, 10991.120710343313, 11119.332840029625, 11384.14618903602, 10731.517081731185, 10982.495344506518, 11015.504302306255, 11038.834417483904, 11084.667459976214], "value": 7397.516103498812, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 115.0, 116.0, 116.0, 114.0, 114.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 126.0, 122.0, 168.0, 118.0, 120.0, 124.0, 118.0, 143.0, 119.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 161.0, 161.0, 163.0, 161.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 111.0, 75.0, 74.0, 77.0, 73.0, 97.0, 75.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 105.0, 83.0, 83.0, 82.0, 100.0, 84.0, 83.0, 114.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 59.0, 59.0, 59.0, 58.0, 59.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 78.0, 88.0, 78.0, 77.0, 78.0, 80.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 145.0, 133.0, 124.0, 132.0, 127.0, 124.0, 173.0, 131.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 185.0, 179.0, 178.0, 181.0, 179.0, 181.0, 180.0, 188.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 64.4, "unit": "score"}]}]} 07:35:46 INFO - Return code: 0 07:35:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:35:46 ERROR - # TBPL SUCCESS # 07:35:46 INFO - Running post-action listener: _resource_record_post_action 07:35:46 INFO - [mozharness: 2017-03-17 14:35:46.755769Z] Finished run-tests step (success) 07:35:46 INFO - Running post-run listener: _resource_record_post_run 07:35:46 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 368795648; Read time: 16; Write time: 247000 07:35:46 INFO - TinderboxPrint: CPU usage
12.9% 07:35:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:35:46 INFO - TinderboxPrint: I/O write bytes / time
368,795,648 / 247,000 07:35:46 INFO - TinderboxPrint: CPU idle
8,306.3 (87.1%) 07:35:46 INFO - TinderboxPrint: CPU user
1,187.1 (12.4%) 07:35:46 INFO - TinderboxPrint: Swap in / out
0 / 0 07:35:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111157248; Read time: 0; Write time: 107312 07:35:46 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257638400; Read time: 16; Write time: 139688 07:35:47 INFO - Running post-run listener: _upload_blobber_files 07:35:47 INFO - Blob upload gear active. 07:35:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:35:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:35:47 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:35:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:51 INFO - (blobuploader) - INFO - Done attempting. 07:35:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:35:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:35:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:52 INFO - (blobuploader) - INFO - Done attempting. 07:35:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:35:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:35:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:53 INFO - (blobuploader) - INFO - Done attempting. 07:35:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:35:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:35:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:54 INFO - (blobuploader) - INFO - Done attempting. 07:35:54 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:54 INFO - Return code: 0 07:35:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:35:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:54 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f449256871f5657fc6928bdb1564b344edf6888ad302ca83e000915eb06ef9eed1b67b2c74ba603fb6ae1dfe12097f306eab064884e692d03c24dcbc3059411a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24e228e359bf8780e8f34e23c6562d4eb325d90d6c738f7b5bb34e2a737665507e4b8ca1cf2d335e84fa84a3f86031d1dd3f2655abc21fc162f941bee7594513", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8727e24f9a40df72d7e37d689ec9dfde84affe8062de391c77087791e02be6ea6d2cc40ddae3973b7b77e81fbd619703961b313ade5da26dc2eefe884531503", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19c06f3ec69b931247e31c61e58629d1a61992510eefdc6992f9abb7c4cae593657966cdadcc6de7d99ffcee4ebd929288a8cc87c39cd94b86aa3d0e80684273"} 07:35:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:35:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:35:54 INFO - Contents: 07:35:54 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f449256871f5657fc6928bdb1564b344edf6888ad302ca83e000915eb06ef9eed1b67b2c74ba603fb6ae1dfe12097f306eab064884e692d03c24dcbc3059411a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24e228e359bf8780e8f34e23c6562d4eb325d90d6c738f7b5bb34e2a737665507e4b8ca1cf2d335e84fa84a3f86031d1dd3f2655abc21fc162f941bee7594513", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8727e24f9a40df72d7e37d689ec9dfde84affe8062de391c77087791e02be6ea6d2cc40ddae3973b7b77e81fbd619703961b313ade5da26dc2eefe884531503", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19c06f3ec69b931247e31c61e58629d1a61992510eefdc6992f9abb7c4cae593657966cdadcc6de7d99ffcee4ebd929288a8cc87c39cd94b86aa3d0e80684273"} 07:35:54 INFO - Running post-run listener: copy_logs_to_upload_dir 07:35:54 INFO - Copying logs to upload dir... 07:35:54 INFO - mkdir: /builds/slave/test/build/upload/logs 07:35:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.287158 ========= master_lag: 0.52 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-17 07:35:55.031751) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 07:35:55.036209) ========= 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=03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182 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/f449256871f5657fc6928bdb1564b344edf6888ad302ca83e000915eb06ef9eed1b67b2c74ba603fb6ae1dfe12097f306eab064884e692d03c24dcbc3059411a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24e228e359bf8780e8f34e23c6562d4eb325d90d6c738f7b5bb34e2a737665507e4b8ca1cf2d335e84fa84a3f86031d1dd3f2655abc21fc162f941bee7594513", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8727e24f9a40df72d7e37d689ec9dfde84affe8062de391c77087791e02be6ea6d2cc40ddae3973b7b77e81fbd619703961b313ade5da26dc2eefe884531503", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19c06f3ec69b931247e31c61e58629d1a61992510eefdc6992f9abb7c4cae593657966cdadcc6de7d99ffcee4ebd929288a8cc87c39cd94b86aa3d0e80684273"} build_url:https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/ayhMZyiVST2oVMGpInjhIA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f449256871f5657fc6928bdb1564b344edf6888ad302ca83e000915eb06ef9eed1b67b2c74ba603fb6ae1dfe12097f306eab064884e692d03c24dcbc3059411a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24e228e359bf8780e8f34e23c6562d4eb325d90d6c738f7b5bb34e2a737665507e4b8ca1cf2d335e84fa84a3f86031d1dd3f2655abc21fc162f941bee7594513", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8727e24f9a40df72d7e37d689ec9dfde84affe8062de391c77087791e02be6ea6d2cc40ddae3973b7b77e81fbd619703961b313ade5da26dc2eefe884531503", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19c06f3ec69b931247e31c61e58629d1a61992510eefdc6992f9abb7c4cae593657966cdadcc6de7d99ffcee4ebd929288a8cc87c39cd94b86aa3d0e80684273"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 07:35:55.067654) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 07:35:55.067976) ========= 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=03627c79f6bb3d1578c4a402000001ba-1489759987.810006-949443182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 07:35:55.120237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 07:35:55.122574) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 07:35:55.122873) ========= ========= Total master_lag: 0.65 =========