builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1490191912.34 results: success (0) revision: ee30286771eb83c0878621485009dc2722daa78f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:52.343128) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:52.344010) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:52.344393) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:52.362751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:52.363088) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-22 07:11:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-03-22 07:11:53 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115136 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:52.492084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:52.492420) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019423 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:52.542089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:52.542557) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ee30286771eb83c0878621485009dc2722daa78f --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 ee30286771eb83c0878621485009dc2722daa78f --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=516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-22 07:11:53,223 truncating revision to first 12 chars 2017-03-22 07:11:53,223 Setting DEBUG logging. 2017-03-22 07:11:53,223 attempt 1/10 2017-03-22 07:11:53,224 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ee30286771eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 07:11:53,510 unpacking tar archive at: mozilla-central-ee30286771eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607298 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:53.163350) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:53.163718) ========= script_repo_revision: ee30286771eb83c0878621485009dc2722daa78f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:53.164122) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:53.164400) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 07:11:53.173667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-22 07:11:53.174070) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:11:53 INFO - MultiFileLogger online at 20170322 07:11:53 in /builds/slave/test 07:11:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:11:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:11:53 INFO - {'append_to_log': False, 07:11:53 INFO - 'base_work_dir': '/builds/slave/test', 07:11:53 INFO - 'blob_upload_branch': 'Firefox', 07:11:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:11:53 INFO - 'branch': 'Firefox', 07:11:53 INFO - 'buildbot_json_path': 'buildprops.json', 07:11:53 INFO - 'config_files': ('talos/linux_config.py',), 07:11:53 INFO - 'default_actions': ('clobber', 07:11:53 INFO - 'read-buildbot-config', 07:11:53 INFO - 'download-and-extract', 07:11:53 INFO - 'populate-webroot', 07:11:53 INFO - 'create-virtualenv', 07:11:53 INFO - 'install', 07:11:53 INFO - 'run-tests'), 07:11:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:11:53 INFO - 'download_minidump_stackwalk': True, 07:11:53 INFO - 'download_symbols': 'ondemand', 07:11:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:11:53 INFO - 'tooltool.py': '/tools/tooltool.py', 07:11:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:11:53 INFO - '/tools/misc-python/virtualenv.py')}, 07:11:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:11:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:11:53 INFO - 'gecko_profile': False, 07:11:53 INFO - 'gecko_profile_interval': 0, 07:11:53 INFO - 'installer_path': 'installer.exe', 07:11:53 INFO - 'log_level': 'info', 07:11:53 INFO - 'log_name': 'talos', 07:11:53 INFO - 'log_to_console': True, 07:11:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:11:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:11:53 INFO - 'opt_config_files': (), 07:11:53 INFO - 'pip_index': False, 07:11:53 INFO - 'suite': 'dromaeojs', 07:11:53 INFO - 'system_bits': '32', 07:11:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:11:53 INFO - 'title': 'talos-linux64-ix-061', 07:11:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:11:53 INFO - 'use_talos_json': True, 07:11:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:11:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:11:53 INFO - 'work_dir': 'build'} 07:11:53 INFO - [mozharness: 2017-03-22 14:11:53.952271Z] Running clobber step. 07:11:53 INFO - Running pre-action listener: _resource_record_pre_action 07:11:53 INFO - Running main action method: clobber 07:11:53 INFO - rmtree: /builds/slave/test/build 07:11:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:11:55 INFO - Running post-action listener: _resource_record_post_action 07:11:55 INFO - [mozharness: 2017-03-22 14:11:55.400527Z] Finished clobber step (success) 07:11:55 INFO - [mozharness: 2017-03-22 14:11:55.400645Z] Running read-buildbot-config step. 07:11:55 INFO - Running pre-action listener: _resource_record_pre_action 07:11:55 INFO - Running main action method: read_buildbot_config 07:11:55 INFO - Using buildbot properties: 07:11:55 INFO - { 07:11:55 INFO - "project": "", 07:11:55 INFO - "product": "firefox", 07:11:55 INFO - "who": "cbook@mozilla.com", 07:11:55 INFO - "installer_path": "public/build/target.tar.bz2", 07:11:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:11:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:11:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:11:55 INFO - "stage_platform": "linux64-pgo", 07:11:55 INFO - "basedir": "/builds/slave/test", 07:11:55 INFO - "buildnumber": 100, 07:11:55 INFO - "platform": "ubuntu64_hw", 07:11:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:11:55 INFO - "slavebuilddir": "test", 07:11:55 INFO - "taskId": "Yk_zMtDJRf2uHErEcA8uNg", 07:11:55 INFO - "branch": "mozilla-central", 07:11:55 INFO - "script_repo_revision": "production", 07:11:55 INFO - "revision": "ee30286771eb83c0878621485009dc2722daa78f", 07:11:55 INFO - "slavename": "talos-linux64-ix-061", 07:11:55 INFO - "repo_path": "mozilla-central" 07:11:55 INFO - } 07:11:55 INFO - Finding installer, test and symbols from parent task. 07:11:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yk_zMtDJRf2uHErEcA8uNg'}, attempt #1 07:11:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yk_zMtDJRf2uHErEcA8uNg'}, attempt #1 07:11:56 INFO - Task dependencies: QZB1CNfyTOivcMPA5YmfFw 07:11:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw'}, attempt #1 07:11:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.tar.bz2 07:11:56 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/test_packages.json 07:11:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.crashreporter-symbols.zip 07:11:56 INFO - Running post-action listener: _resource_record_post_action 07:11:56 INFO - [mozharness: 2017-03-22 14:11:56.772143Z] Finished read-buildbot-config step (success) 07:11:56 INFO - [mozharness: 2017-03-22 14:11:56.772361Z] Running download-and-extract step. 07:11:56 INFO - Running pre-action listener: _resource_record_pre_action 07:11:56 INFO - Running main action method: download_and_extract 07:11:56 INFO - mkdir: /builds/slave/test/build/tests 07:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:56 INFO - trying https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.test_packages.json 07:11:56 INFO - Downloading https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:11:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:11:57 INFO - Downloaded 986 bytes. 07:11:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:11:57 INFO - Using the following test package requirements: 07:11:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:11:57 INFO - u'common': [u'target.common.tests.zip'], 07:11:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:11:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:11:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:11:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:11:57 INFO - u'mozbase': [u'target.common.tests.zip'], 07:11:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:11:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:11:57 INFO - u'web-platform': [u'target.common.tests.zip', 07:11:57 INFO - u'target.web-platform.tests.zip'], 07:11:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:11:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:11:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.common.tests.zip 07:11:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:11:57 INFO - Fetch https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.common.tests.zip into memory 07:11:58 INFO - Expected file size: 60323730 07:11:58 INFO - Obtained file size: 60323730 07:12:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:12:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.common.tests.zip 07:12:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:12:08 INFO - Fetch https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.common.tests.zip into memory 07:12:09 INFO - Expected file size: 60323730 07:12:09 INFO - Obtained file size: 60323730 07:12:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.talos.tests.zip 07:12:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:12:20 INFO - Fetch https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.talos.tests.zip into memory 07:12:21 INFO - Expected file size: 14404171 07:12:21 INFO - Obtained file size: 14404171 07:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:21 INFO - trying https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.tar.bz2 07:12:21 INFO - Downloading https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:12:22 INFO - Downloaded 67275396 bytes. 07:12:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.tar.bz2 07:12:22 INFO - mkdir: /builds/slave/test/properties 07:12:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:12:22 INFO - Writing to file /builds/slave/test/properties/build_url 07:12:22 INFO - Contents: 07:12:22 INFO - build_url:https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.tar.bz2 07:12:22 INFO - Running post-action listener: _resource_record_post_action 07:12:22 INFO - Running post-action listener: set_extra_try_arguments 07:12:22 INFO - [mozharness: 2017-03-22 14:12:22.439367Z] Finished download-and-extract step (success) 07:12:22 INFO - [mozharness: 2017-03-22 14:12:22.439464Z] Running populate-webroot step. 07:12:22 INFO - Running pre-action listener: _resource_record_pre_action 07:12:22 INFO - Running main action method: populate_webroot 07:12:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:12:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:12:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:12:22 INFO - '--tppagecycles', 07:12:22 INFO - '7'], 07:12:22 INFO - 'tests': ['tsvgm']}}, 07:12:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:12:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:12:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:12:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:12:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:12:22 INFO - 'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:12:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:12:22 INFO - 'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['damp', 'tps']}, 07:12:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:12:22 INFO - 'tests': ['damp', 'tps']}, 07:12:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['dromaeo_dom']}, 07:12:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:12:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['basic_compositor_video']}, 07:12:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:12:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'other-e10s': {'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['tsvgx', 07:12:22 INFO - 'tsvgr_opacity', 07:12:22 INFO - 'tart', 07:12:22 INFO - 'tscrollx', 07:12:22 INFO - 'cart', 07:12:22 INFO - 'tsvg_static']}, 07:12:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:12:22 INFO - 'tsvgr_opacity', 07:12:22 INFO - 'tart', 07:12:22 INFO - 'tscrollx', 07:12:22 INFO - 'cart', 07:12:22 INFO - 'tsvg_static']}, 07:12:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:12:22 INFO - 'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['tp5o']}, 07:12:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:12:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:12:22 INFO - 'talos_options': ['--disable-e10s', 07:12:22 INFO - '--xperf_path', 07:12:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:22 INFO - 'tests': ['tp5n']}, 07:12:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:12:22 INFO - 'talos_options': ['--xperf_path', 07:12:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:22 INFO - 'tests': ['tp5n']}}, 07:12:22 INFO - 'talos.zip': {'path': '', 07:12:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:12:22 INFO - Running post-action listener: _resource_record_post_action 07:12:22 INFO - [mozharness: 2017-03-22 14:12:22.452539Z] Finished populate-webroot step (success) 07:12:22 INFO - [mozharness: 2017-03-22 14:12:22.452640Z] Running create-virtualenv step. 07:12:22 INFO - Running pre-action listener: _resource_record_pre_action 07:12:22 INFO - Running main action method: create_virtualenv 07:12:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:12:22 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:12:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:12:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:12:22 INFO - Using real prefix '/usr' 07:12:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:12:23 INFO - Installing distribute.............................................................................................................................................................................................done. 07:12:25 INFO - Installing pip.................done. 07:12:25 INFO - Return code: 0 07:12:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:12:25 INFO - Reading from file tmpfile_stdout 07:12:25 INFO - Output received: 07:12:25 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:12:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:12:25 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:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:25 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:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:25 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 0x246d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', '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:12:25 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:12:25 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:12:25 INFO - Using env: {'DISPLAY': ':0', 07:12:25 INFO - 'HOME': '/home/cltbld', 07:12:25 INFO - 'LANG': 'en_US.UTF-8', 07:12:25 INFO - 'LANGUAGE': 'en_US:en', 07:12:25 INFO - 'LOGNAME': 'cltbld', 07:12:25 INFO - 'MAIL': '/var/mail/cltbld', 07:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:25 INFO - 'MOZ_NO_REMOTE': '1', 07:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:25 INFO - 'NO_EM_RESTART': '1', 07:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:25 INFO - 'PWD': '/builds/slave/test', 07:12:25 INFO - 'SHELL': '/bin/bash', 07:12:25 INFO - 'SHLVL': '1', 07:12:25 INFO - 'TERM': 'linux', 07:12:25 INFO - 'TMOUT': '86400', 07:12:25 INFO - 'USER': 'cltbld', 07:12:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:25 INFO - '_': '/tools/buildbot/bin/python'} 07:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:25 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:12:25 INFO - Cleaning up... 07:12:25 INFO - Return code: 0 07:12:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:12:25 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:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:25 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:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:25 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 0x246d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', '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:12:25 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:12:25 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:12:25 INFO - Using env: {'DISPLAY': ':0', 07:12:25 INFO - 'HOME': '/home/cltbld', 07:12:25 INFO - 'LANG': 'en_US.UTF-8', 07:12:25 INFO - 'LANGUAGE': 'en_US:en', 07:12:25 INFO - 'LOGNAME': 'cltbld', 07:12:25 INFO - 'MAIL': '/var/mail/cltbld', 07:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:25 INFO - 'MOZ_NO_REMOTE': '1', 07:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:25 INFO - 'NO_EM_RESTART': '1', 07:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:25 INFO - 'PWD': '/builds/slave/test', 07:12:25 INFO - 'SHELL': '/bin/bash', 07:12:25 INFO - 'SHLVL': '1', 07:12:25 INFO - 'TERM': 'linux', 07:12:25 INFO - 'TMOUT': '86400', 07:12:25 INFO - 'USER': 'cltbld', 07:12:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:25 INFO - '_': '/tools/buildbot/bin/python'} 07:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:25 INFO - Downloading/unpacking psutil>=3.1.1 07:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:12:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:27 INFO - Installing collected packages: psutil 07:12:27 INFO - Running setup.py install for psutil 07:12:27 INFO - building 'psutil._psutil_linux' extension 07:12:27 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:12:28 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:12:28 INFO - building 'psutil._psutil_posix' extension 07:12:28 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:12:28 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:12:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:28 INFO - Successfully installed psutil 07:12:28 INFO - Cleaning up... 07:12:28 INFO - Return code: 0 07:12:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', '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:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:12:28 INFO - Using env: {'DISPLAY': ':0', 07:12:28 INFO - 'HOME': '/home/cltbld', 07:12:28 INFO - 'LANG': 'en_US.UTF-8', 07:12:28 INFO - 'LANGUAGE': 'en_US:en', 07:12:28 INFO - 'LOGNAME': 'cltbld', 07:12:28 INFO - 'MAIL': '/var/mail/cltbld', 07:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:28 INFO - 'MOZ_NO_REMOTE': '1', 07:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:28 INFO - 'NO_EM_RESTART': '1', 07:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:28 INFO - 'PWD': '/builds/slave/test', 07:12:28 INFO - 'SHELL': '/bin/bash', 07:12:28 INFO - 'SHLVL': '1', 07:12:28 INFO - 'TERM': 'linux', 07:12:28 INFO - 'TMOUT': '86400', 07:12:28 INFO - 'USER': 'cltbld', 07:12:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:28 INFO - '_': '/tools/buildbot/bin/python'} 07:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:12:30 INFO - Installing collected packages: mozsystemmonitor 07:12:30 INFO - Running setup.py install for mozsystemmonitor 07:12:30 INFO - Successfully installed mozsystemmonitor 07:12:30 INFO - Cleaning up... 07:12:30 INFO - Return code: 0 07:12:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x246d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', '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:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:12:30 INFO - Using env: {'DISPLAY': ':0', 07:12:30 INFO - 'HOME': '/home/cltbld', 07:12:30 INFO - 'LANG': 'en_US.UTF-8', 07:12:30 INFO - 'LANGUAGE': 'en_US:en', 07:12:30 INFO - 'LOGNAME': 'cltbld', 07:12:30 INFO - 'MAIL': '/var/mail/cltbld', 07:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:30 INFO - 'MOZ_NO_REMOTE': '1', 07:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:30 INFO - 'NO_EM_RESTART': '1', 07:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:30 INFO - 'PWD': '/builds/slave/test', 07:12:30 INFO - 'SHELL': '/bin/bash', 07:12:30 INFO - 'SHLVL': '1', 07:12:30 INFO - 'TERM': 'linux', 07:12:30 INFO - 'TMOUT': '86400', 07:12:30 INFO - 'USER': 'cltbld', 07:12:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:30 INFO - '_': '/tools/buildbot/bin/python'} 07:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:31 INFO - Downloading/unpacking jsonschema==2.5.1 07:12: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:12: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:12: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:12: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:12: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:12: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:12:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:12:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:12:33 INFO - warning: no files found matching '*.txt' 07:12:33 INFO - no previously-included directories found matching 'build' 07:12:33 INFO - no previously-included directories found matching 'dist' 07:12:33 INFO - no previously-included directories found matching '.git*' 07:12:33 INFO - Installing collected packages: jsonschema, functools32 07:12:33 INFO - Running setup.py install for functools32 07:12:33 INFO - warning: no files found matching '*.txt' 07:12:33 INFO - no previously-included directories found matching 'build' 07:12:33 INFO - no previously-included directories found matching 'dist' 07:12:33 INFO - no previously-included directories found matching '.git*' 07:12:33 INFO - Successfully installed jsonschema functools32 07:12:33 INFO - Cleaning up... 07:12:33 INFO - Return code: 0 07:12:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x246d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', '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:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:12:33 INFO - Using env: {'DISPLAY': ':0', 07:12:33 INFO - 'HOME': '/home/cltbld', 07:12:33 INFO - 'LANG': 'en_US.UTF-8', 07:12:33 INFO - 'LANGUAGE': 'en_US:en', 07:12:33 INFO - 'LOGNAME': 'cltbld', 07:12:33 INFO - 'MAIL': '/var/mail/cltbld', 07:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:33 INFO - 'MOZ_NO_REMOTE': '1', 07:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:33 INFO - 'NO_EM_RESTART': '1', 07:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:33 INFO - 'PWD': '/builds/slave/test', 07:12:33 INFO - 'SHELL': '/bin/bash', 07:12:33 INFO - 'SHLVL': '1', 07:12:33 INFO - 'TERM': 'linux', 07:12:33 INFO - 'TMOUT': '86400', 07:12:33 INFO - 'USER': 'cltbld', 07:12:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:33 INFO - '_': '/tools/buildbot/bin/python'} 07:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:12:33 INFO - Cleaning up... 07:12:33 INFO - Return code: 0 07:12:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x246d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', '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:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:12:33 INFO - Using env: {'DISPLAY': ':0', 07:12:33 INFO - 'HOME': '/home/cltbld', 07:12:33 INFO - 'LANG': 'en_US.UTF-8', 07:12:33 INFO - 'LANGUAGE': 'en_US:en', 07:12:33 INFO - 'LOGNAME': 'cltbld', 07:12:33 INFO - 'MAIL': '/var/mail/cltbld', 07:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:33 INFO - 'MOZ_NO_REMOTE': '1', 07:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:33 INFO - 'NO_EM_RESTART': '1', 07:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:33 INFO - 'PWD': '/builds/slave/test', 07:12:33 INFO - 'SHELL': '/bin/bash', 07:12:33 INFO - 'SHLVL': '1', 07:12:33 INFO - 'TERM': 'linux', 07:12:33 INFO - 'TMOUT': '86400', 07:12:33 INFO - 'USER': 'cltbld', 07:12:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:33 INFO - '_': '/tools/buildbot/bin/python'} 07:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:12: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:12: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:12: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:12: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:12: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:12: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:12:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12: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:12: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:12: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:12: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:12: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:12: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:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:12:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:12: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:12: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:12: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:12: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:12: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:12: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:12:36 INFO - Downloading docopt-0.6.1.tar.gz 07:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:12:36 INFO - Installing collected packages: blobuploader, requests, docopt 07:12:36 INFO - Running setup.py install for blobuploader 07:12:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:12:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:12:37 INFO - Running setup.py install for requests 07:12:37 INFO - Running setup.py install for docopt 07:12:37 INFO - Successfully installed blobuploader requests docopt 07:12:37 INFO - Cleaning up... 07:12:37 INFO - Return code: 0 07:12:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:37 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 0x246d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', '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:12:37 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:12:37 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:12:37 INFO - Using env: {'DISPLAY': ':0', 07:12:37 INFO - 'HOME': '/home/cltbld', 07:12:37 INFO - 'LANG': 'en_US.UTF-8', 07:12:37 INFO - 'LANGUAGE': 'en_US:en', 07:12:37 INFO - 'LOGNAME': 'cltbld', 07:12:37 INFO - 'MAIL': '/var/mail/cltbld', 07:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:37 INFO - 'MOZ_NO_REMOTE': '1', 07:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:37 INFO - 'NO_EM_RESTART': '1', 07:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:37 INFO - 'PWD': '/builds/slave/test', 07:12:37 INFO - 'SHELL': '/bin/bash', 07:12:37 INFO - 'SHLVL': '1', 07:12:37 INFO - 'TERM': 'linux', 07:12:37 INFO - 'TMOUT': '86400', 07:12:37 INFO - 'USER': 'cltbld', 07:12:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:37 INFO - '_': '/tools/buildbot/bin/python'} 07:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:37 INFO - Running setup.py (path:/tmp/pip-j3a0PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:37 INFO - Running setup.py (path:/tmp/pip-w3eTJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:37 INFO - Running setup.py (path:/tmp/pip-mTxcST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:37 INFO - Running setup.py (path:/tmp/pip-talCnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:38 INFO - Running setup.py (path:/tmp/pip-gGMj5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:38 INFO - Running setup.py (path:/tmp/pip-YazDYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:38 INFO - Running setup.py (path:/tmp/pip-RXlbDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:38 INFO - Running setup.py (path:/tmp/pip-RqtS4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:38 INFO - Running setup.py (path:/tmp/pip-IVhWTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:38 INFO - Running setup.py (path:/tmp/pip-qZFXRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:38 INFO - Running setup.py (path:/tmp/pip-a1Mxtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:38 INFO - Running setup.py (path:/tmp/pip-F93I61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:38 INFO - Running setup.py (path:/tmp/pip-XzPdhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:38 INFO - Running setup.py (path:/tmp/pip-eacojJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:38 INFO - Running setup.py (path:/tmp/pip-KnBPzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:38 INFO - Running setup.py (path:/tmp/pip-KsYqCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:38 INFO - Running setup.py (path:/tmp/pip-wwtf8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:12:39 INFO - Running setup.py install for manifestparser 07:12:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozcrash 07:12:39 INFO - Running setup.py install for mozdebug 07:12:39 INFO - Running setup.py install for mozdevice 07:12:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozfile 07:12:39 INFO - Running setup.py install for mozhttpd 07:12:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozinfo 07:12:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozInstall 07:12:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozleak 07:12:39 INFO - Running setup.py install for mozlog 07:12:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Running setup.py install for moznetwork 07:12:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Running setup.py install for mozprocess 07:12:40 INFO - Running setup.py install for mozprofile 07:12:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Running setup.py install for mozrunner 07:12:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Running setup.py install for mozscreenshot 07:12:40 INFO - Running setup.py install for moztest 07:12:40 INFO - Running setup.py install for mozversion 07:12:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:12:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:12:40 INFO - Cleaning up... 07:12:40 INFO - Return code: 0 07:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:40 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 0x246d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', '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:12:40 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:12:40 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:12:40 INFO - Using env: {'DISPLAY': ':0', 07:12:40 INFO - 'HOME': '/home/cltbld', 07:12:40 INFO - 'LANG': 'en_US.UTF-8', 07:12:40 INFO - 'LANGUAGE': 'en_US:en', 07:12:40 INFO - 'LOGNAME': 'cltbld', 07:12:40 INFO - 'MAIL': '/var/mail/cltbld', 07:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:40 INFO - 'MOZ_NO_REMOTE': '1', 07:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:40 INFO - 'NO_EM_RESTART': '1', 07:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:40 INFO - 'PWD': '/builds/slave/test', 07:12:40 INFO - 'SHELL': '/bin/bash', 07:12:40 INFO - 'SHLVL': '1', 07:12:40 INFO - 'TERM': 'linux', 07:12:40 INFO - 'TMOUT': '86400', 07:12:40 INFO - 'USER': 'cltbld', 07:12:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:40 INFO - '_': '/tools/buildbot/bin/python'} 07:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:41 INFO - Running setup.py (path:/tmp/pip-8BIuUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:41 INFO - Running setup.py (path:/tmp/pip-hBqWNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:41 INFO - Running setup.py (path:/tmp/pip-_5huga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:41 INFO - Running setup.py (path:/tmp/pip-E8TlHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:41 INFO - Running setup.py (path:/tmp/pip-dyTErK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:41 INFO - Running setup.py (path:/tmp/pip-Bobyrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:41 INFO - Running setup.py (path:/tmp/pip-nYy2oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:41 INFO - Running setup.py (path:/tmp/pip-s1k_As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:41 INFO - Running setup.py (path:/tmp/pip-R0_52H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:41 INFO - Running setup.py (path:/tmp/pip-_nzg6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:41 INFO - Running setup.py (path:/tmp/pip-uNWfTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:41 INFO - Running setup.py (path:/tmp/pip-cQ5Kwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:41 INFO - Running setup.py (path:/tmp/pip-KJjDuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:42 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:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:42 INFO - Running setup.py (path:/tmp/pip-swra4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:42 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:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:42 INFO - Running setup.py (path:/tmp/pip-aa_Dzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:42 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:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:42 INFO - Running setup.py (path:/tmp/pip-rQQC0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:42 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:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:42 INFO - Running setup.py (path:/tmp/pip-mhG02r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:42 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:12:42 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:12:42 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:12:42 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:12:42 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:12:42 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:12:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12: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:12: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:12: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:12: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:12: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:12: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:12:44 INFO - Downloading blessings-1.6.tar.gz 07:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:12:44 INFO - Installing collected packages: blessings 07:12:44 INFO - Running setup.py install for blessings 07:12:44 INFO - Successfully installed blessings 07:12:44 INFO - Cleaning up... 07:12:44 INFO - Return code: 0 07:12:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:12:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:44 INFO - Reading from file tmpfile_stdout 07:12:44 INFO - Current package versions: 07:12:44 INFO - argparse == 1.2.1 07:12:44 INFO - blessings == 1.6 07:12:44 INFO - blobuploader == 1.2.4 07:12:44 INFO - docopt == 0.6.1 07:12:44 INFO - functools32 == 3.2.3-2 07:12:44 INFO - jsonschema == 2.5.1 07:12:44 INFO - manifestparser == 1.1 07:12:44 INFO - mozInstall == 1.12 07:12:44 INFO - mozcrash == 1.0 07:12:44 INFO - mozdebug == 0.1 07:12:44 INFO - mozdevice == 0.49 07:12:44 INFO - mozfile == 1.2 07:12:44 INFO - mozhttpd == 0.7 07:12:44 INFO - mozinfo == 0.9 07:12:44 INFO - mozleak == 0.1 07:12:44 INFO - mozlog == 3.4 07:12:44 INFO - moznetwork == 0.27 07:12:44 INFO - mozprocess == 0.25 07:12:44 INFO - mozprofile == 0.28 07:12:44 INFO - mozrunner == 6.13 07:12:44 INFO - mozscreenshot == 0.1 07:12:44 INFO - mozsystemmonitor == 0.3 07:12:44 INFO - moztest == 0.8 07:12:44 INFO - mozversion == 1.4 07:12:44 INFO - psutil == 3.1.1 07:12:44 INFO - requests == 1.2.3 07:12:44 INFO - wsgiref == 0.1.2 07:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:44 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:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:44 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:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:44 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 0x246d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', '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:12:44 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:12:44 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:12:44 INFO - Using env: {'DISPLAY': ':0', 07:12:44 INFO - 'HOME': '/home/cltbld', 07:12:44 INFO - 'LANG': 'en_US.UTF-8', 07:12:44 INFO - 'LANGUAGE': 'en_US:en', 07:12:44 INFO - 'LOGNAME': 'cltbld', 07:12:44 INFO - 'MAIL': '/var/mail/cltbld', 07:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:44 INFO - 'MOZ_NO_REMOTE': '1', 07:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:44 INFO - 'NO_EM_RESTART': '1', 07:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:44 INFO - 'PWD': '/builds/slave/test', 07:12:44 INFO - 'SHELL': '/bin/bash', 07:12:44 INFO - 'SHLVL': '1', 07:12:44 INFO - 'TERM': 'linux', 07:12:44 INFO - 'TMOUT': '86400', 07:12:44 INFO - 'USER': 'cltbld', 07:12:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:44 INFO - '_': '/tools/buildbot/bin/python'} 07:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:12:45 INFO - Cleaning up... 07:12:45 INFO - Return code: 0 07:12:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', '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:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:12:45 INFO - Using env: {'DISPLAY': ':0', 07:12:45 INFO - 'HOME': '/home/cltbld', 07:12:45 INFO - 'LANG': 'en_US.UTF-8', 07:12:45 INFO - 'LANGUAGE': 'en_US:en', 07:12:45 INFO - 'LOGNAME': 'cltbld', 07:12:45 INFO - 'MAIL': '/var/mail/cltbld', 07:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:45 INFO - 'MOZ_NO_REMOTE': '1', 07:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:45 INFO - 'NO_EM_RESTART': '1', 07:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:45 INFO - 'PWD': '/builds/slave/test', 07:12:45 INFO - 'SHELL': '/bin/bash', 07:12:45 INFO - 'SHLVL': '1', 07:12:45 INFO - 'TERM': 'linux', 07:12:45 INFO - 'TMOUT': '86400', 07:12:45 INFO - 'USER': 'cltbld', 07:12:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:45 INFO - '_': '/tools/buildbot/bin/python'} 07:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:12:45 INFO - Cleaning up... 07:12:45 INFO - Return code: 0 07:12:45 INFO - Running post-action listener: _resource_record_post_action 07:12:45 INFO - Running post-action listener: _start_resource_monitoring 07:12:45 INFO - Starting resource monitoring. 07:12:45 INFO - [mozharness: 2017-03-22 14:12:45.335741Z] Finished create-virtualenv step (success) 07:12:45 INFO - [mozharness: 2017-03-22 14:12:45.336212Z] Running install step. 07:12:45 INFO - Running pre-action listener: _resource_record_pre_action 07:12:45 INFO - Running main action method: install 07:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:45 INFO - Reading from file tmpfile_stdout 07:12:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:45 INFO - Reading from file tmpfile_stdout 07:12:45 INFO - Output received: 07:12:45 INFO - Usage: mozinstall [options] installer 07:12:45 INFO - Options: 07:12:45 INFO - -h, --help show this help message and exit 07:12:45 INFO - -d DEST, --destination=DEST 07:12:45 INFO - Directory to install application into. [default: 07:12:45 INFO - "/builds/slave/test"] 07:12:45 INFO - --app=APP Application being installed. [default: firefox] 07:12:45 INFO - mkdir: /builds/slave/test/build/application 07:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:13:02 INFO - Reading from file tmpfile_stdout 07:13:02 INFO - Output received: 07:13:02 INFO - /builds/slave/test/build/application/firefox/firefox 07:13:02 INFO - Running post-action listener: _resource_record_post_action 07:13:02 INFO - [mozharness: 2017-03-22 14:13:02.367357Z] Finished install step (success) 07:13:02 INFO - [mozharness: 2017-03-22 14:13:02.367635Z] Running run-tests step. 07:13:02 INFO - Running pre-action listener: _resource_record_pre_action 07:13:02 INFO - Running main action method: run_tests 07:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:13:02 INFO - Python 2.7.3 07:13:02 INFO - Return code: 0 07:13:02 INFO - grabbing minidump binary from tooltool 07:13: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:13:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2708400>, '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 0x27093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2709840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:13:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:13:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:13:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:13:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:13:02 INFO - Return code: 0 07:13:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:13:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:13:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:13:02 INFO - ENV: RUST_BACKTRACE is now 1 07:13:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:13:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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:13:02 INFO - Using env: {'DISPLAY': ':0', 07:13:02 INFO - 'HOME': '/home/cltbld', 07:13:02 INFO - 'LANG': 'en_US.UTF-8', 07:13:02 INFO - 'LANGUAGE': 'en_US:en', 07:13:02 INFO - 'LOGNAME': 'cltbld', 07:13:02 INFO - 'MAIL': '/var/mail/cltbld', 07:13:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:02 INFO - 'MOZ_NO_REMOTE': '1', 07:13:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:02 INFO - 'NO_EM_RESTART': '1', 07:13:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:02 INFO - 'PWD': '/builds/slave/test', 07:13:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:02 INFO - 'RUST_BACKTRACE': '1', 07:13:02 INFO - 'SHELL': '/bin/bash', 07:13:02 INFO - 'SHLVL': '1', 07:13:02 INFO - 'TERM': 'linux', 07:13:02 INFO - 'TMOUT': '86400', 07:13:02 INFO - 'USER': 'cltbld', 07:13:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022', 07:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:02 INFO - '_': '/tools/buildbot/bin/python'} 07:13:02 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/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:13:02 INFO - mozversion application_buildid: 20170322132507 07:13:02 INFO - mozversion application_changeset: ee30286771eb83c0878621485009dc2722daa78f 07:13:02 INFO - mozversion application_display_name: Nightly 07:13:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:13:02 INFO - mozversion application_name: Firefox 07:13:02 INFO - mozversion application_remotingname: firefox 07:13:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:13:02 INFO - mozversion application_vendor: Mozilla 07:13:02 INFO - mozversion application_version: 55.0a1 07:13:02 INFO - mozversion platform_buildid: 20170322132507 07:13:02 INFO - mozversion platform_changeset: ee30286771eb83c0878621485009dc2722daa78f 07:13:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:13:02 INFO - mozversion platform_version: 55.0a1 07:13:02 INFO - using testdate: 1490191982 07:13:02 INFO - actual date: 1490191982 07:13:02 INFO - starting webserver on 'localhost:49838' 07:13:02 INFO - SUITE-START | Running 2 tests 07:13:02 INFO - TEST-START | dromaeo_css 07:13:02 INFO - operating with platform_type : linux_ 07:13:02 INFO - Initialising browser for dromaeo_css test... 07:13:02 INFO - TEST-INFO | started process 4798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmfcka5/profile http://localhost:49838/getInfo.html) 07:13:06 INFO - PID 4798 | __metrics Screen width/height:1600/1200 07:13:06 INFO - PID 4798 | colorDepth:24 07:13:06 INFO - PID 4798 | Browser inner width/height: 1024/697 07:13:06 INFO - PID 4798 | __metrics 07:13:07 INFO - PID 4798 | 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:13:07 INFO - PID 4798 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:13:08 INFO - TEST-INFO | 4798: exit 0 07:13:08 INFO - Browser initialized. 07:13:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:13:08 INFO - TEST-INFO | started process 4893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmfcka5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:20 INFO - PID 4893 | RSS: Main: 144502784 07:13:20 INFO - PID 4893 | 07:16:23 INFO - PID 4893 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49838/tests/dromaeo/cssquery-ext.html) 07:16:24 INFO - PID 4893 | RSS: Main: 292335616 07:16:24 INFO - PID 4893 | 07:18:10 INFO - PID 4893 | ************************* 07:18:10 INFO - PID 4893 | A coding exception was thrown and uncaught in a Task. 07:18:10 INFO - PID 4893 | 07:18:10 ERROR - PID 4893 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:18:10 INFO - PID 4893 | Full stack: 07:18:10 INFO - PID 4893 | ************************* 07:19:27 INFO - PID 4893 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-ext.html (next: http://localhost:49838/tests/dromaeo/cssquery-jquery.html) 07:19:28 INFO - PID 4893 | RSS: Main: 235606016 07:19:28 INFO - PID 4893 | 07:22:29 INFO - PID 4893 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49838/tests/dromaeo/cssquery-mootools.html) 07:22:30 INFO - PID 4893 | RSS: Main: 179916800 07:22:30 INFO - PID 4893 | 07:25:32 INFO - PID 4893 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49838/tests/dromaeo/cssquery-prototype.html) 07:25:33 INFO - PID 4893 | RSS: Main: 176156672 07:25:33 INFO - PID 4893 | 07:28:36 INFO - PID 4893 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49838/tests/dromaeo/cssquery-yui.html) 07:28:36 INFO - PID 4893 | RSS: Main: 180625408 07:28:36 INFO - PID 4893 | 07:31:39 INFO - PID 4893 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-yui.html (next: http://localhost:49838/tests/dromaeo/cssquery-dojo.html) 07:31:39 INFO - PID 4893 | RSS: Main: 290172928 07:31:39 INFO - PID 4893 | 07:31:39 INFO - PID 4893 | __start_tp_report 07:31:39 INFO - PID 4893 | _x_x_mozilla_page_load 07:31:39 INFO - PID 4893 | _x_x_mozilla_page_load_details 07:31:39 INFO - PID 4893 | |i|pagename|runs| 07:31:39 INFO - PID 4893 | |0;dojo.html;3257.869685212592;3326.268220991381;3342.4484959981605;3350.5979282486105;3377.476491143874;5664.150377443375;5762.9135562966585;5762.942370576298;5782.1615865699505;5796.681182534964;5748.683822389767;5755.740991655375;5775.480206781389;5790;5851.444112809287;5087.211482220262;5160.14857548504;5168.586513078963;5246.422893481714;5252.107141785887;5254.185601231815;5279.3928698199625;5283.471652834724;5285.207218917174;5286.074936886049;5076.695398276115;5078.21287700407;5095.847124586268;5139.511746384088;5209.843704688866;5108.361454818148;5145.408278048035;5160.380754309507;5188.9881473112755;5202.713850738208;5124.385073791132;5150.510701483353;5164;5168.5606723428555;5229.712365819878;5579.8884022319735;5762.1068734346245;5764.798232061899;5765.855853603652;5773.307203135609;6106.764041036324;6132.938670613326;6170.136180934673;6203.038529028008;6224.502039836802;6257.5619706620555;6272.843178920518;6272.968635156841;6279.717412716439;6282.905756413657;5793.132294944854;5799.594028417971;5830.591858569902;5856.502197313276;5901.822945311647;6183.567150299526;6221.253449585988;6336.619802811846;6383.170187875639;6412.61524308543;5998.970005149947;6045.395460453919;6048.939510604926;6117.327094019654;6118.771466971993;6211.565190436717;6230.719617617218;6236.158118654014;6238.875222495615;6239.064140378889;6146.631202127886;6152.292486364126;6202.28673702521;6214.813555593249;6215.595986260879;6065.363136870565;6123.903153635682;6125.264968203844;6149.2313460817395;6196.411340922605;4757.666963312535;4757.95242047582;4758.119747846659;4776.355192049029;4800.591949684246;4222.3244280914905;4223.450951376301;4226.112516371596;4241.703080784316;4260.531341552427;5765.971170144123;5834.970825145847;5861.5603829712945;5879.265091863517;5890.911636325459;6190.133381326528;6293.653849038347;6297.96851015742;6302.180716506917;6302.275238347557;5846.356900740915;5850.590458667937;5855.180274761537;5858.238429004202;5863.384344643751;5191.896162076738;5228.816991405359;5263.26314315996;5306.416294207634;5312.92030619541;6335.429811317003;6387.041943708388;6445.677716114175;6464.062710906798;6466.127072845105;6198.659073750807;6226.377362263737;6256.155419018374;6261.373862613702;6263.906041409474;6374.043893416025;6376.107344971615;6415.775447859489;6431.228252609717;6438.935610643834;5999.980003399345;6053.515718742578;6100.127044624488;6101.359357267423;6134;6219.036049412348;6279.026750853625;6283.937160628518;6293.905591416224;6299.338569450325;5919.852003699942;5988.610740301867;6040.244969378828;6063.939360606514;6126.264848218242;6066.575339726177;6070.939290607214;6083.513318934563;6083.878322433438;6085.574009819447;6062.272527296753;6063.575549711478;6088.360722124113;6088.4824789893355;6129.509639228761;5996.5502587305255;6064.969675151596;6081.087836824512;6122.204113465221;6154.230721159855;5972.044472884318;5975.760969561169;6025.246844144482;6026.306974697965;6035.034394496859 07:31:39 INFO - PID 4893 | |1;ext.html;650.8860949333865;723.5911709883916;740.004693686991;1133.676902082906;1136.9488373023214;28524;35223.471647925304;35975.4603680945;36010.819945900264;36051.27897442049;37629.435558466575;37693.81153094231;37825;37946.8102659487;38057.42913856294;6000.129981152731;6116.357782432848;8142.18578142184;8334.583270836465;8335.208155225244;7824.56964866935;7990.800229994238;7995.120536740954;7998.44010919233;8000.399970002273;8104.311133553655;8174.632141553644;8209.671613135468;8211.260986511214;8211.260986511214;8106.351491880635;8364.623591938316;8373.246407823264;8376.162383761635;8379.329653627696;7959.681612735483;8051.798705032363;8066.11272759996;8068.273855352988;8068.757937261891;40272.798636006926;40483.39274910879;40555;40563.797181014204;40592.188156237;2963.822170669745;2998.685138060494;3002.714742099497;3011.6084908961916;3030.757539396843;27819.304517387227;28003;28137.29656758577;28417.289567760763;28963.56554651682;3549.6450354964554;3564.9661598136768;3573.0888623401124;3619.7466177367596;3626.3835148024637;154865;156169.2191539035;183366;185520;186594.99999999863;47356.526434735904;47505;47609.285860712116;47627.285590716165;47845.28232076522;49985;50031;50071.74964125229;50119;50142.49857501451;14543.27283635814;14777.630559236106;14798.630034249014;14801.407943682347;14843.480478183428;9361.251099911991;9370.812583748288;11053.899759045917;11772.941135294268;11794.29234245948;13991.510297139552;14004.43982240699;14155.858441415454;14669.119852808866;14821.481248156262;5702.515286200636;5762.88474230513;5764;5775.364709881909;5865.853353666107;1013.5945621751358;1036.1503567075076;1047.0737409359317;1050.5535147562255;1063.2663462211049;24163.69697666376;24419.75580244175;24508.754912451004;24601.261962141165;24854.254372368498;1126.5381193710539;1137.5449820071872;1138.0895283772948;1140.1790710688292;1165.7143999720122;12740.044496662787;13531.188128712309;13538.932305338607;13723.931380343034;13782.862171378358;335086;337620;338132;338683;339046;58050.12924806131;58334;58516;58594;58706.11940820891;1448.9855101449061;1451.7096580683906;1469.133211405276;1496.1845794042274;1510.8338082810883;23851.64222536698;24225.39436514101;24537.21052237185;24625.384365391008;24850.254492365257;39512.60487395089;39517.80241098891;39784.80107599444;39839.402408964466;39927.2014559713;319701;320943;321272;322415;324138;25177.370565736004;25626.949844012062;27750.72249277562;29540.409191816474;33567;35229.471557927165;35589.28821423505;35683.10792230215;35869;38421.807890961485;32989.50515742218;33591;33642.327153457285;33677.32645347128;33914.3217135651;32884.67115328816;33339.33321333608;33823.323533529685;33968;34669.653303467654;33998;34399.484007739404;34679.826600866836;34720.82639586887;35024;26775.598366024915;28798.7120128796;30274.84862575673;30453.847730761205;30540.08379748611;23708.877962984647;23720.762792371854;24122.75877241205;24262.75737242605;24351.904164312295 07:31:39 INFO - PID 4893 | |2;jquery.html;430.9202797482468;446.1901648507959;448.6231565484992;455.37386094120586;456.59135074108696;19654.803451965476;20799;21391.786082139173;21645.350639480803;21715.239966601173;21179.364619061413;21269.149234030658;21290.46773830655;21481.026010188125;21500.247491337806;5734.397888221729;5947.286325640929;5949.077892926603;5953.285605727318;5956.19591355168;5662.17898404731;5814.098814683731;5864.618799778023;5876.853078673024;5880.470757631812;5828.9417105828825;5832.941670583282;5841.094630332284;5846.21076154718;5846.298444186704;5793.391693872146;5945.940540594604;5980.431858973434;6006.579539432241;6006.969965150146;5384.488473595042;5436.809711660112;5447.046766815831;5449.56403487724;5478.753456094445;24444;24835.25494235176;25079.122230721838;25095.87452062746;25391.873040634862;2014.1920309354434;2018.8990550472417;2029.0666293505005;2041.8876961767096;2063.556335387899;15121.621959451102;15471.922640386838;15709.685806283811;15732.370705171894;16076.839231607652;1811.1668632429098;1868.1313189366874;1868.6262747450428;1872.6816441205028;1881.106474424651;111493.44253278762;111628;111770;114520.99999999917;116695;11801.763964720829;12079.27524348542;12146.45340959659;12306.938465307616;12365.690857728629;17432.65134697299;17440.476785696195;17457.47627571175;17457.912710436365;17470.563235919202;8143.348532117417;8400.873986890201;8483.957580212184;8565.700200492953;8574.271186949054;7530.548167109991;7642.159362470124;7647.661659209616;7797.337226335825;7882.921170788333;7584.393248540104;7728.729494467667;7794.259545343183;7893.329067029252;7905.960470197727;2139.7753235910004;2141.443224761573;2146.7101941238047;2169.1973969631335;2369.289213236022;979.9363041402286;982.5922242269378;991.3704797453524;1001.5442973447064;1023.5138309303021;18150.45548633543;19040.904795475933;19303.4208973731;19619.411417657495;19788.802111978985;1021.4841505039907;1032.385730490357;1036.1658864614058;1037.5797801890246;1041.2763129624989;10161.898381016243;10631.149508039338;10724.463776811284;10744.355338679705;10775.16822140238;593084;596373;610485;621240;628869;98062.50968745111;100941.49529252306;105502;105802;108279;1170.4381896689636;1172.366921862202;1173.8004539228352;1180.9055275577932;1195.6054502014488;15640.934071384676;16197.59506012359;16441.91779041097;16503.422380216634;16554.58613534671;46939.530604693515;47016.52983470258;47780.28329575129;48058.75970620124;48209.51790482191;56088.71955640196;58657.70671146617;59260.70369648124;59956.400435996824;60023;8389.286910612665;8582.78543036429;8626.439281446686;8628.180322869317;8671.696490622799;12601.558945436866;12748.872511274769;12954.935225323814;13333.866661333263;13415.128016679275;11719.238249513754;11749.412529373669;11855.58505452305;11869.5845645402;12021.579244726392;11249.943750281196;11369.602063927723;11430.828537571777;11592.6522204334;11808.409579521162;11945;12299.446524906221;12346.567870124503;12431.191972521758;12506.18709783861;9055.773605659911;9170.899492060995;9445.008274131393;9461.670457719638;9626.95186524063;11173.385463799568;11329.490172942402;11500.25248358854;11689.88310116922;11906.285622862655 07:31:39 INFO - PID 4893 | |3;mootools.html;1198.6703656494458;1309.757694826457;1366.3168415792104;1374.3265799758121;1392.0325373865162;9032.322575806817;10343.844842327362;10639.57441702331;10649.20130990177;10651.946740266307;10398.68803935883;10488.423136727477;10491.475426228697;10495.73760655984;10505.527251273692;2006.3679940818595;2374.7031621047367;2407.723111842143;2412.3004328744732;2413.8793060347;2108.2410332280365;2316.9536609267802;2384.9046038158453;2391.5336509380677;2397.9520409591796;2325.697659304288;2360.8701521416315;2361.067378385537;2368.431576421655;2370.1704403458825;2318.4783423729696;2326.7440581536016;2336.3224664847176;2339.4970081432402;2340.9348746320384;2261.7172853393326;2383.475635360235;2385.1413491143176;2387.057112440576;2389.3668177932686;10812.891871081267;10889.83665245022;10899.400532970683;10904.727381815439;10911.890881091167;6123.112148738453;6358.42774150324;6365.1725275714325;6373.808785736435;6388.041793730931;3622.8913132606062;3727.1986522897437;3946.309395855714;3984.3425834737523;3987.441758153861;1355.8847497962686;1395.9511417100352;1400.5798260521804;1424.8432672406027;1470.573533675233;16358.263878125514;16387.262573184114;16388.508344749676;16430.260638271306;16468.258928348252;5483.725813709299;5590.357108932525;5601.803936862272;5613.522850557748;5653.378128405872;13583.388747506386;13594.796078058836;13626.1143025703;13631.795523067161;13637.522686705917;6432.903506447407;6443;6449.258335291502;6455.386738259952;6456.322086180978;4835.129676658235;4983.352164218629;5653.180288858092;5912.379200184005;5965.910511342333;4345.543717909637;4370.409994650745;4455.443069616298;4459.531749166291;4478.507364189936;1347.6698208938872;1382.5783136143573;1388.1809732257814;1389.5553422904572;1389.6942672612008;796.2117503671324;808.292743849132;810.9878351824727;813.1989989859983;822.6051495282298;5917.082852157836;6035.607685500516;6045.21412216409;6166.907496387557;6294.0558916162945;909.1499448015994;921.9858156028449;924.4037595750704;924.7965447601651;926.2127191886842;3862.9613703863165;3873.4770805941403;3878.991462219843;3893.124047089439;3926.823292951824;14104.929475352557;14526.782098268535;14546.345414456375;14554;14589.781153282709;14063;14220.075695079786;14250.216238106796;14250.643733906529;14290.57128286153;9821.852672209923;10231.590736370461;10251.077403033763;10257.230707696952;10269.127124194378;6956.686949087202;7091.1490621125795;7144.214136444883;7152.356287934111;7160.785176444715;12863.22820630765;13082;13160.078794484294;13243.337833108499;13250;12564;12663.303518306582;12757.425915833624;13008.414621341873;13376;8088.150744171778;8325.54209518458;8889.066648001866;8984.640614375352;9073.954630226806;9936.900630993887;10419.426931518536;10446;10449.68650940473;10475.371477711362;9169.587368568296;9518.904810951803;9641.37331073478;9690.85463718059;9852.704418867446;9213.170814626716;9320.114589114024;9568.904310956801;9591.856122158313;9598.232141428809;7763.534187948741;7839.7256096038645;7905.249001344863;7920.405969552191;7959.641816118173;5780.306363236438;5782.624129431573;5806.390329015561;6085.087236914498;6115.908261375994;5996.280446346466;6073.392660734068;6096.207493025879;6175.505959523138;6203.565750397429 07:31:39 INFO - PID 4893 | |4;prototype.html;408.22999598705957;423.4008877438425;426.7077052219228;431.4240488947255;433.3391577843786;5544.722763861811;5769.394213607574;5769.798057068004;5772;5772.422757724231;5650.237217975572;5683.772649094031;5687.2606561146995;5720;5730.226419433376;4230.153969206163;4338.84814031509;4339.522652508222;4342.913141737164;4374.081442896995;4353.738775673454;4360.781960901958;4362.19299429605;4365.4106695596;4372.803223854934;4317.935230971538;4340.589308474742;4346.217680817452;4347.326279382429;4349.586789255031;4128.545859955388;4301.032267739764;4347;4350.195213885409;4362.520122786491;3785.413260944558;3791.50710407648;3792.431135329695;3807.619238076198;3811.1996480739076;5559.166125081229;5568.52667523261;5573.136163894603;5573.6098473106895;5578.386377498472;4947.431045429786;5048.343715317022;5049.293098966147;5059.293278096237;5094.490550944876;5945.31628862682;5946.910796338058;5954.910676339859;5972.192385129969;5972.283326000907;4195.538490766014;4221.451211342536;4227.556106608823;4230.76730779807;4230.809613567397;6139.600925939844;6297.716602752887;6308.148399965991;6313.905291420632;6344.827586206897;4364.476262848415;4386.583274588909;4389.4513185851765;4393.868183954486;4408;4435.068635586498;4438.977805111019;4444.977775111104;4449.755263460541;4471.374007638933;4992.72540010303;5022.769421491758;5073.315102461121;5080.720560369141;5100.183970564692;6034.818955431344;6035.124906888476;6041.426064523863;6042.274927008787;6062.120992456157;1506.8493150685063;1547.6981988512357;1558.2286768049887;1561.500319897622;1566.1386237569518;1023.6673081248475;1050.9737256568646;1053.378506681062;1059.1368035051407;1071.325065208929;5739.139129130664;5743.966086104541;5774.162746401832;5780.739866706008;5783.045797443375;6217.844553886099;6226.844328891723;6243.37566243372;6264.123022776815;6265.65538895356;5609.1305847593685;5754.079347304411;5768.884622307614;5804.738786754606;5855;3261.249912520086;3267.281198136406;3283.4254005548933;3289.5657213661716;3300.864179029931;6279.717412716439;6332.746690132343;6453.032045193165;6468.514861385321;6483.077737968555;6029.517638588903;6225.190725205694;6269.711555282289;6355.618662880242;6357.364263573698;6210.378962103844;6252.5935814171935;6257.43683068526;6279.560430769893;6372.55392122547;6003.879922401615;6195.81412557624;6214.875702486015;6227.844303892439;6236.251649801871;5783.768649253982;5924.496417804535;6089.51283897296;6143.72353244114;6164.630122192682;6234.345393733593;6360.823247699191;6387.361263873576;6392.648404337806;6405.583637063576;4405.603495685404;4416.4258646375765;4420.425344705168;4429.800658970418;4436.779885531505;5958.404159584007;6180.165677633462;6210.391635513005;6221.346758590464;6231.875362492634;6043.063325184604;6061.363556826646;6069.36271691466;6075.27096748393;6082.817515474543;5792.420757924174;5956.970215148896;6094.268687757498;6101.298350689727;6126.356732543019;6028.638281703112;6029.8191054268445;6043.576949613484;6053.9091913622215;6085.1785009023215;6075.453209211192;6105.55777688928;6118.736067654818;6139.631622102688;6146.323904370605;5638.64672478594;5897.67562784051;5931.8432905582995;5944.821655350346;5945.910811337747 07:31:39 INFO - PID 4893 | |5;yui.html;760.7831767946135;761.2881955371731;768.2624680306905;769.1001528211991;787.5747096567853;14964.5510634681;15104.169270690109;15141.621459463506;15257.160856152921;15366.923165384158;14686.63283417915;14954.476593319236;14967.326470308835;14989;14997.62505937352;800.2317774936068;806.3226889412892;820.1511435664089;825.8637324841394;841.4152164245852;847.8516259654535;852.9872051919226;857.1985193843744;857.4041041476177;857.5240741388527;891.777055736066;898.3352319283748;899.9145081217274;905.0451773379083;905.2576886952702;898.3666515106834;898.6180873128894;898.847195976679;899.0964081098487;899.1143723432414;654.1790053482896;654.6203202142793;655.3446553446554;656.0061506817176;656.5699466849221;16170.595735106599;16255;16393;17032.744508832253;17056.232469538776;15881.52355429339;15918;15978.920105399515;16016.199190040568;16502.83497165037;12387.93806030973;12388.442520086617;12446.75106497874;12548.937255313756;13198.736025279537;3151.306712523241;3167.572377729;3250.951235731466;3323.7839540429795;3324.036029551427;83366;83593;84092.15907840905;85166.57416712877;87114.12885871188;11809.704757381134;11986.580469683693;11989.478194155161;12006.87993120075;12094.69763255908;24639.753602464105;24872;25038.749612504005;25455;25460.363490912874;8121.918780812234;8125.065617454068;8129.79675508117;8266.8346633067;8275;4087.05997620543;4099.713020088565;4116.279651061052;4140.171965606891;4223.72545784523;4192.140611174702;4205.074883525619;4211.599898009746;4237.63980061692;4308.698391112592;775.8913752074714;796.1640277708383;813.1949370123535;814.0353680888167;845.966161353539;635.8124353315783;639.1754636518931;642.2004604267717;646.4795839349275;653.2487639214941;9874.40753554789;10303.845442318221;10565;10653.520591573399;10898.291611045257;615.6521565315583;631.463256232199;654.404491912367;663.3300366629642;668.4385116502161;4814.181589129857;4989.90020199594;5041.571466425395;5066.898662026812;5070.974645126751;58216;70530;78348.60825695835;79651.20348796554;83487.5825620868;56078;63891.680541596994;73634.26365736382;74905;77448.22551774523;64380.35619643837;64869;65251.67374163099;65434.672826635564;66916.66541667261;10200.0819926207;10675.786484270426;10717.47632566344;10736.463176841284;10895.237333386587;28786.568201476577;29875.850620746758;30140.397192055596;30725.846370768002;31619;53283;54262;54640.453595463536;54895.72552137214;55705;13905.582832515041;13996.16023038621;14016.088954217943;14380.35288412003;14807.259637018322;15040.09203564408;15240.923795380952;15625.531234062997;15827;16037;14389.352479138255;14902.32939517746;15086.471973480875;15148.772768408262;15578.766318505459;14389.856101438852;14489.203093829941;14632.561023169323;14922.253887305375;15177.16525591059;14245.928770356082;14319.856801432268;14405.495807646683;14405.78391324152;14784.186869721838;10870.347779133277;11337.716557086138;11516.795118498047;11581.82627260575;12117.333546655018;10068.797655415527;10909.727256818325;11109.555617775199;11491.253068550517;11569.479373428385 07:31:39 INFO - PID 4893 | __end_tp_report 07:31:39 INFO - PID 4893 | __start_cc_report 07:31:39 INFO - PID 4893 | _x_x_mozilla_cycle_collect,1568 07:31:39 INFO - PID 4893 | __end_cc_report 07:31:39 INFO - PID 4893 | __startTimestamp1490193099678__endTimestamp 07:31:39 INFO - PID 4893 | 07:31:39 INFO - PID 4893 | ------- Summary: start ------- 07:31:39 INFO - PID 4893 | Number of tests: 6 07:31:39 INFO - PID 4893 | 07:31:39 INFO - PID 4893 | [#0] dojo.html Cycles:165 Average:5747.14 Median:6025.25 stddev:670.54 (11.1%) stddev-sans-first:643.53 07:31:39 INFO - PID 4893 | Values: 3257.9 3326.3 3342.4 3350.6 3377.5 5664.2 5762.9 5762.9 5782.2 5796.7 5748.7 5755.7 5775.5 5790.0 5851.4 5087.2 5160.1 5168.6 5246.4 5252.1 5254.2 5279.4 5283.5 5285.2 5286.1 5076.7 5078.2 5095.8 5139.5 5209.8 5108.4 5145.4 5160.4 5189.0 5202.7 5124.4 5150.5 5164.0 5168.6 5229.7 5579.9 5762.1 5764.8 5765.9 5773.3 6106.8 6132.9 6170.1 6203.0 6224.5 6257.6 6272.8 6273.0 6279.7 6282.9 5793.1 5799.6 5830.6 5856.5 5901.8 6183.6 6221.3 6336.6 6383.2 6412.6 5999.0 6045.4 6048.9 6117.3 6118.8 6211.6 6230.7 6236.2 6238.9 6239.1 6146.6 6152.3 6202.3 6214.8 6215.6 6065.4 6123.9 6125.3 6149.2 6196.4 4757.7 4758.0 4758.1 4776.4 4800.6 4222.3 4223.5 4226.1 4241.7 4260.5 5766.0 5835.0 5861.6 5879.3 5890.9 6190.1 6293.7 6298.0 6302.2 6302.3 5846.4 5850.6 5855.2 5858.2 5863.4 5191.9 5228.8 5263.3 5306.4 5312.9 6335.4 6387.0 6445.7 6464.1 6466.1 6198.7 6226.4 6256.2 6261.4 6263.9 6374.0 6376.1 6415.8 6431.2 6438.9 6000.0 6053.5 6100.1 6101.4 6134.0 6219.0 6279.0 6283.9 6293.9 6299.3 5919.9 5988.6 6040.2 6063.9 6126.3 6066.6 6070.9 6083.5 6083.9 6085.6 6062.3 6063.6 6088.4 6088.5 6129.5 5996.6 6065.0 6081.1 6122.2 6154.2 5972.0 5975.8 6025.2 6026.3 6035.0 07:31:39 INFO - PID 4893 | 07:31:39 INFO - PID 4893 | [#1] ext.html Cycles:180 Average:43004.60 Median:186253.16 stddev:75737.18 (40.7%) stddev-sans-first:75882.88 07:31:39 INFO - PID 4893 | Values: 650.9 723.6 740.0 1133.7 1136.9 28524.0 35223.5 35975.5 36010.8 36051.3 37629.4 37693.8 37825.0 37946.8 38057.4 6000.1 6116.4 8142.2 8334.6 8335.2 7824.6 7990.8 7995.1 7998.4 8000.4 8104.3 8174.6 8209.7 8211.3 8211.3 8106.4 8364.6 8373.2 8376.2 8379.3 7959.7 8051.8 8066.1 8068.3 8068.8 40272.8 40483.4 40555.0 40563.8 40592.2 2963.8 2998.7 3002.7 3011.6 3030.8 27819.3 28003.0 28137.3 28417.3 28963.6 3549.6 3565.0 3573.1 3619.7 3626.4 154865.0 156169.2 183366.0 185520.0 186595.0 47356.5 47505.0 47609.3 47627.3 47845.3 49985.0 50031.0 50071.7 50119.0 50142.5 14543.3 14777.6 14798.6 14801.4 14843.5 9361.3 9370.8 11053.9 11772.9 11794.3 13991.5 14004.4 14155.9 14669.1 14821.5 5702.5 5762.9 5764.0 5775.4 5865.9 1013.6 1036.2 1047.1 1050.6 1063.3 24163.7 24419.8 24508.8 24601.3 24854.3 1126.5 1137.5 1138.1 1140.2 1165.7 12740.0 13531.2 13538.9 13723.9 13782.9 335086.0 337620.0 338132.0 338683.0 339046.0 58050.1 58334.0 58516.0 58594.0 58706.1 1449.0 1451.7 1469.1 1496.2 1510.8 23851.6 24225.4 24537.2 24625.4 24850.3 39512.6 39517.8 39784.8 39839.4 39927.2 319701.0 320943.0 321272.0 322415.0 324138.0 25177.4 25626.9 27750.7 29540.4 33567.0 35229.5 35589.3 35683.1 35869.0 38421.8 32989.5 33591.0 33642.3 33677.3 33914.3 32884.7 33339.3 33823.3 33968.0 34669.7 33998.0 34399.5 34679.8 34720.8 35024.0 26775.6 28798.7 30274.8 30453.8 30540.1 23708.9 23720.8 24122.8 24262.8 24351.9 07:31:39 INFO - PID 4893 | 07:31:39 INFO - PID 4893 | [#2] jquery.html Cycles:180 Average:34241.23 Median:11715.12 stddev:100784.70 (860.3%) stddev-sans-first:101035.45 07:31:39 INFO - PID 4893 | Values: 430.9 446.2 448.6 455.4 456.6 19654.8 20799.0 21391.8 21645.4 21715.2 21179.4 21269.1 21290.5 21481.0 21500.2 5734.4 5947.3 5949.1 5953.3 5956.2 5662.2 5814.1 5864.6 5876.9 5880.5 5828.9 5832.9 5841.1 5846.2 5846.3 5793.4 5945.9 5980.4 6006.6 6007.0 5384.5 5436.8 5447.0 5449.6 5478.8 24444.0 24835.3 25079.1 25095.9 25391.9 2014.2 2018.9 2029.1 2041.9 2063.6 15121.6 15471.9 15709.7 15732.4 16076.8 1811.2 1868.1 1868.6 1872.7 1881.1 111493.4 111628.0 111770.0 114521.0 116695.0 11801.8 12079.3 12146.5 12306.9 12365.7 17432.7 17440.5 17457.5 17457.9 17470.6 8143.3 8400.9 8484.0 8565.7 8574.3 7530.5 7642.2 7647.7 7797.3 7882.9 7584.4 7728.7 7794.3 7893.3 7906.0 2139.8 2141.4 2146.7 2169.2 2369.3 979.9 982.6 991.4 1001.5 1023.5 18150.5 19040.9 19303.4 19619.4 19788.8 1021.5 1032.4 1036.2 1037.6 1041.3 10161.9 10631.1 10724.5 10744.4 10775.2 593084.0 596373.0 610485.0 621240.0 628869.0 98062.5 100941.5 105502.0 105802.0 108279.0 1170.4 1172.4 1173.8 1180.9 1195.6 15640.9 16197.6 16441.9 16503.4 16554.6 46939.5 47016.5 47780.3 48058.8 48209.5 56088.7 58657.7 59260.7 59956.4 60023.0 8389.3 8582.8 8626.4 8628.2 8671.7 12601.6 12748.9 12954.9 13333.9 13415.1 11719.2 11749.4 11855.6 11869.6 12021.6 11249.9 11369.6 11430.8 11592.7 11808.4 11945.0 12299.4 12346.6 12431.2 12506.2 9055.8 9170.9 9445.0 9461.7 9627.0 11173.4 11329.5 11500.3 11689.9 11906.3 07:31:39 INFO - PID 4893 | 07:31:39 INFO - PID 4893 | [#3] mootools.html Cycles:180 Average:6976.69 Median:2413.09 stddev:4426.55 (183.4%) stddev-sans-first:4417.68 07:31:39 INFO - PID 4893 | Values: 1198.7 1309.8 1366.3 1374.3 1392.0 9032.3 10343.8 10639.6 10649.2 10651.9 10398.7 10488.4 10491.5 10495.7 10505.5 2006.4 2374.7 2407.7 2412.3 2413.9 2108.2 2317.0 2384.9 2391.5 2398.0 2325.7 2360.9 2361.1 2368.4 2370.2 2318.5 2326.7 2336.3 2339.5 2340.9 2261.7 2383.5 2385.1 2387.1 2389.4 10812.9 10889.8 10899.4 10904.7 10911.9 6123.1 6358.4 6365.2 6373.8 6388.0 3622.9 3727.2 3946.3 3984.3 3987.4 1355.9 1396.0 1400.6 1424.8 1470.6 16358.3 16387.3 16388.5 16430.3 16468.3 5483.7 5590.4 5601.8 5613.5 5653.4 13583.4 13594.8 13626.1 13631.8 13637.5 6432.9 6443.0 6449.3 6455.4 6456.3 4835.1 4983.4 5653.2 5912.4 5965.9 4345.5 4370.4 4455.4 4459.5 4478.5 1347.7 1382.6 1388.2 1389.6 1389.7 796.2 808.3 811.0 813.2 822.6 5917.1 6035.6 6045.2 6166.9 6294.1 909.1 922.0 924.4 924.8 926.2 3863.0 3873.5 3879.0 3893.1 3926.8 14104.9 14526.8 14546.3 14554.0 14589.8 14063.0 14220.1 14250.2 14250.6 14290.6 9821.9 10231.6 10251.1 10257.2 10269.1 6956.7 7091.1 7144.2 7152.4 7160.8 12863.2 13082.0 13160.1 13243.3 13250.0 12564.0 12663.3 12757.4 13008.4 13376.0 8088.2 8325.5 8889.1 8984.6 9074.0 9936.9 10419.4 10446.0 10449.7 10475.4 9169.6 9518.9 9641.4 9690.9 9852.7 9213.2 9320.1 9568.9 9591.9 9598.2 7763.5 7839.7 7905.2 7920.4 7959.6 5780.3 5782.6 5806.4 6085.1 6115.9 5996.3 6073.4 6096.2 6175.5 6203.6 07:31:39 INFO - PID 4893 | 07:31:39 INFO - PID 4893 | [#4] prototype.html Cycles:180 Average:5049.94 Median:5761.48 stddev:1495.07 (25.9%) stddev-sans-first:1458.11 07:31:39 INFO - PID 4893 | Values: 408.2 423.4 426.7 431.4 433.3 5544.7 5769.4 5769.8 5772.0 5772.4 5650.2 5683.8 5687.3 5720.0 5730.2 4230.2 4338.8 4339.5 4342.9 4374.1 4353.7 4360.8 4362.2 4365.4 4372.8 4317.9 4340.6 4346.2 4347.3 4349.6 4128.5 4301.0 4347.0 4350.2 4362.5 3785.4 3791.5 3792.4 3807.6 3811.2 5559.2 5568.5 5573.1 5573.6 5578.4 4947.4 5048.3 5049.3 5059.3 5094.5 5945.3 5946.9 5954.9 5972.2 5972.3 4195.5 4221.5 4227.6 4230.8 4230.8 6139.6 6297.7 6308.1 6313.9 6344.8 4364.5 4386.6 4389.5 4393.9 4408.0 4435.1 4439.0 4445.0 4449.8 4471.4 4992.7 5022.8 5073.3 5080.7 5100.2 6034.8 6035.1 6041.4 6042.3 6062.1 1506.8 1547.7 1558.2 1561.5 1566.1 1023.7 1051.0 1053.4 1059.1 1071.3 5739.1 5744.0 5774.2 5780.7 5783.0 6217.8 6226.8 6243.4 6264.1 6265.7 5609.1 5754.1 5768.9 5804.7 5855.0 3261.2 3267.3 3283.4 3289.6 3300.9 6279.7 6332.7 6453.0 6468.5 6483.1 6029.5 6225.2 6269.7 6355.6 6357.4 6210.4 6252.6 6257.4 6279.6 6372.6 6003.9 6195.8 6214.9 6227.8 6236.3 5783.8 5924.5 6089.5 6143.7 6164.6 6234.3 6360.8 6387.4 6392.6 6405.6 4405.6 4416.4 4420.4 4429.8 4436.8 5958.4 6180.2 6210.4 6221.3 6231.9 6043.1 6061.4 6069.4 6075.3 6082.8 5792.4 5957.0 6094.3 6101.3 6126.4 6028.6 6029.8 6043.6 6053.9 6085.2 6075.5 6105.6 6118.7 6139.6 6146.3 5638.6 5897.7 5931.8 5944.8 5945.9 07:31:39 INFO - PID 4893 | 07:31:39 INFO - PID 4893 | [#5] yui.html Cycles:180 Average:17772.43 Median:4108.00 stddev:22431.14 (546.0%) stddev-sans-first:22457.69 07:31:39 INFO - PID 4893 | Values: 760.8 761.3 768.3 769.1 787.6 14964.6 15104.2 15141.6 15257.2 15366.9 14686.6 14954.5 14967.3 14989.0 14997.6 800.2 806.3 820.2 825.9 841.4 847.9 853.0 857.2 857.4 857.5 891.8 898.3 899.9 905.0 905.3 898.4 898.6 898.8 899.1 899.1 654.2 654.6 655.3 656.0 656.6 16170.6 16255.0 16393.0 17032.7 17056.2 15881.5 15918.0 15978.9 16016.2 16502.8 12387.9 12388.4 12446.8 12548.9 13198.7 3151.3 3167.6 3251.0 3323.8 3324.0 83366.0 83593.0 84092.2 85166.6 87114.1 11809.7 11986.6 11989.5 12006.9 12094.7 24639.8 24872.0 25038.7 25455.0 25460.4 8121.9 8125.1 8129.8 8266.8 8275.0 4087.1 4099.7 4116.3 4140.2 4223.7 4192.1 4205.1 4211.6 4237.6 4308.7 775.9 796.2 813.2 814.0 846.0 635.8 639.2 642.2 646.5 653.2 9874.4 10303.8 10565.0 10653.5 10898.3 615.7 631.5 654.4 663.3 668.4 4814.2 4989.9 5041.6 5066.9 5071.0 58216.0 70530.0 78348.6 79651.2 83487.6 56078.0 63891.7 73634.3 74905.0 77448.2 64380.4 64869.0 65251.7 65434.7 66916.7 10200.1 10675.8 10717.5 10736.5 10895.2 28786.6 29875.9 30140.4 30725.8 31619.0 53283.0 54262.0 54640.5 54895.7 55705.0 13905.6 13996.2 14016.1 14380.4 14807.3 15040.1 15240.9 15625.5 15827.0 16037.0 14389.4 14902.3 15086.5 15148.8 15578.8 14389.9 14489.2 14632.6 14922.3 15177.2 14245.9 14319.9 14405.5 14405.8 14784.2 10870.3 11337.7 11516.8 11581.8 12117.3 10068.8 10909.7 11109.6 11491.3 11569.5 07:31:39 INFO - PID 4893 | -------- Summary: end -------- 07:31:39 INFO - PID 4893 | 07:31:40 INFO - TEST-INFO | 4893: exit 0 07:31:40 INFO - TEST-OK | dromaeo_css | took 1117874ms 07:31:40 INFO - TEST-START | kraken 07:31:40 INFO - operating with platform_type : linux_ 07:31:40 INFO - Initialising browser for kraken test... 07:31:40 INFO - TEST-INFO | started process 5224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Rt5kI/profile http://localhost:49838/getInfo.html) 07:31:44 INFO - PID 5224 | __metrics Screen width/height:1600/1200 07:31:44 INFO - PID 5224 | colorDepth:24 07:31:44 INFO - PID 5224 | Browser inner width/height: 1024/697 07:31:44 INFO - PID 5224 | __metrics 07:31:45 INFO - PID 5224 | 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:31:45 INFO - PID 5224 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:46 INFO - TEST-INFO | 5224: exit 0 07:31:46 INFO - Browser initialized. 07:31:46 INFO - Running cycle 1/1 for kraken test... 07:31:46 INFO - TEST-INFO | started process 5319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Rt5kI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:58 INFO - PID 5319 | RSS: Main: 144752640 07:31:58 INFO - PID 5319 | 07:32:01 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49838/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:01 INFO - PID 5319 | RSS: Main: 200318976 07:32:01 INFO - PID 5319 | 07:32:04 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49838/tests/kraken/driver.html?testName=audio-dft) 07:32:05 INFO - PID 5319 | RSS: Main: 179077120 07:32:05 INFO - PID 5319 | 07:32:08 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49838/tests/kraken/driver.html?testName=audio-fft) 07:32:08 INFO - PID 5319 | RSS: Main: 261791744 07:32:08 INFO - PID 5319 | 07:32:10 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49838/tests/kraken/driver.html?testName=audio-oscillator) 07:32:11 INFO - PID 5319 | RSS: Main: 172085248 07:32:11 INFO - PID 5319 | 07:32:13 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49838/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:32:14 INFO - PID 5319 | RSS: Main: 176250880 07:32:14 INFO - PID 5319 | 07:32:17 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49838/tests/kraken/driver.html?testName=imaging-darkroom) 07:32:17 INFO - PID 5319 | RSS: Main: 215302144 07:32:17 INFO - PID 5319 | 07:32:21 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49838/tests/kraken/driver.html?testName=imaging-desaturate) 07:32:21 INFO - PID 5319 | RSS: Main: 230531072 07:32:21 INFO - PID 5319 | 07:32:24 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49838/tests/kraken/driver.html?testName=json-parse-financial) 07:32:25 INFO - PID 5319 | RSS: Main: 244027392 07:32:25 INFO - PID 5319 | 07:32:26 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49838/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:32:27 INFO - PID 5319 | RSS: Main: 178245632 07:32:27 INFO - PID 5319 | 07:32:29 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:32:29 INFO - PID 5319 | RSS: Main: 185151488 07:32:29 INFO - PID 5319 | 07:32:31 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:32 INFO - PID 5319 | RSS: Main: 194080768 07:32:32 INFO - PID 5319 | 07:32:34 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:35 INFO - PID 5319 | RSS: Main: 205008896 07:32:35 INFO - PID 5319 | 07:32:38 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:32:39 INFO - PID 5319 | RSS: Main: 200830976 07:32:39 INFO - PID 5319 | 07:32:40 INFO - PID 5319 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49838/tests/kraken/driver.html?testName=ai-astar) 07:32:41 INFO - PID 5319 | RSS: Main: 268775424 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | __start_tp_report 07:32:41 INFO - PID 5319 | _x_x_mozilla_page_load 07:32:41 INFO - PID 5319 | _x_x_mozilla_page_load_details 07:32:41 INFO - PID 5319 | |i|pagename|runs| 07:32:41 INFO - PID 5319 | |0;ai-astar;100;108;108;108;108;109;109;108;109;109 07:32:41 INFO - PID 5319 | |1;audio-beat-detection;153;119;117;150;120;117;122;117;143;118 07:32:41 INFO - PID 5319 | |2;audio-dft;161;162;161;164;161;161;164;164;162;162 07:32:41 INFO - PID 5319 | |3;audio-fft;76;75;74;107;76;74;74;75;91;74 07:32:41 INFO - PID 5319 | |4;audio-oscillator;83;84;110;83;83;82;100;83;83;109 07:32:41 INFO - PID 5319 | |5;imaging-gaussian-blur;113;113;113;113;114;114;114;113;113;112 07:32:41 INFO - PID 5319 | |6;imaging-darkroom;147;148;147;146;147;147;147;146;146;147 07:32:41 INFO - PID 5319 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 07:32:41 INFO - PID 5319 | |8;json-parse-financial;57;55;55;56;58;57;56;58;57;57 07:32:41 INFO - PID 5319 | |9;json-stringify-tinderbox;55;56;56;55;56;55;55;55;55;56 07:32:41 INFO - PID 5319 | |10;stanford-crypto-aes;78;78;79;80;78;79;80;79;81;78 07:32:41 INFO - PID 5319 | |11;stanford-crypto-ccm;133;127;140;126;125;124;127;126;176;126 07:32:41 INFO - PID 5319 | |12;stanford-crypto-pbkdf2;179;179;177;181;179;182;179;190;173;180 07:32:41 INFO - PID 5319 | |13;stanford-crypto-sha256-iterative;66;65;64;64;66;65;65;63;65;63 07:32:41 INFO - PID 5319 | __end_tp_report 07:32:41 INFO - PID 5319 | __start_cc_report 07:32:41 INFO - PID 5319 | _x_x_mozilla_cycle_collect,1744 07:32:41 INFO - PID 5319 | __end_cc_report 07:32:41 INFO - PID 5319 | __startTimestamp1490193161131__endTimestamp 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | ------- Summary: start ------- 07:32:41 INFO - PID 5319 | Number of tests: 14 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#0] ai-astar Cycles:10 Average:107.60 Median:108.50 stddev:2.72 (2.5%) stddev-sans-first:0.53 07:32:41 INFO - PID 5319 | Values: 100.0 108.0 108.0 108.0 108.0 109.0 109.0 108.0 109.0 109.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:121.00 stddev:14.82 (12.2%) stddev-sans-first:12.55 07:32:41 INFO - PID 5319 | Values: 153.0 119.0 117.0 150.0 120.0 117.0 122.0 117.0 143.0 118.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.32 07:32:41 INFO - PID 5319 | Values: 161.0 162.0 161.0 164.0 161.0 161.0 164.0 164.0 162.0 162.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#3] audio-fft Cycles:10 Average:79.60 Median:75.00 stddev:10.93 (14.6%) stddev-sans-first:11.51 07:32:41 INFO - PID 5319 | Values: 76.0 75.0 74.0 107.0 76.0 74.0 74.0 75.0 91.0 74.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:83.00 stddev:11.58 (13.9%) stddev-sans-first:12.00 07:32:41 INFO - PID 5319 | Values: 83.0 84.0 110.0 83.0 83.0 82.0 100.0 83.0 83.0 109.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 07:32:41 INFO - PID 5319 | Values: 113.0 113.0 113.0 113.0 114.0 114.0 114.0 113.0 113.0 112.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:32:41 INFO - PID 5319 | Values: 147.0 148.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:32:41 INFO - PID 5319 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.07 (1.9%) stddev-sans-first:1.13 07:32:41 INFO - PID 5319 | Values: 57.0 55.0 55.0 56.0 58.0 57.0 56.0 58.0 57.0 57.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 07:32:41 INFO - PID 5319 | Values: 55.0 56.0 56.0 55.0 56.0 55.0 55.0 55.0 55.0 56.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:1.05 (1.3%) stddev-sans-first:1.05 07:32:41 INFO - PID 5319 | Values: 78.0 78.0 79.0 80.0 78.0 79.0 80.0 79.0 81.0 78.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:127.00 stddev:15.85 (12.5%) stddev-sans-first:16.82 07:32:41 INFO - PID 5319 | Values: 133.0 127.0 140.0 126.0 125.0 124.0 127.0 126.0 176.0 126.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:179.50 stddev:4.31 (2.4%) stddev-sans-first:4.56 07:32:41 INFO - PID 5319 | Values: 179.0 179.0 177.0 181.0 179.0 182.0 179.0 190.0 173.0 180.0 07:32:41 INFO - PID 5319 | 07:32:41 INFO - PID 5319 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.01 07:32:41 INFO - PID 5319 | Values: 66.0 65.0 64.0 64.0 66.0 65.0 65.0 63.0 65.0 63.0 07:32:41 INFO - PID 5319 | -------- Summary: end -------- 07:32:41 INFO - PID 5319 | 07:32:42 INFO - TEST-INFO | 5319: exit 0 07:32:42 INFO - TEST-OK | kraken | took 61725ms 07:32:42 INFO - SUITE-END | took 1179s 07:32:42 INFO - Completed test suite (00:19:39) 07:32:42 INFO - javascript benchmark 07:32:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7475.623514107241, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3257.869685212592, 3326.268220991381, 3342.4484959981605, 3350.5979282486105, 3377.476491143874, 5664.150377443375, 5762.9135562966585, 5762.942370576298, 5782.1615865699505, 5796.681182534964, 5748.683822389767, 5755.740991655375, 5775.480206781389, 5790.0, 5851.444112809287, 5087.211482220262, 5160.14857548504, 5168.586513078963, 5246.422893481714, 5252.107141785887, 5254.185601231815, 5279.3928698199625, 5283.471652834724, 5285.207218917174, 5286.074936886049, 5076.695398276115, 5078.21287700407, 5095.847124586268, 5139.511746384088, 5209.843704688866, 5108.361454818148, 5145.408278048035, 5160.380754309507, 5188.9881473112755, 5202.713850738208, 5124.385073791132, 5150.510701483353, 5164.0, 5168.5606723428555, 5229.712365819878, 5579.8884022319735, 5762.1068734346245, 5764.798232061899, 5765.855853603652, 5773.307203135609, 6106.764041036324, 6132.938670613326, 6170.136180934673, 6203.038529028008, 6224.502039836802, 6257.5619706620555, 6272.843178920518, 6272.968635156841, 6279.717412716439, 6282.905756413657, 5793.132294944854, 5799.594028417971, 5830.591858569902, 5856.502197313276, 5901.822945311647, 6183.567150299526, 6221.253449585988, 6336.619802811846, 6383.170187875639, 6412.61524308543, 5998.970005149947, 6045.395460453919, 6048.939510604926, 6117.327094019654, 6118.771466971993, 6211.565190436717, 6230.719617617218, 6236.158118654014, 6238.875222495615, 6239.064140378889, 6146.631202127886, 6152.292486364126, 6202.28673702521, 6214.813555593249, 6215.595986260879, 6065.363136870565, 6123.903153635682, 6125.264968203844, 6149.2313460817395, 6196.411340922605, 4757.666963312535, 4757.95242047582, 4758.119747846659, 4776.355192049029, 4800.591949684246, 4222.3244280914905, 4223.450951376301, 4226.112516371596, 4241.703080784316, 4260.531341552427, 5765.971170144123, 5834.970825145847, 5861.5603829712945, 5879.265091863517, 5890.911636325459, 6190.133381326528, 6293.653849038347, 6297.96851015742, 6302.180716506917, 6302.275238347557, 5846.356900740915, 5850.590458667937, 5855.180274761537, 5858.238429004202, 5863.384344643751, 5191.896162076738, 5228.816991405359, 5263.26314315996, 5306.416294207634, 5312.92030619541, 6335.429811317003, 6387.041943708388, 6445.677716114175, 6464.062710906798, 6466.127072845105, 6198.659073750807, 6226.377362263737, 6256.155419018374, 6261.373862613702, 6263.906041409474, 6374.043893416025, 6376.107344971615, 6415.775447859489, 6431.228252609717, 6438.935610643834, 5999.980003399345, 6053.515718742578, 6100.127044624488, 6101.359357267423, 6134.0, 6219.036049412348, 6279.026750853625, 6283.937160628518, 6293.905591416224, 6299.338569450325, 5919.852003699942, 5988.610740301867, 6040.244969378828, 6063.939360606514, 6126.264848218242, 6066.575339726177, 6070.939290607214, 6083.513318934563, 6083.878322433438, 6085.574009819447, 6062.272527296753, 6063.575549711478, 6088.360722124113, 6088.4824789893355, 6129.509639228761, 5996.5502587305255, 6064.969675151596, 6081.087836824512, 6122.204113465221, 6154.230721159855, 5972.044472884318, 5975.760969561169, 6025.246844144482, 6026.306974697965, 6035.034394496859], "value": 5700.770733481458, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.8860949333865, 723.5911709883916, 740.004693686991, 1133.676902082906, 1136.9488373023214, 28524.0, 35223.471647925304, 35975.4603680945, 36010.819945900264, 36051.27897442049, 37629.435558466575, 37693.81153094231, 37825.0, 37946.8102659487, 38057.42913856294, 6000.129981152731, 6116.357782432848, 8142.18578142184, 8334.583270836465, 8335.208155225244, 7824.56964866935, 7990.800229994238, 7995.120536740954, 7998.44010919233, 8000.399970002273, 8104.311133553655, 8174.632141553644, 8209.671613135468, 8211.260986511214, 8211.260986511214, 8106.351491880635, 8364.623591938316, 8373.246407823264, 8376.162383761635, 8379.329653627696, 7959.681612735483, 8051.798705032363, 8066.11272759996, 8068.273855352988, 8068.757937261891, 40272.798636006926, 40483.39274910879, 40555.0, 40563.797181014204, 40592.188156237, 2963.822170669745, 2998.685138060494, 3002.714742099497, 3011.6084908961916, 3030.757539396843, 27819.304517387227, 28003.0, 28137.29656758577, 28417.289567760763, 28963.56554651682, 3549.6450354964554, 3564.9661598136768, 3573.0888623401124, 3619.7466177367596, 3626.3835148024637, 154865.0, 156169.2191539035, 183366.0, 185520.0, 186594.99999999863, 47356.526434735904, 47505.0, 47609.285860712116, 47627.285590716165, 47845.28232076522, 49985.0, 50031.0, 50071.74964125229, 50119.0, 50142.49857501451, 14543.27283635814, 14777.630559236106, 14798.630034249014, 14801.407943682347, 14843.480478183428, 9361.251099911991, 9370.812583748288, 11053.899759045917, 11772.941135294268, 11794.29234245948, 13991.510297139552, 14004.43982240699, 14155.858441415454, 14669.119852808866, 14821.481248156262, 5702.515286200636, 5762.88474230513, 5764.0, 5775.364709881909, 5865.853353666107, 1013.5945621751358, 1036.1503567075076, 1047.0737409359317, 1050.5535147562255, 1063.2663462211049, 24163.69697666376, 24419.75580244175, 24508.754912451004, 24601.261962141165, 24854.254372368498, 1126.5381193710539, 1137.5449820071872, 1138.0895283772948, 1140.1790710688292, 1165.7143999720122, 12740.044496662787, 13531.188128712309, 13538.932305338607, 13723.931380343034, 13782.862171378358, 335086.0, 337620.0, 338132.0, 338683.0, 339046.0, 58050.12924806131, 58334.0, 58516.0, 58594.0, 58706.11940820891, 1448.9855101449061, 1451.7096580683906, 1469.133211405276, 1496.1845794042274, 1510.8338082810883, 23851.64222536698, 24225.39436514101, 24537.21052237185, 24625.384365391008, 24850.254492365257, 39512.60487395089, 39517.80241098891, 39784.80107599444, 39839.402408964466, 39927.2014559713, 319701.0, 320943.0, 321272.0, 322415.0, 324138.0, 25177.370565736004, 25626.949844012062, 27750.72249277562, 29540.409191816474, 33567.0, 35229.471557927165, 35589.28821423505, 35683.10792230215, 35869.0, 38421.807890961485, 32989.50515742218, 33591.0, 33642.327153457285, 33677.32645347128, 33914.3217135651, 32884.67115328816, 33339.33321333608, 33823.323533529685, 33968.0, 34669.653303467654, 33998.0, 34399.484007739404, 34679.826600866836, 34720.82639586887, 35024.0, 26775.598366024915, 28798.7120128796, 30274.84862575673, 30453.847730761205, 30540.08379748611, 23708.877962984647, 23720.762792371854, 24122.75877241205, 24262.75737242605, 24351.904164312295], "value": 17104.188475715353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.9202797482468, 446.1901648507959, 448.6231565484992, 455.37386094120586, 456.59135074108696, 19654.803451965476, 20799.0, 21391.786082139173, 21645.350639480803, 21715.239966601173, 21179.364619061413, 21269.149234030658, 21290.46773830655, 21481.026010188125, 21500.247491337806, 5734.397888221729, 5947.286325640929, 5949.077892926603, 5953.285605727318, 5956.19591355168, 5662.17898404731, 5814.098814683731, 5864.618799778023, 5876.853078673024, 5880.470757631812, 5828.9417105828825, 5832.941670583282, 5841.094630332284, 5846.21076154718, 5846.298444186704, 5793.391693872146, 5945.940540594604, 5980.431858973434, 6006.579539432241, 6006.969965150146, 5384.488473595042, 5436.809711660112, 5447.046766815831, 5449.56403487724, 5478.753456094445, 24444.0, 24835.25494235176, 25079.122230721838, 25095.87452062746, 25391.873040634862, 2014.1920309354434, 2018.8990550472417, 2029.0666293505005, 2041.8876961767096, 2063.556335387899, 15121.621959451102, 15471.922640386838, 15709.685806283811, 15732.370705171894, 16076.839231607652, 1811.1668632429098, 1868.1313189366874, 1868.6262747450428, 1872.6816441205028, 1881.106474424651, 111493.44253278762, 111628.0, 111770.0, 114520.99999999917, 116695.0, 11801.763964720829, 12079.27524348542, 12146.45340959659, 12306.938465307616, 12365.690857728629, 17432.65134697299, 17440.476785696195, 17457.47627571175, 17457.912710436365, 17470.563235919202, 8143.348532117417, 8400.873986890201, 8483.957580212184, 8565.700200492953, 8574.271186949054, 7530.548167109991, 7642.159362470124, 7647.661659209616, 7797.337226335825, 7882.921170788333, 7584.393248540104, 7728.729494467667, 7794.259545343183, 7893.329067029252, 7905.960470197727, 2139.7753235910004, 2141.443224761573, 2146.7101941238047, 2169.1973969631335, 2369.289213236022, 979.9363041402286, 982.5922242269378, 991.3704797453524, 1001.5442973447064, 1023.5138309303021, 18150.45548633543, 19040.904795475933, 19303.4208973731, 19619.411417657495, 19788.802111978985, 1021.4841505039907, 1032.385730490357, 1036.1658864614058, 1037.5797801890246, 1041.2763129624989, 10161.898381016243, 10631.149508039338, 10724.463776811284, 10744.355338679705, 10775.16822140238, 593084.0, 596373.0, 610485.0, 621240.0, 628869.0, 98062.50968745111, 100941.49529252306, 105502.0, 105802.0, 108279.0, 1170.4381896689636, 1172.366921862202, 1173.8004539228352, 1180.9055275577932, 1195.6054502014488, 15640.934071384676, 16197.59506012359, 16441.91779041097, 16503.422380216634, 16554.58613534671, 46939.530604693515, 47016.52983470258, 47780.28329575129, 48058.75970620124, 48209.51790482191, 56088.71955640196, 58657.70671146617, 59260.70369648124, 59956.400435996824, 60023.0, 8389.286910612665, 8582.78543036429, 8626.439281446686, 8628.180322869317, 8671.696490622799, 12601.558945436866, 12748.872511274769, 12954.935225323814, 13333.866661333263, 13415.128016679275, 11719.238249513754, 11749.412529373669, 11855.58505452305, 11869.5845645402, 12021.579244726392, 11249.943750281196, 11369.602063927723, 11430.828537571777, 11592.6522204334, 11808.409579521162, 11945.0, 12299.446524906221, 12346.567870124503, 12431.191972521758, 12506.18709783861, 9055.773605659911, 9170.899492060995, 9445.008274131393, 9461.670457719638, 9626.95186524063, 11173.385463799568, 11329.490172942402, 11500.25248358854, 11689.88310116922, 11906.285622862655], "value": 9915.696028351847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1198.6703656494458, 1309.757694826457, 1366.3168415792104, 1374.3265799758121, 1392.0325373865162, 9032.322575806817, 10343.844842327362, 10639.57441702331, 10649.20130990177, 10651.946740266307, 10398.68803935883, 10488.423136727477, 10491.475426228697, 10495.73760655984, 10505.527251273692, 2006.3679940818595, 2374.7031621047367, 2407.723111842143, 2412.3004328744732, 2413.8793060347, 2108.2410332280365, 2316.9536609267802, 2384.9046038158453, 2391.5336509380677, 2397.9520409591796, 2325.697659304288, 2360.8701521416315, 2361.067378385537, 2368.431576421655, 2370.1704403458825, 2318.4783423729696, 2326.7440581536016, 2336.3224664847176, 2339.4970081432402, 2340.9348746320384, 2261.7172853393326, 2383.475635360235, 2385.1413491143176, 2387.057112440576, 2389.3668177932686, 10812.891871081267, 10889.83665245022, 10899.400532970683, 10904.727381815439, 10911.890881091167, 6123.112148738453, 6358.42774150324, 6365.1725275714325, 6373.808785736435, 6388.041793730931, 3622.8913132606062, 3727.1986522897437, 3946.309395855714, 3984.3425834737523, 3987.441758153861, 1355.8847497962686, 1395.9511417100352, 1400.5798260521804, 1424.8432672406027, 1470.573533675233, 16358.263878125514, 16387.262573184114, 16388.508344749676, 16430.260638271306, 16468.258928348252, 5483.725813709299, 5590.357108932525, 5601.803936862272, 5613.522850557748, 5653.378128405872, 13583.388747506386, 13594.796078058836, 13626.1143025703, 13631.795523067161, 13637.522686705917, 6432.903506447407, 6443.0, 6449.258335291502, 6455.386738259952, 6456.322086180978, 4835.129676658235, 4983.352164218629, 5653.180288858092, 5912.379200184005, 5965.910511342333, 4345.543717909637, 4370.409994650745, 4455.443069616298, 4459.531749166291, 4478.507364189936, 1347.6698208938872, 1382.5783136143573, 1388.1809732257814, 1389.5553422904572, 1389.6942672612008, 796.2117503671324, 808.292743849132, 810.9878351824727, 813.1989989859983, 822.6051495282298, 5917.082852157836, 6035.607685500516, 6045.21412216409, 6166.907496387557, 6294.0558916162945, 909.1499448015994, 921.9858156028449, 924.4037595750704, 924.7965447601651, 926.2127191886842, 3862.9613703863165, 3873.4770805941403, 3878.991462219843, 3893.124047089439, 3926.823292951824, 14104.929475352557, 14526.782098268535, 14546.345414456375, 14554.0, 14589.781153282709, 14063.0, 14220.075695079786, 14250.216238106796, 14250.643733906529, 14290.57128286153, 9821.852672209923, 10231.590736370461, 10251.077403033763, 10257.230707696952, 10269.127124194378, 6956.686949087202, 7091.1490621125795, 7144.214136444883, 7152.356287934111, 7160.785176444715, 12863.22820630765, 13082.0, 13160.078794484294, 13243.337833108499, 13250.0, 12564.0, 12663.303518306582, 12757.425915833624, 13008.414621341873, 13376.0, 8088.150744171778, 8325.54209518458, 8889.066648001866, 8984.640614375352, 9073.954630226806, 9936.900630993887, 10419.426931518536, 10446.0, 10449.68650940473, 10475.371477711362, 9169.587368568296, 9518.904810951803, 9641.37331073478, 9690.85463718059, 9852.704418867446, 9213.170814626716, 9320.114589114024, 9568.904310956801, 9591.856122158313, 9598.232141428809, 7763.534187948741, 7839.7256096038645, 7905.249001344863, 7920.405969552191, 7959.641816118173, 5780.306363236438, 5782.624129431573, 5806.390329015561, 6085.087236914498, 6115.908261375994, 5996.280446346466, 6073.392660734068, 6096.207493025879, 6175.505959523138, 6203.565750397429], "value": 5279.4829862641145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.22999598705957, 423.4008877438425, 426.7077052219228, 431.4240488947255, 433.3391577843786, 5544.722763861811, 5769.394213607574, 5769.798057068004, 5772.0, 5772.422757724231, 5650.237217975572, 5683.772649094031, 5687.2606561146995, 5720.0, 5730.226419433376, 4230.153969206163, 4338.84814031509, 4339.522652508222, 4342.913141737164, 4374.081442896995, 4353.738775673454, 4360.781960901958, 4362.19299429605, 4365.4106695596, 4372.803223854934, 4317.935230971538, 4340.589308474742, 4346.217680817452, 4347.326279382429, 4349.586789255031, 4128.545859955388, 4301.032267739764, 4347.0, 4350.195213885409, 4362.520122786491, 3785.413260944558, 3791.50710407648, 3792.431135329695, 3807.619238076198, 3811.1996480739076, 5559.166125081229, 5568.52667523261, 5573.136163894603, 5573.6098473106895, 5578.386377498472, 4947.431045429786, 5048.343715317022, 5049.293098966147, 5059.293278096237, 5094.490550944876, 5945.31628862682, 5946.910796338058, 5954.910676339859, 5972.192385129969, 5972.283326000907, 4195.538490766014, 4221.451211342536, 4227.556106608823, 4230.76730779807, 4230.809613567397, 6139.600925939844, 6297.716602752887, 6308.148399965991, 6313.905291420632, 6344.827586206897, 4364.476262848415, 4386.583274588909, 4389.4513185851765, 4393.868183954486, 4408.0, 4435.068635586498, 4438.977805111019, 4444.977775111104, 4449.755263460541, 4471.374007638933, 4992.72540010303, 5022.769421491758, 5073.315102461121, 5080.720560369141, 5100.183970564692, 6034.818955431344, 6035.124906888476, 6041.426064523863, 6042.274927008787, 6062.120992456157, 1506.8493150685063, 1547.6981988512357, 1558.2286768049887, 1561.500319897622, 1566.1386237569518, 1023.6673081248475, 1050.9737256568646, 1053.378506681062, 1059.1368035051407, 1071.325065208929, 5739.139129130664, 5743.966086104541, 5774.162746401832, 5780.739866706008, 5783.045797443375, 6217.844553886099, 6226.844328891723, 6243.37566243372, 6264.123022776815, 6265.65538895356, 5609.1305847593685, 5754.079347304411, 5768.884622307614, 5804.738786754606, 5855.0, 3261.249912520086, 3267.281198136406, 3283.4254005548933, 3289.5657213661716, 3300.864179029931, 6279.717412716439, 6332.746690132343, 6453.032045193165, 6468.514861385321, 6483.077737968555, 6029.517638588903, 6225.190725205694, 6269.711555282289, 6355.618662880242, 6357.364263573698, 6210.378962103844, 6252.5935814171935, 6257.43683068526, 6279.560430769893, 6372.55392122547, 6003.879922401615, 6195.81412557624, 6214.875702486015, 6227.844303892439, 6236.251649801871, 5783.768649253982, 5924.496417804535, 6089.51283897296, 6143.72353244114, 6164.630122192682, 6234.345393733593, 6360.823247699191, 6387.361263873576, 6392.648404337806, 6405.583637063576, 4405.603495685404, 4416.4258646375765, 4420.425344705168, 4429.800658970418, 4436.779885531505, 5958.404159584007, 6180.165677633462, 6210.391635513005, 6221.346758590464, 6231.875362492634, 6043.063325184604, 6061.363556826646, 6069.36271691466, 6075.27096748393, 6082.817515474543, 5792.420757924174, 5956.970215148896, 6094.268687757498, 6101.298350689727, 6126.356732543019, 6028.638281703112, 6029.8191054268445, 6043.576949613484, 6053.9091913622215, 6085.1785009023215, 6075.453209211192, 6105.55777688928, 6118.736067654818, 6139.631622102688, 6146.323904370605, 5638.64672478594, 5897.67562784051, 5931.8432905582995, 5944.821655350346, 5945.910811337747], "value": 4594.997678504838, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.7831767946135, 761.2881955371731, 768.2624680306905, 769.1001528211991, 787.5747096567853, 14964.5510634681, 15104.169270690109, 15141.621459463506, 15257.160856152921, 15366.923165384158, 14686.63283417915, 14954.476593319236, 14967.326470308835, 14989.0, 14997.62505937352, 800.2317774936068, 806.3226889412892, 820.1511435664089, 825.8637324841394, 841.4152164245852, 847.8516259654535, 852.9872051919226, 857.1985193843744, 857.4041041476177, 857.5240741388527, 891.777055736066, 898.3352319283748, 899.9145081217274, 905.0451773379083, 905.2576886952702, 898.3666515106834, 898.6180873128894, 898.847195976679, 899.0964081098487, 899.1143723432414, 654.1790053482896, 654.6203202142793, 655.3446553446554, 656.0061506817176, 656.5699466849221, 16170.595735106599, 16255.0, 16393.0, 17032.744508832253, 17056.232469538776, 15881.52355429339, 15918.0, 15978.920105399515, 16016.199190040568, 16502.83497165037, 12387.93806030973, 12388.442520086617, 12446.75106497874, 12548.937255313756, 13198.736025279537, 3151.306712523241, 3167.572377729, 3250.951235731466, 3323.7839540429795, 3324.036029551427, 83366.0, 83593.0, 84092.15907840905, 85166.57416712877, 87114.12885871188, 11809.704757381134, 11986.580469683693, 11989.478194155161, 12006.87993120075, 12094.69763255908, 24639.753602464105, 24872.0, 25038.749612504005, 25455.0, 25460.363490912874, 8121.918780812234, 8125.065617454068, 8129.79675508117, 8266.8346633067, 8275.0, 4087.05997620543, 4099.713020088565, 4116.279651061052, 4140.171965606891, 4223.72545784523, 4192.140611174702, 4205.074883525619, 4211.599898009746, 4237.63980061692, 4308.698391112592, 775.8913752074714, 796.1640277708383, 813.1949370123535, 814.0353680888167, 845.966161353539, 635.8124353315783, 639.1754636518931, 642.2004604267717, 646.4795839349275, 653.2487639214941, 9874.40753554789, 10303.845442318221, 10565.0, 10653.520591573399, 10898.291611045257, 615.6521565315583, 631.463256232199, 654.404491912367, 663.3300366629642, 668.4385116502161, 4814.181589129857, 4989.90020199594, 5041.571466425395, 5066.898662026812, 5070.974645126751, 58216.0, 70530.0, 78348.60825695835, 79651.20348796554, 83487.5825620868, 56078.0, 63891.680541596994, 73634.26365736382, 74905.0, 77448.22551774523, 64380.35619643837, 64869.0, 65251.67374163099, 65434.672826635564, 66916.66541667261, 10200.0819926207, 10675.786484270426, 10717.47632566344, 10736.463176841284, 10895.237333386587, 28786.568201476577, 29875.850620746758, 30140.397192055596, 30725.846370768002, 31619.0, 53283.0, 54262.0, 54640.453595463536, 54895.72552137214, 55705.0, 13905.582832515041, 13996.16023038621, 14016.088954217943, 14380.35288412003, 14807.259637018322, 15040.09203564408, 15240.923795380952, 15625.531234062997, 15827.0, 16037.0, 14389.352479138255, 14902.32939517746, 15086.471973480875, 15148.772768408262, 15578.766318505459, 14389.856101438852, 14489.203093829941, 14632.561023169323, 14922.253887305375, 15177.16525591059, 14245.928770356082, 14319.856801432268, 14405.495807646683, 14405.78391324152, 14784.186869721838, 10870.347779133277, 11337.716557086138, 11516.795118498047, 11581.82627260575, 12117.333546655018, 10068.797655415527, 10909.727256818325, 11109.555617775199, 11491.253068550517, 11569.479373428385], "value": 7440.748862195865, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1489.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 108.0, 108.0, 108.0, 109.0, 109.0, 108.0, 109.0, 109.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 117.0, 150.0, 120.0, 117.0, 122.0, 117.0, 143.0, 118.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 164.0, 161.0, 161.0, 164.0, 164.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 107.0, 76.0, 74.0, 74.0, 75.0, 91.0, 74.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 110.0, 83.0, 83.0, 82.0, 100.0, 83.0, 83.0, 109.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.8, "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, 55.0, 55.0, 56.0, 58.0, 57.0, 56.0, 58.0, 57.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 80.0, 78.0, 79.0, 80.0, 79.0, 81.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 127.0, 140.0, 126.0, 125.0, 124.0, 127.0, 126.0, 176.0, 126.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 177.0, 181.0, 179.0, 182.0, 179.0, 190.0, 173.0, 180.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 63.0, 65.0, 63.0], "value": 64.6, "unit": "score"}]}]} 07:32:42 INFO - Return code: 0 07:32:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:32:42 ERROR - # TBPL SUCCESS # 07:32:42 INFO - Running post-action listener: _resource_record_post_action 07:32:42 INFO - [mozharness: 2017-03-22 14:32:42.423857Z] Finished run-tests step (success) 07:32:42 INFO - Running post-run listener: _resource_record_post_run 07:32:42 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366469120; Read time: 44; Write time: 360468 07:32:42 INFO - TinderboxPrint: CPU usage
12.9% 07:32:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 44 07:32:42 INFO - TinderboxPrint: I/O write bytes / time
366,469,120 / 360,468 07:32:42 INFO - TinderboxPrint: CPU idle
8,311.0 (87.0%) 07:32:42 INFO - TinderboxPrint: CPU user
1,188.9 (12.5%) 07:32:42 INFO - TinderboxPrint: Swap in / out
0 / 0 07:32:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 111050752; Read time: 44; Write time: 137344 07:32:42 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 254410752; Read time: 0; Write time: 222956 07:32:43 INFO - Running post-run listener: _upload_blobber_files 07:32:43 INFO - Blob upload gear active. 07:32:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:32:43 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:32:43 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:32:43 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:32:43 INFO - (blobuploader) - INFO - Open directory for files ... 07:32:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:32:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:32:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:46 INFO - (blobuploader) - INFO - Done attempting. 07:32:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:32:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:32:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:47 INFO - (blobuploader) - INFO - Done attempting. 07:32:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:32:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:50 INFO - (blobuploader) - INFO - Done attempting. 07:32:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:32:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:51 INFO - (blobuploader) - INFO - Done attempting. 07:32:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:32:51 INFO - Return code: 0 07:32:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:32:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:32:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc4e0c0d9594349c1223acfc8a28605271d695cab7a51f985a85460dd9a3fda7b884791cf89ed6ad5412affe6ceea281a209da410ca89259e04b7387d2531a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fafc548a8daae594dbdd41afa9dc133c6ed5c5f158f13b752e4b4cf9f04bc757bdfce096d10a7754e81fbbc0962a6eb1f0fe3eaf608b846565130ae7429c8027", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bba808baa7ba3a0b14e2e013f9883edd5b98cef4b135f2acf2b14cb563da6214a0f33eda70f4821d7f4624e16f262fa0f5cd8db9ee019da1cc7ef254bf8fecee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17e7bfd31d6ac019897ca680f5e9a575053fa566e2ae366cbf9632553e97768621387e6a2c27e2dd9135125da9bb78ecaec2eff05bce983a615a23faa19b3aea"} 07:32:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:32:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:32:51 INFO - Contents: 07:32:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc4e0c0d9594349c1223acfc8a28605271d695cab7a51f985a85460dd9a3fda7b884791cf89ed6ad5412affe6ceea281a209da410ca89259e04b7387d2531a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fafc548a8daae594dbdd41afa9dc133c6ed5c5f158f13b752e4b4cf9f04bc757bdfce096d10a7754e81fbbc0962a6eb1f0fe3eaf608b846565130ae7429c8027", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bba808baa7ba3a0b14e2e013f9883edd5b98cef4b135f2acf2b14cb563da6214a0f33eda70f4821d7f4624e16f262fa0f5cd8db9ee019da1cc7ef254bf8fecee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17e7bfd31d6ac019897ca680f5e9a575053fa566e2ae366cbf9632553e97768621387e6a2c27e2dd9135125da9bb78ecaec2eff05bce983a615a23faa19b3aea"} 07:32:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:32:51 INFO - Copying logs to upload dir... 07:32:51 INFO - mkdir: /builds/slave/test/build/upload/logs 07:32:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.371618 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-22 07:32:50.547685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 07:32:50.551755) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc4e0c0d9594349c1223acfc8a28605271d695cab7a51f985a85460dd9a3fda7b884791cf89ed6ad5412affe6ceea281a209da410ca89259e04b7387d2531a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fafc548a8daae594dbdd41afa9dc133c6ed5c5f158f13b752e4b4cf9f04bc757bdfce096d10a7754e81fbbc0962a6eb1f0fe3eaf608b846565130ae7429c8027", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bba808baa7ba3a0b14e2e013f9883edd5b98cef4b135f2acf2b14cb563da6214a0f33eda70f4821d7f4624e16f262fa0f5cd8db9ee019da1cc7ef254bf8fecee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17e7bfd31d6ac019897ca680f5e9a575053fa566e2ae366cbf9632553e97768621387e6a2c27e2dd9135125da9bb78ecaec2eff05bce983a615a23faa19b3aea"} build_url:https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011486 build_url: 'https://queue.taskcluster.net/v1/task/QZB1CNfyTOivcMPA5YmfFw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cc4e0c0d9594349c1223acfc8a28605271d695cab7a51f985a85460dd9a3fda7b884791cf89ed6ad5412affe6ceea281a209da410ca89259e04b7387d2531a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fafc548a8daae594dbdd41afa9dc133c6ed5c5f158f13b752e4b4cf9f04bc757bdfce096d10a7754e81fbbc0962a6eb1f0fe3eaf608b846565130ae7429c8027", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bba808baa7ba3a0b14e2e013f9883edd5b98cef4b135f2acf2b14cb563da6214a0f33eda70f4821d7f4624e16f262fa0f5cd8db9ee019da1cc7ef254bf8fecee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17e7bfd31d6ac019897ca680f5e9a575053fa566e2ae366cbf9632553e97768621387e6a2c27e2dd9135125da9bb78ecaec2eff05bce983a615a23faa19b3aea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 07:32:50.577228) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:32:50.577573) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1490191575.441834-425673022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:32:50.660094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 07:32:50.660423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 07:32:50.660725) ========= ========= Total master_lag: 0.15 =========