builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1494372165.61 results: success (0) revision: 2b6f6881a24a726364054aa69031927e2f3fc5fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:45.608999) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:45.609441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:45.609712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:45.624909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:45.625199) ========= 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=920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-09 16:22:45-- 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% 225M=0s 2017-05-09 16:22:46 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.261784 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:45.901348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:45.901698) ========= 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=920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020774 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:45.951557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:45.951896) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2b6f6881a24a726364054aa69031927e2f3fc5fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 2b6f6881a24a726364054aa69031927e2f3fc5fa --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-09 16:22:46,362 truncating revision to first 12 chars 2017-05-09 16:22:46,362 Setting DEBUG logging. 2017-05-09 16:22:46,362 attempt 1/10 2017-05-09 16:22:46,362 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2b6f6881a24a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 16:22:46,812 unpacking tar archive at: mozilla-central-2b6f6881a24a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.748102 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:46.716622) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:46.716952) ========= script_repo_revision: 2b6f6881a24a726364054aa69031927e2f3fc5fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:46.717331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:46.717608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 16:22:46.729140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-09 16:22:46.729414) ========= /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=920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:22:47 INFO - MultiFileLogger online at 20170509 16:22:47 in /builds/slave/test 16:22:47 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 16:22:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:22:47 INFO - {'append_to_log': False, 16:22:47 INFO - 'base_work_dir': '/builds/slave/test', 16:22:47 INFO - 'blob_upload_branch': 'Firefox', 16:22:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:22:47 INFO - 'branch': 'Firefox', 16:22:47 INFO - 'buildbot_json_path': 'buildprops.json', 16:22:47 INFO - 'config_files': ('talos/linux_config.py',), 16:22:47 INFO - 'default_actions': ('clobber', 16:22:47 INFO - 'read-buildbot-config', 16:22:47 INFO - 'download-and-extract', 16:22:47 INFO - 'populate-webroot', 16:22:47 INFO - 'create-virtualenv', 16:22:47 INFO - 'install', 16:22:47 INFO - 'run-tests'), 16:22:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:22:47 INFO - 'download_minidump_stackwalk': True, 16:22:47 INFO - 'download_symbols': 'ondemand', 16:22:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:22:47 INFO - 'tooltool.py': '/tools/tooltool.py', 16:22:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:22:47 INFO - '/tools/misc-python/virtualenv.py')}, 16:22:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:22:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:22:47 INFO - 'gecko_profile': False, 16:22:47 INFO - 'gecko_profile_interval': 0, 16:22:47 INFO - 'installer_path': 'installer.exe', 16:22:47 INFO - 'log_level': 'info', 16:22:47 INFO - 'log_name': 'talos', 16:22:47 INFO - 'log_to_console': True, 16:22:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:22:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:22:47 INFO - 'opt_config_files': (), 16:22:47 INFO - 'pip_index': False, 16:22:47 INFO - 'suite': 'dromaeojs', 16:22:47 INFO - 'system_bits': '32', 16:22:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:22:47 INFO - 'title': 'talos-linux64-ix-053', 16:22:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:22:47 INFO - 'use_talos_json': True, 16:22:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:22:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:22:47 INFO - 'work_dir': 'build'} 16:22:47 INFO - [mozharness: 2017-05-09 23:22:47.239035Z] Running clobber step. 16:22:47 INFO - Running pre-action listener: _resource_record_pre_action 16:22:47 INFO - Running main action method: clobber 16:22:47 INFO - rmtree: /builds/slave/test/build 16:22:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:22:48 INFO - Running post-action listener: _resource_record_post_action 16:22:48 INFO - [mozharness: 2017-05-09 23:22:48.186935Z] Finished clobber step (success) 16:22:48 INFO - [mozharness: 2017-05-09 23:22:48.187035Z] Running read-buildbot-config step. 16:22:48 INFO - Running pre-action listener: _resource_record_pre_action 16:22:48 INFO - Running main action method: read_buildbot_config 16:22:48 INFO - Using buildbot properties: 16:22:48 INFO - { 16:22:48 INFO - "project": "", 16:22:48 INFO - "product": "firefox", 16:22:48 INFO - "who": "kwierso@gmail.com", 16:22:48 INFO - "installer_path": "public/build/target.tar.bz2", 16:22:48 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 16:22:48 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:22:48 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 16:22:48 INFO - "stage_platform": "linux64-stylo", 16:22:48 INFO - "basedir": "/builds/slave/test", 16:22:48 INFO - "buildnumber": 73, 16:22:48 INFO - "platform": "ubuntu64_hw_stylo", 16:22:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:22:48 INFO - "slavebuilddir": "test", 16:22:48 INFO - "taskId": "Lt0NchEDSiGeCKbJGfGRlw", 16:22:48 INFO - "branch": "mozilla-central", 16:22:48 INFO - "script_repo_revision": "production", 16:22:48 INFO - "revision": "2b6f6881a24a726364054aa69031927e2f3fc5fa", 16:22:48 INFO - "slavename": "talos-linux64-ix-053", 16:22:48 INFO - "repo_path": "mozilla-central" 16:22:48 INFO - } 16:22:48 INFO - Finding installer, test and symbols from parent task. 16:22:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lt0NchEDSiGeCKbJGfGRlw'}, attempt #1 16:22:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lt0NchEDSiGeCKbJGfGRlw'}, attempt #1 16:22:49 INFO - Task dependencies: UddWIBvDQoK8diXReAZw7Q 16:22:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q'}, attempt #1 16:22:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.tar.bz2 16:22:49 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/test_packages.json 16:22:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.crashreporter-symbols.zip 16:22:49 INFO - Running post-action listener: _resource_record_post_action 16:22:49 INFO - [mozharness: 2017-05-09 23:22:49.563580Z] Finished read-buildbot-config step (success) 16:22:49 INFO - [mozharness: 2017-05-09 23:22:49.563798Z] Running download-and-extract step. 16:22:49 INFO - Running pre-action listener: _resource_record_pre_action 16:22:49 INFO - Running main action method: download_and_extract 16:22:49 INFO - mkdir: /builds/slave/test/build/tests 16:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:49 INFO - trying https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.test_packages.json 16:22:49 INFO - Downloading https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:22:50 INFO - Downloaded 986 bytes. 16:22:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:22:50 INFO - Using the following test package requirements: 16:22:50 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:22:50 INFO - u'common': [u'target.common.tests.zip'], 16:22:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:22:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:22:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:22:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:22:50 INFO - u'mozbase': [u'target.common.tests.zip'], 16:22:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:22:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:22:50 INFO - u'web-platform': [u'target.common.tests.zip', 16:22:50 INFO - u'target.web-platform.tests.zip'], 16:22:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:22:50 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:22:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.common.tests.zip 16:22:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:50 INFO - Fetch https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.common.tests.zip into memory 16:22:51 INFO - Content-Length response header: 58451569 16:22:51 INFO - Bytes received: 58451569 16:23:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:23:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.common.tests.zip 16:23:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:23:01 INFO - Fetch https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.common.tests.zip into memory 16:23:02 INFO - Content-Length response header: 58451569 16:23:02 INFO - Bytes received: 58451569 16:23:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.talos.tests.zip 16:23:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:23:12 INFO - Fetch https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.talos.tests.zip into memory 16:23:13 INFO - Content-Length response header: 14409362 16:23:13 INFO - Bytes received: 14409362 16:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:13 INFO - trying https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.tar.bz2 16:23:13 INFO - Downloading https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:23:14 INFO - Downloaded 64565994 bytes. 16:23:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.tar.bz2 16:23:14 INFO - mkdir: /builds/slave/test/properties 16:23:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:23:14 INFO - Writing to file /builds/slave/test/properties/build_url 16:23:14 INFO - Contents: 16:23:14 INFO - build_url:https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.tar.bz2 16:23:14 INFO - Running post-action listener: _resource_record_post_action 16:23:14 INFO - Running post-action listener: set_extra_try_arguments 16:23:14 INFO - [mozharness: 2017-05-09 23:23:14.928719Z] Finished download-and-extract step (success) 16:23:14 INFO - [mozharness: 2017-05-09 23:23:14.928816Z] Running populate-webroot step. 16:23:14 INFO - Running pre-action listener: _resource_record_pre_action 16:23:14 INFO - Running main action method: populate_webroot 16:23:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:23:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:23:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:23:14 INFO - '--tppagecycles', 16:23:14 INFO - '7'], 16:23:14 INFO - 'tests': ['tsvgm']}}, 16:23:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:23:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:23:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:23:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:23:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:23:14 INFO - 'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:23:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:23:14 INFO - 'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['damp', 'tps']}, 16:23:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:23:14 INFO - 'tests': ['damp', 'tps']}, 16:23:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['dromaeo_dom']}, 16:23:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:23:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:23:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:23:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['a11yr', 16:23:14 INFO - 'ts_paint', 16:23:14 INFO - 'tpaint', 16:23:14 INFO - 'sessionrestore', 16:23:14 INFO - 'sessionrestore_no_auto_restore', 16:23:14 INFO - 'tabpaint']}, 16:23:14 INFO - 'other-e10s': {'tests': ['a11yr', 16:23:14 INFO - 'ts_paint', 16:23:14 INFO - 'tpaint', 16:23:14 INFO - 'sessionrestore', 16:23:14 INFO - 'sessionrestore_no_auto_restore', 16:23:14 INFO - 'tabpaint']}, 16:23:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:23:14 INFO - 'ts_paint', 16:23:14 INFO - 'tpaint', 16:23:14 INFO - 'sessionrestore', 16:23:14 INFO - 'sessionrestore_no_auto_restore', 16:23:14 INFO - 'tabpaint']}, 16:23:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:23:14 INFO - 'ts_paint', 16:23:14 INFO - 'tpaint', 16:23:14 INFO - 'sessionrestore', 16:23:14 INFO - 'sessionrestore_no_auto_restore', 16:23:14 INFO - 'tabpaint']}, 16:23:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['a11yr', 16:23:14 INFO - 'ts_paint', 16:23:14 INFO - 'tpaint', 16:23:14 INFO - 'sessionrestore', 16:23:14 INFO - 'sessionrestore_no_auto_restore', 16:23:14 INFO - 'tabpaint']}, 16:23:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['a11yr', 16:23:14 INFO - 'ts_paint', 16:23:14 INFO - 'tpaint', 16:23:14 INFO - 'sessionrestore', 16:23:14 INFO - 'sessionrestore_no_auto_restore', 16:23:14 INFO - 'tabpaint']}, 16:23:14 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:23:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:23:14 INFO - 'bloom_basic_ref']}, 16:23:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['tsvgx', 16:23:14 INFO - 'tsvgr_opacity', 16:23:14 INFO - 'tart', 16:23:14 INFO - 'tscrollx', 16:23:14 INFO - 'cart', 16:23:14 INFO - 'tsvg_static']}, 16:23:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:23:14 INFO - 'tsvgr_opacity', 16:23:14 INFO - 'tart', 16:23:14 INFO - 'tscrollx', 16:23:14 INFO - 'cart', 16:23:14 INFO - 'tsvg_static']}, 16:23:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:23:14 INFO - 'talos_options': ['--disable-e10s'], 16:23:14 INFO - 'tests': ['tp5o']}, 16:23:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:23:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:23:14 INFO - 'talos_options': ['--disable-e10s', 16:23:14 INFO - '--xperf_path', 16:23:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:14 INFO - 'tests': ['tp5n']}, 16:23:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:23:14 INFO - 'talos_options': ['--xperf_path', 16:23:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:14 INFO - 'tests': ['tp5n']}}, 16:23:14 INFO - 'talos.zip': {'path': '', 16:23:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:23:14 INFO - Running post-action listener: _resource_record_post_action 16:23:14 INFO - [mozharness: 2017-05-09 23:23:14.942346Z] Finished populate-webroot step (success) 16:23:14 INFO - [mozharness: 2017-05-09 23:23:14.942434Z] Running create-virtualenv step. 16:23:14 INFO - Running pre-action listener: _resource_record_pre_action 16:23:14 INFO - Running main action method: create_virtualenv 16:23:14 INFO - Creating virtualenv /builds/slave/test/build/venv 16:23:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:23:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:23:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:23:15 INFO - Using real prefix '/usr' 16:23:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:23:15 INFO - Installing distribute.............................................................................................................................................................................................done. 16:23:17 INFO - Installing pip.................done. 16:23:17 INFO - Return code: 0 16:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:23:17 INFO - Reading from file tmpfile_stdout 16:23:17 INFO - Output received: 16:23:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:23:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:17 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 0xff41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1366770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, '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': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:23:17 INFO - Using env: {'DISPLAY': ':0', 16:23:17 INFO - 'HOME': '/home/cltbld', 16:23:17 INFO - 'LANG': 'en_US.UTF-8', 16:23:17 INFO - 'LANGUAGE': 'en_US:en', 16:23:17 INFO - 'LOGNAME': 'cltbld', 16:23:17 INFO - 'MAIL': '/var/mail/cltbld', 16:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:17 INFO - 'MOZ_NO_REMOTE': '1', 16:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:17 INFO - 'NO_EM_RESTART': '1', 16:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:17 INFO - 'PWD': '/builds/slave/test', 16:23:17 INFO - 'SHELL': '/bin/bash', 16:23:17 INFO - 'SHLVL': '1', 16:23:17 INFO - 'TERM': 'linux', 16:23:17 INFO - 'TMOUT': '86400', 16:23:17 INFO - 'USER': 'cltbld', 16:23:17 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:17 INFO - '_': '/tools/buildbot/bin/python'} 16:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:23:17 INFO - Cleaning up... 16:23:17 INFO - Return code: 0 16:23:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:17 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 0xff41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1366770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, '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': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:23:17 INFO - Using env: {'DISPLAY': ':0', 16:23:17 INFO - 'HOME': '/home/cltbld', 16:23:17 INFO - 'LANG': 'en_US.UTF-8', 16:23:17 INFO - 'LANGUAGE': 'en_US:en', 16:23:17 INFO - 'LOGNAME': 'cltbld', 16:23:17 INFO - 'MAIL': '/var/mail/cltbld', 16:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:17 INFO - 'MOZ_NO_REMOTE': '1', 16:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:17 INFO - 'NO_EM_RESTART': '1', 16:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:17 INFO - 'PWD': '/builds/slave/test', 16:23:17 INFO - 'SHELL': '/bin/bash', 16:23:17 INFO - 'SHLVL': '1', 16:23:17 INFO - 'TERM': 'linux', 16:23:17 INFO - 'TMOUT': '86400', 16:23:17 INFO - 'USER': 'cltbld', 16:23:17 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:17 INFO - '_': '/tools/buildbot/bin/python'} 16:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:18 INFO - Downloading/unpacking psutil>=3.1.1 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:19 INFO - Installing collected packages: psutil 16:23:19 INFO - Running setup.py install for psutil 16:23:19 INFO - building 'psutil._psutil_linux' extension 16:23:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:23:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:23:19 INFO - building 'psutil._psutil_posix' extension 16:23:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:23:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:19 INFO - Successfully installed psutil 16:23:19 INFO - Cleaning up... 16:23:19 INFO - Return code: 0 16:23:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:19 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 0xff41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1366770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, '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': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:23:19 INFO - Using env: {'DISPLAY': ':0', 16:23:19 INFO - 'HOME': '/home/cltbld', 16:23:19 INFO - 'LANG': 'en_US.UTF-8', 16:23:19 INFO - 'LANGUAGE': 'en_US:en', 16:23:19 INFO - 'LOGNAME': 'cltbld', 16:23:19 INFO - 'MAIL': '/var/mail/cltbld', 16:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:19 INFO - 'MOZ_NO_REMOTE': '1', 16:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:19 INFO - 'NO_EM_RESTART': '1', 16:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:19 INFO - 'PWD': '/builds/slave/test', 16:23:19 INFO - 'SHELL': '/bin/bash', 16:23:19 INFO - 'SHLVL': '1', 16:23:19 INFO - 'TERM': 'linux', 16:23:19 INFO - 'TMOUT': '86400', 16:23:19 INFO - 'USER': 'cltbld', 16:23:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:19 INFO - '_': '/tools/buildbot/bin/python'} 16:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:23:21 INFO - Installing collected packages: mozsystemmonitor 16:23:21 INFO - Running setup.py install for mozsystemmonitor 16:23:21 INFO - Successfully installed mozsystemmonitor 16:23:21 INFO - Cleaning up... 16:23:21 INFO - Return code: 0 16:23:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xff41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1366770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, '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': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:23:21 INFO - Using env: {'DISPLAY': ':0', 16:23:21 INFO - 'HOME': '/home/cltbld', 16:23:21 INFO - 'LANG': 'en_US.UTF-8', 16:23:21 INFO - 'LANGUAGE': 'en_US:en', 16:23:21 INFO - 'LOGNAME': 'cltbld', 16:23:21 INFO - 'MAIL': '/var/mail/cltbld', 16:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:21 INFO - 'MOZ_NO_REMOTE': '1', 16:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:21 INFO - 'NO_EM_RESTART': '1', 16:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:21 INFO - 'PWD': '/builds/slave/test', 16:23:21 INFO - 'SHELL': '/bin/bash', 16:23:21 INFO - 'SHLVL': '1', 16:23:21 INFO - 'TERM': 'linux', 16:23:21 INFO - 'TMOUT': '86400', 16:23:21 INFO - 'USER': 'cltbld', 16:23:21 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:21 INFO - '_': '/tools/buildbot/bin/python'} 16:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:21 INFO - Downloading/unpacking jsonschema==2.5.1 16:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:23:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:22 INFO - Downloading functools32-3.2.3-2.tar.gz 16:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:23:22 INFO - warning: no files found matching '*.txt' 16:23:22 INFO - no previously-included directories found matching 'build' 16:23:22 INFO - no previously-included directories found matching 'dist' 16:23:22 INFO - no previously-included directories found matching '.git*' 16:23:22 INFO - Installing collected packages: jsonschema, functools32 16:23:23 INFO - Running setup.py install for functools32 16:23:23 INFO - warning: no files found matching '*.txt' 16:23:23 INFO - no previously-included directories found matching 'build' 16:23:23 INFO - no previously-included directories found matching 'dist' 16:23:23 INFO - no previously-included directories found matching '.git*' 16:23:23 INFO - Successfully installed jsonschema functools32 16:23:23 INFO - Cleaning up... 16:23:23 INFO - Return code: 0 16:23:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:23 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 0xff41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1366770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, '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': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:23:23 INFO - Using env: {'DISPLAY': ':0', 16:23:23 INFO - 'HOME': '/home/cltbld', 16:23:23 INFO - 'LANG': 'en_US.UTF-8', 16:23:23 INFO - 'LANGUAGE': 'en_US:en', 16:23:23 INFO - 'LOGNAME': 'cltbld', 16:23:23 INFO - 'MAIL': '/var/mail/cltbld', 16:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:23 INFO - 'MOZ_NO_REMOTE': '1', 16:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:23 INFO - 'NO_EM_RESTART': '1', 16:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:23 INFO - 'PWD': '/builds/slave/test', 16:23:23 INFO - 'SHELL': '/bin/bash', 16:23:23 INFO - 'SHLVL': '1', 16:23:23 INFO - 'TERM': 'linux', 16:23:23 INFO - 'TMOUT': '86400', 16:23:23 INFO - 'USER': 'cltbld', 16:23:23 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:23 INFO - '_': '/tools/buildbot/bin/python'} 16:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:23:23 INFO - Cleaning up... 16:23:23 INFO - Return code: 0 16:23:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:23 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 0xff41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1366770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, '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': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:23:23 INFO - Using env: {'DISPLAY': ':0', 16:23:23 INFO - 'HOME': '/home/cltbld', 16:23:23 INFO - 'LANG': 'en_US.UTF-8', 16:23:23 INFO - 'LANGUAGE': 'en_US:en', 16:23:23 INFO - 'LOGNAME': 'cltbld', 16:23:23 INFO - 'MAIL': '/var/mail/cltbld', 16:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:23 INFO - 'MOZ_NO_REMOTE': '1', 16:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:23 INFO - 'NO_EM_RESTART': '1', 16:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:23 INFO - 'PWD': '/builds/slave/test', 16:23:23 INFO - 'SHELL': '/bin/bash', 16:23:23 INFO - 'SHLVL': '1', 16:23:23 INFO - 'TERM': 'linux', 16:23:23 INFO - 'TMOUT': '86400', 16:23:23 INFO - 'USER': 'cltbld', 16:23:23 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:23 INFO - '_': '/tools/buildbot/bin/python'} 16:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:23 INFO - Downloading/unpacking blobuploader==1.2.4 16:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:24 INFO - Downloading blobuploader-1.2.4.tar.gz 16:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:23:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:23:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:23: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 16:23: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 16:23: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 16:23: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 16:23: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 16:23: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 16:23:25 INFO - Downloading docopt-0.6.1.tar.gz 16:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:23:25 INFO - Installing collected packages: blobuploader, requests, docopt 16:23:25 INFO - Running setup.py install for blobuploader 16:23:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:23:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:23:25 INFO - Running setup.py install for requests 16:23:25 INFO - Running setup.py install for docopt 16:23:25 INFO - Successfully installed blobuploader requests docopt 16:23:25 INFO - Cleaning up... 16:23:25 INFO - Return code: 0 16:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23: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')]} 16:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23: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')]} 16:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:25 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 0xff41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1366770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, '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': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:23:25 INFO - Using env: {'DISPLAY': ':0', 16:23:25 INFO - 'HOME': '/home/cltbld', 16:23:25 INFO - 'LANG': 'en_US.UTF-8', 16:23:25 INFO - 'LANGUAGE': 'en_US:en', 16:23:25 INFO - 'LOGNAME': 'cltbld', 16:23:25 INFO - 'MAIL': '/var/mail/cltbld', 16:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:25 INFO - 'MOZ_NO_REMOTE': '1', 16:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:25 INFO - 'NO_EM_RESTART': '1', 16:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:25 INFO - 'PWD': '/builds/slave/test', 16:23:25 INFO - 'SHELL': '/bin/bash', 16:23:25 INFO - 'SHLVL': '1', 16:23:25 INFO - 'TERM': 'linux', 16:23:25 INFO - 'TMOUT': '86400', 16:23:25 INFO - 'USER': 'cltbld', 16:23:25 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:25 INFO - '_': '/tools/buildbot/bin/python'} 16:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:26 INFO - Running setup.py (path:/tmp/pip-VhVzIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:26 INFO - Running setup.py (path:/tmp/pip-5vvIol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:26 INFO - Running setup.py (path:/tmp/pip-AnTTZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:26 INFO - Running setup.py (path:/tmp/pip-Bx884X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:26 INFO - Running setup.py (path:/tmp/pip-e4eGDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:26 INFO - Running setup.py (path:/tmp/pip-ZO1bgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:26 INFO - Running setup.py (path:/tmp/pip-El91l6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:26 INFO - Running setup.py (path:/tmp/pip-jd54sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:26 INFO - Running setup.py (path:/tmp/pip-uEDdaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:26 INFO - Running setup.py (path:/tmp/pip-Ufi7q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:26 INFO - Running setup.py (path:/tmp/pip-gldfa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:26 INFO - Running setup.py (path:/tmp/pip-Zoo73S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:27 INFO - Running setup.py (path:/tmp/pip-yFsEV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:27 INFO - Running setup.py (path:/tmp/pip-v8Y6dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:27 INFO - Running setup.py (path:/tmp/pip-NMiK_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:27 INFO - Running setup.py (path:/tmp/pip-VjRXZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:27 INFO - Running setup.py (path:/tmp/pip-mm9IWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:23:27 INFO - Running setup.py install for manifestparser 16:23:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Running setup.py install for mozcrash 16:23:27 INFO - Running setup.py install for mozdebug 16:23:27 INFO - Running setup.py install for mozdevice 16:23:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Running setup.py install for mozfile 16:23:27 INFO - Running setup.py install for mozhttpd 16:23:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Running setup.py install for mozinfo 16:23:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Running setup.py install for mozInstall 16:23:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Running setup.py install for mozleak 16:23:28 INFO - Running setup.py install for mozlog 16:23:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Running setup.py install for moznetwork 16:23:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Running setup.py install for mozprocess 16:23:28 INFO - Running setup.py install for mozprofile 16:23:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Running setup.py install for mozrunner 16:23:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Running setup.py install for mozscreenshot 16:23:28 INFO - Running setup.py install for moztest 16:23:29 INFO - Running setup.py install for mozversion 16:23:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:23:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:23:29 INFO - Cleaning up... 16:23:29 INFO - Return code: 0 16:23:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:29 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 0xff41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1366770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, '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': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:23:29 INFO - Using env: {'DISPLAY': ':0', 16:23:29 INFO - 'HOME': '/home/cltbld', 16:23:29 INFO - 'LANG': 'en_US.UTF-8', 16:23:29 INFO - 'LANGUAGE': 'en_US:en', 16:23:29 INFO - 'LOGNAME': 'cltbld', 16:23:29 INFO - 'MAIL': '/var/mail/cltbld', 16:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:29 INFO - 'MOZ_NO_REMOTE': '1', 16:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:29 INFO - 'NO_EM_RESTART': '1', 16:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:29 INFO - 'PWD': '/builds/slave/test', 16:23:29 INFO - 'SHELL': '/bin/bash', 16:23:29 INFO - 'SHLVL': '1', 16:23:29 INFO - 'TERM': 'linux', 16:23:29 INFO - 'TMOUT': '86400', 16:23:29 INFO - 'USER': 'cltbld', 16:23:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:29 INFO - '_': '/tools/buildbot/bin/python'} 16:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:29 INFO - Running setup.py (path:/tmp/pip-YBh9Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:29 INFO - Running setup.py (path:/tmp/pip-ChvQYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:29 INFO - Running setup.py (path:/tmp/pip-v2wGii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:29 INFO - Running setup.py (path:/tmp/pip-dv3CFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:29 INFO - Running setup.py (path:/tmp/pip-yVjw4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:29 INFO - Running setup.py (path:/tmp/pip-HDn_95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:29 INFO - Running setup.py (path:/tmp/pip-AftmRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:29 INFO - Running setup.py (path:/tmp/pip-y8r7OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:30 INFO - Running setup.py (path:/tmp/pip-rMEQPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:30 INFO - Running setup.py (path:/tmp/pip-6VbuJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:30 INFO - Running setup.py (path:/tmp/pip-xPP60V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:30 INFO - Running setup.py (path:/tmp/pip-FEuo1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:30 INFO - Running setup.py (path:/tmp/pip-clL0R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:30 INFO - Running setup.py (path:/tmp/pip-iiEEzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:30 INFO - Running setup.py (path:/tmp/pip-F9yiZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:30 INFO - Running setup.py (path:/tmp/pip-1b8NVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:30 INFO - Running setup.py (path:/tmp/pip-HaeIOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:23:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:31 INFO - Downloading blessings-1.6.tar.gz 16:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:23:31 INFO - Installing collected packages: blessings 16:23:31 INFO - Running setup.py install for blessings 16:23:32 INFO - Successfully installed blessings 16:23:32 INFO - Cleaning up... 16:23:32 INFO - Return code: 0 16:23:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:32 INFO - Reading from file tmpfile_stdout 16:23:32 INFO - Current package versions: 16:23:32 INFO - argparse == 1.2.1 16:23:32 INFO - blessings == 1.6 16:23:32 INFO - blobuploader == 1.2.4 16:23:32 INFO - docopt == 0.6.1 16:23:32 INFO - functools32 == 3.2.3-2 16:23:32 INFO - jsonschema == 2.5.1 16:23:32 INFO - manifestparser == 1.1 16:23:32 INFO - mozInstall == 1.12 16:23:32 INFO - mozcrash == 1.0 16:23:32 INFO - mozdebug == 0.1 16:23:32 INFO - mozdevice == 0.50 16:23:32 INFO - mozfile == 1.2 16:23:32 INFO - mozhttpd == 0.7 16:23:32 INFO - mozinfo == 0.9 16:23:32 INFO - mozleak == 0.1 16:23:32 INFO - mozlog == 3.4 16:23:32 INFO - moznetwork == 0.27 16:23:32 INFO - mozprocess == 0.25 16:23:32 INFO - mozprofile == 0.28 16:23:32 INFO - mozrunner == 6.13 16:23:32 INFO - mozscreenshot == 0.1 16:23:32 INFO - mozsystemmonitor == 0.3 16:23:32 INFO - moztest == 0.8 16:23:32 INFO - mozversion == 1.4 16:23:32 INFO - psutil == 3.1.1 16:23:32 INFO - requests == 1.2.3 16:23:32 INFO - wsgiref == 0.1.2 16:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:32 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 0xff41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1366770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, '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': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:23:32 INFO - Using env: {'DISPLAY': ':0', 16:23:32 INFO - 'HOME': '/home/cltbld', 16:23:32 INFO - 'LANG': 'en_US.UTF-8', 16:23:32 INFO - 'LANGUAGE': 'en_US:en', 16:23:32 INFO - 'LOGNAME': 'cltbld', 16:23:32 INFO - 'MAIL': '/var/mail/cltbld', 16:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:32 INFO - 'MOZ_NO_REMOTE': '1', 16:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:32 INFO - 'NO_EM_RESTART': '1', 16:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:32 INFO - 'PWD': '/builds/slave/test', 16:23:32 INFO - 'SHELL': '/bin/bash', 16:23:32 INFO - 'SHLVL': '1', 16:23:32 INFO - 'TERM': 'linux', 16:23:32 INFO - 'TMOUT': '86400', 16:23:32 INFO - 'USER': 'cltbld', 16:23:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:32 INFO - '_': '/tools/buildbot/bin/python'} 16:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:23:32 INFO - Cleaning up... 16:23:32 INFO - Return code: 0 16:23:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:32 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 0xff41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1366770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, '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': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:23:32 INFO - Using env: {'DISPLAY': ':0', 16:23:32 INFO - 'HOME': '/home/cltbld', 16:23:32 INFO - 'LANG': 'en_US.UTF-8', 16:23:32 INFO - 'LANGUAGE': 'en_US:en', 16:23:32 INFO - 'LOGNAME': 'cltbld', 16:23:32 INFO - 'MAIL': '/var/mail/cltbld', 16:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:32 INFO - 'MOZ_NO_REMOTE': '1', 16:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:32 INFO - 'NO_EM_RESTART': '1', 16:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:32 INFO - 'PWD': '/builds/slave/test', 16:23:32 INFO - 'SHELL': '/bin/bash', 16:23:32 INFO - 'SHLVL': '1', 16:23:32 INFO - 'TERM': 'linux', 16:23:32 INFO - 'TMOUT': '86400', 16:23:32 INFO - 'USER': 'cltbld', 16:23:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:32 INFO - '_': '/tools/buildbot/bin/python'} 16:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:23:32 INFO - Cleaning up... 16:23:32 INFO - Return code: 0 16:23:32 INFO - Running post-action listener: _resource_record_post_action 16:23:32 INFO - Running post-action listener: _start_resource_monitoring 16:23:32 INFO - Starting resource monitoring. 16:23:32 INFO - [mozharness: 2017-05-09 23:23:32.776383Z] Finished create-virtualenv step (success) 16:23:32 INFO - [mozharness: 2017-05-09 23:23:32.776851Z] Running install step. 16:23:32 INFO - Running pre-action listener: _resource_record_pre_action 16:23:32 INFO - Running main action method: install 16:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:32 INFO - Reading from file tmpfile_stdout 16:23:32 INFO - Detecting whether we're running mozinstall >=1.0... 16:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:23:33 INFO - Reading from file tmpfile_stdout 16:23:33 INFO - Output received: 16:23:33 INFO - Usage: mozinstall [options] installer 16:23:33 INFO - Options: 16:23:33 INFO - -h, --help show this help message and exit 16:23:33 INFO - -d DEST, --destination=DEST 16:23:33 INFO - Directory to install application into. [default: 16:23:33 INFO - "/builds/slave/test"] 16:23:33 INFO - --app=APP Application being installed. [default: firefox] 16:23:33 INFO - mkdir: /builds/slave/test/build/application 16:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:23:49 INFO - Reading from file tmpfile_stdout 16:23:49 INFO - Output received: 16:23:49 INFO - /builds/slave/test/build/application/firefox/firefox 16:23:49 INFO - Running post-action listener: _resource_record_post_action 16:23:49 INFO - [mozharness: 2017-05-09 23:23:49.231242Z] Finished install step (success) 16:23:49 INFO - [mozharness: 2017-05-09 23:23:49.231519Z] Running run-tests step. 16:23:49 INFO - Running pre-action listener: _resource_record_pre_action 16:23:49 INFO - Running main action method: run_tests 16:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:49 INFO - Python 2.7.3 16:23:49 INFO - Return code: 0 16:23:49 INFO - grabbing minidump binary from tooltool 16:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:49 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 0x1363a30>, '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 0x13647f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1364ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:23:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:23:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:23:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:49 INFO - Return code: 0 16:23:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:23:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:49 INFO - ENV: RUST_BACKTRACE is now 1 16:23:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:23:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:49 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/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 16:23:49 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/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 16:23:49 INFO - Using env: {'DISPLAY': ':0', 16:23:49 INFO - 'HOME': '/home/cltbld', 16:23:49 INFO - 'LANG': 'en_US.UTF-8', 16:23:49 INFO - 'LANGUAGE': 'en_US:en', 16:23:49 INFO - 'LOGNAME': 'cltbld', 16:23:49 INFO - 'MAIL': '/var/mail/cltbld', 16:23:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:49 INFO - 'MOZ_NO_REMOTE': '1', 16:23:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:49 INFO - 'NO_EM_RESTART': '1', 16:23:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:49 INFO - 'PWD': '/builds/slave/test', 16:23:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:49 INFO - 'RUST_BACKTRACE': '1', 16:23:49 INFO - 'SHELL': '/bin/bash', 16:23:49 INFO - 'SHLVL': '1', 16:23:49 INFO - 'TERM': 'linux', 16:23:49 INFO - 'TMOUT': '86400', 16:23:49 INFO - 'USER': 'cltbld', 16:23:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746', 16:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:49 INFO - '_': '/tools/buildbot/bin/python'} 16:23:49 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/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 16:23:49 INFO - mozversion application_buildid: 20170509204849 16:23:49 INFO - mozversion application_changeset: 2b6f6881a24a726364054aa69031927e2f3fc5fa 16:23:49 INFO - mozversion application_display_name: Nightly 16:23:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:49 INFO - mozversion application_name: Firefox 16:23:49 INFO - mozversion application_remotingname: firefox 16:23:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:23:49 INFO - mozversion application_vendor: Mozilla 16:23:49 INFO - mozversion application_version: 55.0a1 16:23:49 INFO - mozversion platform_buildid: 20170509204849 16:23:49 INFO - mozversion platform_changeset: 2b6f6881a24a726364054aa69031927e2f3fc5fa 16:23:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:23:49 INFO - mozversion platform_version: 55.0a1 16:23:49 INFO - using testdate: 1494372229 16:23:49 INFO - actual date: 1494372229 16:23:49 INFO - starting webserver on 'localhost:51920' 16:23:49 INFO - SUITE-START | Running 2 tests 16:23:49 INFO - TEST-START | dromaeo_css 16:23:49 INFO - operating with platform_type : linux_ 16:23:49 INFO - Initialising browser for dromaeo_css test... 16:23:49 INFO - TEST-INFO | started process 8626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptE6J8l/profile http://localhost:51920/getInfo.html) 16:23:53 INFO - PID 8626 | __metrics Screen width/height:1600/1200 16:23:53 INFO - PID 8626 | colorDepth:24 16:23:53 INFO - PID 8626 | Browser inner width/height: 1024/695 16:23:53 INFO - PID 8626 | __metrics 16:23:54 INFO - PID 8626 | 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" 16:23:54 INFO - PID 8626 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:23:55 INFO - TEST-INFO | 8626: exit 0 16:23:55 INFO - Browser initialized. 16:23:55 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:55 INFO - TEST-INFO | started process 8726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptE6J8l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:07 INFO - PID 8726 | RSS: Main: 162852864 16:24:07 INFO - PID 8726 | 16:27:13 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:51920/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51920/tests/dromaeo/cssquery-ext.html) 16:27:15 INFO - PID 8726 | RSS: Main: 302637056 16:27:15 INFO - PID 8726 | 16:30:17 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:51920/tests/dromaeo/cssquery-ext.html (next: http://localhost:51920/tests/dromaeo/cssquery-jquery.html) 16:30:18 INFO - PID 8726 | RSS: Main: 251981824 16:30:18 INFO - PID 8726 | 16:33:20 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:51920/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51920/tests/dromaeo/cssquery-mootools.html) 16:33:21 INFO - PID 8726 | RSS: Main: 199749632 16:33:21 INFO - PID 8726 | 16:36:23 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:51920/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51920/tests/dromaeo/cssquery-prototype.html) 16:36:23 INFO - PID 8726 | RSS: Main: 228704256 16:36:23 INFO - PID 8726 | 16:39:27 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:51920/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51920/tests/dromaeo/cssquery-yui.html) 16:39:27 INFO - PID 8726 | RSS: Main: 206929920 16:39:27 INFO - PID 8726 | 16:42:29 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:51920/tests/dromaeo/cssquery-yui.html (next: http://localhost:51920/tests/dromaeo/cssquery-dojo.html) 16:42:29 INFO - PID 8726 | RSS: Main: 293408768 16:42:29 INFO - PID 8726 | 16:42:29 INFO - PID 8726 | __start_tp_report 16:42:29 INFO - PID 8726 | _x_x_mozilla_page_load 16:42:29 INFO - PID 8726 | _x_x_mozilla_page_load_details 16:42:29 INFO - PID 8726 | |i|pagename|runs| 16:42:29 INFO - PID 8726 | |0;dojo.html;2693.703692593814;2717.415755612543;2755.7244275572443;2756.765674917631;2767.571026490894;5014.598832093433;5109.105906466372;5135.255387968742;5146.562542183914;5160.122779127548;5138.7173705446185;5158.638895277332;5183.144781111121;5189.740512974355;5236.8690782730455;4325.243082460573;4554.863354099366;4598.310253461991;4662.254039353704;4688.226442636961;4621.075784843045;4642.141203877293;4666.743329116897;4677.4387073551225;4689;4524.47968483622;4552.56750608695;4573.131105090022;4578.702384345041;4600.907981840378;4581.954180458186;4588.311753237042;4594.33382159585;4597.655175861791;4600.401947746805;4532.206863798822;4593.356930029799;4604.355390245369;4614.330922016289;4616.607588354994;5011.824586139468;5022.372203474566;5022.748862556858;5076.898462030776;5086;5541.5843811714285;5562.0978360786385;5564.387917329091;5566.66600003997;5618.7190640468225;5528.226048353234;5562.054450743383;5576.33084029915;5602.439756024406;5613.971930140364;5139.897202055975;5222.216667499905;5269.104252277122;5270.92093618596;5272.420033796279;5730.140478928194;5761.510271626875;5767.8558036049435;5781.53747700183;5784.1034639630925;5403.162509810985;5456.290682211366;5484.8354549363585;5485.232067510552;5549.139883318092;5583.246261754693;5590.8043218487155;5594.356648985337;5620.409856965041;5644.040513112781;5522.337319521683;5525.392206857243;5526.834194974157;5531.557475401958;5533.7786488540005;5336.733163341817;5426.810061647823;5502.862428439241;5530.585206109477;5581.3302403711;4550.772461376918;4552.3171524270965;4584.816607335736;4596.011857450664;4596.770161491912;3896.3765797472834;3909.315869722844;3915.784631845219;3956.5054368203973;3968.3452230381663;4691.155591993405;4741.691790033637;4745.715257084586;4762.690425122356;4784.234522476387;5571.721413929368;5633.352164501053;5647.435256474402;5676.8864622707315;5681.886362272731;4744.905101898012;4747.264174053027;4757.738324392191;4760.428748550127;4804.039192161582;4823.662343635911;4913.631477639191;4924.285978533164;4924.384451943507;4926.3349447824085;5123.410807757155;5225.137852254487;5277.155655095166;5283.920741188808;5283.947160528499;5581.302337207849;5656.038473459439;5663.207150998781;5665.943340566541;5677.063284558001;5264.894702106013;5275.366955965309;5278.208268759717;5278.4193738687945;5324.6006549508165;5439.156930675752;5465.672059676433;5515.696636685021;5569.693666848362;5577.414371491097;5619.072852979376;5653.491185793134;5658.20785090096;5660.943390566042;5690.430956904276;5323.281357016753;5423.267858839164;5425.969065877471;5467.152591348347;5480.04099282616;5356.732163391893;5427.782888684566;5473.425290344616;5477.616566840283;5481.260029896072;5321.920171197357;5330.0938840398;5332.840014799563;5346.652467589594;5350.785968561214;5268.604854635841;5453.318335208099;5458.9454105458435;5464.644798088111;5506.669599824023;5234.842954711365;5274.208868669731;5326.414094449685;5342.599305052059;5348.652337598043 16:42:29 INFO - PID 8726 | |1;ext.html;698.343557056367;750.40717832912;770.5954373953674;1069.0432063303344;1075.6826736112846;25830;32491.67508324916;33075.83462082686;33095;33234.845644294495;34983.82508087462;35348.64651353492;35383.82308088463;35411;35430.645693543054;5273.077211487994;6829.112215411989;6969.512134150612;6973.163220413558;6987.790366289019;5324.41431442541;6724.125863637721;6900.20647625522;6902.689378977958;6903.413209877166;6959.652017399135;6999.020137180799;7001.159860816709;7010.053642758214;7011.018457415966;5264.552513036397;6902.930970690279;6949.583025018515;6961.199462061877;6981.301869813004;5387.4073851876265;6577.440917522016;6849.452043836481;6872.965635171842;6876.621785801779;32520;33111;33144.66855331464;33148.50277245843;33185;3036.8481575921114;3079.1532328609587;3081.599392079038;3082.1215953453384;3083.753299736038;22082;22128.33614991553;22162.11351545936;22165.778342216694;22178;2772;2781.207355903558;2781.3741908070724;2783.5268004439295;2790.0513825299295;130602.99999999905;131086;131411;131591;131850;41634.79182604067;41755;41802.35668184817;41834.581654183676;41890.58109418928;43879;43965.34051989223;44016.3397549037;44171;44178;10925.672229833117;11113.777724445466;11115.444227788577;11140.777184456265;11141.2201145919;6981.82545436358;7098.787036388917;8659.610317535726;8684.913150868411;8685.785124793138;11873.525058997717;11973.221740586834;12150.878491215151;12194.75610487803;12242.755144897052;5023.296738456619;5056.064628043824;5076.593872490192;5168.2764412982215;5180.378354597397;892.5269607108243;932.3520153493257;936.9531523423938;942.1661829281136;971.8979507151789;21037.15851365959;21622.78377216239;21714.89142554277;21797.782022179894;22117.115315387528;1004.7889943112028;1004.9648262310784;1009.8939611340851;1036.0520124086377;1039.6361273554196;11037.558497660004;11319.320840749417;11362.602308919148;11537.48081336342;11697.883021169679;151719;152385;152412;152726.23636881966;153520.23239883952;40954.59045409508;40996.79501602473;40998;41063.794681026404;41202.58797412048;1243.185713357752;1296.0538806671184;1296.0538806671184;1300.635821969831;1301.5965050834272;19707.408777736116;19800.90099549493;19809.40571782849;21473.46316342104;21639.675404869253;30503.847480762455;30581.08256752301;30602.234944126576;30661.23346916345;30677.233069172555;143561;143565;143865;143893;144348;28626.85686571637;28877.56683649789;28986.565201522415;29698.703012969592;29955.700442996163;36433.27133457369;36467.817660911525;36546.45180322351;36567.63432365749;37023.62976370202;25720.87139564365;27382.178534643994;27873.721262787112;28365.574516381857;28781;26741.732582673925;27770.72229277762;27993.02024429135;28065.71934280631;28775.71662755338;30902;30972.845135774176;31164.376712466077;32299.192520186243;32780.18049548685;27289.31776705598;27357.72642273552;27662;27852.721472785823;28742.20971667588;21507.784922151204;22618.660720088883;22635.773642264026;22689.886550567142;22712.432189195402 16:42:29 INFO - PID 8726 | |2;jquery.html;392.64073372863834;415.74016239850096;417.82451370424417;430.97414155150693;440.79503031090536;11900.46447909844;13582.524611638595;17690.557736056606;17886.195121219545;18167.636647267063;18702.90648546759;19071;19102;19177.904110479427;19185.52036199096;4445.377647129389;5295.602829787762;5508.20131080993;5512.751926163332;5514.889702205954;5324.893502129955;5347.572194224472;5399.325084364455;5399.379071406799;5400.540954018894;5318.175682769177;5382.165764306539;5384.138537833947;5384.730763461831;5390.272313237721;5172.767225474844;5357.330333708286;5360.571154307646;5362.973185134068;5376.569874410077;4711.623070154379;4865.537773911473;4899.608031357483;4900.58345040672;4900.926486102711;21742;21800.672989905164;22213.555728885494;22402.439939001655;22684.432889177737;1621.9432319868747;1654.710425675502;1655.180685560655;1655.925483353252;1656;13992.720145597134;14258.857411425857;15100;15203.467878624195;15207.923960380238;2079.170330109509;2110.915563377463;2122.681597760333;2127.8297736181066;2128.8935553222277;67418.9999999995;87430.25139497174;88200.55899720524;90185;90705.54647226722;10432.530536125892;10721.195910306758;10852.240343175901;10945.83581246282;10959.232853700323;15413;15592.454264100703;15598.142102184262;15609.297581608855;15625.531234062997;7712.9614351927885;7718.614069296513;7770.689172433153;8014.599270036475;8049.235322644339;7285.380742636829;7287.890681639779;7318.560886346836;7487.588182649898;7494.5128566643;6845.349691779273;6996.580205187705;7086.822829429306;7089.92910070903;7131.679074441663;1971.6253911756721;2021.3935819254166;2025.9594808103755;2029.0869108901054;2157.6448622392018;868.1492137705085;896.7264984179757;898.2185498616245;907.5371560504191;918.1140199707314;17057.48827535176;17093.487195384158;17686.850354726903;17817.109144542723;17840.10799460048;896.408370475483;908.6774195160755;909.9863502047475;917.3028498341308;920.9033051529627;9140.405873618327;9332.906670933204;9676.274279429072;9797.412155270564;9934.403935763732;347789;353252;353408;384819;393173;74948.62525687445;75514.62242688751;75729.62135189289;76188.61905690435;76484;1106.7454485468227;1135.9545618175346;1154.5324143721807;1157.579353011848;1158.5481662151767;17004.914975425538;17061.573460663087;17425.912870435568;17742.73385899187;18603.627927441645;38290.42564361481;38495.422568660935;38652;38757.806210969895;38935.44258229639;46924.296135558674;47271;47776;48112.27831582459;49342.50657493379;7587.696492140473;7938.64276107565;8016.4388492807275;8293.377996650395;8552.486850788973;12011.81982270284;12104.878951210376;12145.817812732992;12370.381480926098;12635.620931372074;10319.678072433942;10503.947480262856;10722.24944253926;10867.619633312795;11005.449727513433;10236.846447303147;10247.436390998566;10256.38461692301;10362.740931476774;10390.272680912565;10319.174466042548;10452.216083793897;10609.416482093558;10833;11319.773604528027;8042.758717238492;8082.878756818534;8096.919030809617;8183.222593853575;8304.83390332202;10710.785784284426;10717.678469645924;10783.838242426213;10952.288101273392;11160.162987776112 16:42:29 INFO - PID 8726 | |3;mootools.html;1261.6782720406297;1318.0905175428954;1338.337522926151;1349.0691422918185;1353.546561901763;9608.807823843528;10040;10045.196384289258;10049.949750251257;10053.24600654952;9947;10286.794264114731;10333.173346132311;10335.896641033587;10339.22455815815;2052.6407878621217;2099.580083983202;2101.6112019276406;2103.0851579562864;2106.031225636209;1739.0522165419814;1815.0561707911877;2039.4799326171806;2085.6871469279654;2099.454141923103;2149.720536330275;2239.4513344230604;2242.9439264018447;2243.181238847817;2243.2933625907785;2211.7235345581803;2222.2444368914566;2233.2072114399316;2233.8994745236423;2234.9888250558806;2195.637719776235;2199.7800219978035;2200.8459407841456;2203.5592881423618;2205.6029914615365;9813.90186098137;9861.063198996084;9940.900590994142;9948.602055917754;9949.701508954742;5423.2136340230445;5634.154876768476;5642.520385767215;5644.85887852807;5645.5483561314995;3098.148009297439;3168.1446009577285;3353.9329213415594;3362.09223509651;3374.6119196292493;1082.8213344798098;1097.1771171621283;1107.789519991199;1158.067755456857;1161.2625982501088;14501.564953051426;14834.184119873402;14834.406623735038;14858.851411485855;14870.405183792634;4738.526147385234;4903.289023091632;5145.331106956071;5179.948200517946;5198.818041368534;12345.197562158432;12375.6906077347;12376.443060062318;12382.380880955916;12385.814212786816;5755.7122143893475;5755.9424405756245;5756.050251708505;5760.654360738369;5764.365919748824;5022.146235140035;5056.418511871108;5155.793768249303;5204.843854684365;5230.790768369298;4084.642040846397;4113.609207125318;4132.628063474302;4143.523494798137;4182.53992060873;1202.9939850300868;1289.9032572557096;1298.7792075347213;1312.343828085957;1333.4532841534924;641.3618449642636;670.9899351509731;721.3435773446244;733.6478490324674;741.7403908632043;5776.815752770672;5830.2129212555765;5858.94141058584;5870.706464676749;6090.969545152246;845.8773477845677;861.4228466927174;867.4751775175928;884.8363052835246;888.2183678362999;3045.512717965115;3126.343038189763;3146.4493713600027;3156.510740835174;3271.6401195868434;12838.29389383593;13291.268980206181;13329.133606315558;13343.532976345781;13348.399322030531;12743.872561274455;13181.143225690299;13181.60455186346;13189.274589897648;13196.142250753863;7614.923850761532;7625.23747625233;7737.961310193413;7760.805979850436;7764.805879853049;5522.282103326542;5547.44525547442;5618.915716264178;5700.771969121189;5759.136129580596;11415.942920285677;11533.769324613628;11589.826152607886;11648;11691.941540292244;12013.339266340436;12044.638660840188;12058.276503409823;12064.698382540506;12261.203021803554;7442.776716698508;7646.847063058819;7648.961755191189;7649;7651.961740191264;9390.154886060287;9411.058894110534;9507.096825801538;9519.809603808024;9529.904700952902;7909.960450197712;7922.564258965812;7928.603569821371;7980;8102.230288122619;7986.640601173078;7995.320397766255;8071.192880711882;8152.959235203786;8238;7141.143062832493;7230.927690723025;7232.963835180791;7233.4574906883245;7251.782446526613;4810.542998415145;4845.5221157547285;4956.132676781621;4994.225894986283;5075.822346218012;5196.68819870809;5286.603504737083;5356.035913535445;5358.598105142208;5406.864828379322 16:42:29 INFO - PID 8726 | |4;prototype.html;365.28404327518064;383.07487417885807;390.2176136845626;392.6623104130449;400.9037830920579;5347.021602007263;5364.54401375883;5388.8922221555595;5404.378496472907;5414.35027796664;5065.164247899102;5187.729006393439;5208.843734687956;5218.39988401334;5249.4750524947485;4007.8797636070817;4015.518137823465;4020.135670830771;4021.336479480882;4023.4769479967563;4008.458858054169;4017.4777278953693;4018.437418761361;4031.6169963853386;4031.737937034098;3800.8289626966853;3964.1873415949663;3967.583403742609;3984;3985.641292283694;3937.8621748238675;3958.821853016607;3966.781826999528;3972.940405893914;3973.4834471518807;3460.809655468948;3480.7911525308564;3491.14466955595;3500.1424650960676;3505.4917037029486;4940.580050695695;5050.570701490377;5083.593312534988;5084.186530155194;5103.183490641517;4661.044485880387;4664.160451118797;4674.252119660872;4680.648951328664;4695.953040469586;5501.60680104156;5515.944840551583;5532.3914369419335;5540;5551.528120109796;3750;3868.4777555030273;3894.9805250973845;3901.9804900975314;3910.4720862683457;5583.134614134816;5695.316562012544;5742.425757424224;5863.794767183171;5901.557383196277;3977.3039718049226;3977.423273625366;3979.2041591681777;3979.4428779970826;3988.720789544762;3819.694424446038;4036.3945408189006;4045.554988951213;4048.4534587830267;4053.1691003344245;4502.302143167814;4524;4583.243764778774;4607.861764147081;4628.282616194495;5552.361478430033;5578.86052848682;5588.329400471888;5590.552755779528;5590.8043218487155;1357.4773712120707;1394.1286695815115;1395.9860401396058;1401.341369556307;1404.95082672106;924.3945215883607;924.5700749151677;935.2004036548789;937.1986951156799;946.342292106979;4859.80560777572;4872.293517439952;4912.971363481911;4926.374296482152;4954.653174277766;5764.691265995776;5828;5831.271091113611;5832.300123985064;5841.795537156179;4836.671179294512;4936.580390666762;4937.432195297515;4947.950520494821;4961.330220420269;3068.6931306869133;3077.415291094685;3093.2885436349766;3095.411871744361;3096.8296743679316;5317.14925611908;5319.255304257407;5378.91931621026;5414.675119492843;5423.566114710814;5908.852278693067;5928.199693041471;5934.317553481319;5934.525237980951;5942.108683697394;5384.380796208407;5385;5394.541463975527;5410.3507579090765;5415.729213539386;5671.120976248523;5753.9136912945505;5776.220210271727;5781.161731548986;5781.94218057814;5439.211314359317;5566.276384070207;5672.14917762339;5677.943220567741;5690.459406356389;5207.3490813648295;5298.15229563268;5410.161424979135;5410.97294513525;5477.917831232455;3995.34076877312;3995.9800200998807;3999.06022084804;4001.779902105412;4002.519697636186;5723.255976723;5771.950957410227;5798.478136967693;5803.912941305799;5853.678047707247;5587.916181257366;5612.354579223278;5615.522680572197;5628.802991895264;5632.098864181711;5459.682764325788;5618.6628802272;5624.987502249471;5631.155326700864;5643.463870932255;5495.972520137374;5516.420775818642;5536.778528858962;5537.418571049981;5538.6122971391615;5647.3787883333625;5658.490735833795;5669.149627555899;5669.7165141741925;5684.261046063985;5277.894442111213;5414.458554144711;5442.700651464207;5454.481824226692;5470.398256191896 16:42:29 INFO - PID 8726 | |5;yui.html;746.302207436047;759.2938567132567;767.4244316762424;770.4183341577109;776.5845272779064;13193.472261109557;14111.71776564468;14113.57659270221;14114.223717695548;14122.152670839756;13820.447182112703;15973.84026159741;16322.34710611577;16422.83577164228;16429.589260268498;908.7546362482109;912.6760000199899;913.5386629751999;913.5751875377948;915.9358844880861;914.3553794574842;916.2486760856101;916.4638686368482;916.5234078279291;918.081918081918;967.5210770668529;967.8016006718641;968.3124981263312;968.4963818814213;969.7139343893568;954.6324665003954;960.3373672166183;963.734972882456;965.6958058211711;967.4823969176492;709.7480394459996;712.7647876200894;712.768350286159;713.1976526407791;713.2795876165111;14834.703305933928;14953;15074;15105.848941510554;15210.239488025554;15510.534683959499;15642.139682317467;15919.885608007444;16135.677286454205;16144.354225830954;11112.722181945435;11208.27146235492;11225.943870280596;11228.101751859913;11229;2908.7527560157414;2912.577676236955;2943.9116826495238;2973.108067579739;2975.613170287849;66087.3391266086;68834.31165688329;69249;69786.65106674434;70535;12338.568150114703;12399.25604463735;12546.372681365896;12596.118271720892;12599.370031498389;21996.120155193934;22267.443313916956;22494.21270255566;22543;22561.774382255968;6397.744090236339;6459.677016149174;6463.741450341934;6466.6766661666725;6467.773627923094;3026.3644634626976;3100.5039193728894;3103.6120484939383;3108.4715598348334;3112.1752735525106;3577.821108944542;3640;3664.5708173812236;3682.5212722345923;3683.079230192452;713.5932518464425;722.068531594248;724.9891251631229;726.4188649080714;728.4136270302457;575.4245754245754;585.0609771316975;587.9059350503899;588.1471865794615;589.1722130406786;9599.952000240093;9610.183134433652;9960.900390996143;10223.7444063899;10564.418956957441;585.1223165252122;589.351713115578;602.5510994309268;602.5541099586275;620.798240571816;4308.719933204395;4553.180427523078;4579.107074120515;4581.2440947243995;4773.331733557305;63099.6845015772;63426.948879712705;63979.36020639827;67494.66252668705;67974.32025679779;56586.71706641523;56657;56908.43091569114;57133;57565.424345756845;37809.62190378061;48488.7575562127;50681;52886.73556632269;54674.179887301725;10141.84787228207;10781.73045673833;11540.884591153981;11550.711232219262;11615.477303521193;24470.456521956094;24796.25611231666;24921.626175607016;25872.741272587034;27743;41531.584684152775;42526.57473425226;42651.3602295972;43429.70269310995;43970.78014610035;13382.732345353234;14070;14103.2948352584;14138.858611413754;14217.64455888611;15470.690586187988;15644;15828.92085539611;15840.207989600243;15918.124503152438;13827.202463679658;13832.792508112587;13962.371693273624;13984.790228146383;14004;13240.735185296047;13253.536126235536;13316.800247996482;13431.328433578477;13505.12216705911;14038.719225615634;14104.506342277971;14297.928510357382;14334.641633958818;14411.351489182802;9289.767755806159;9412.764680883032;9424.717258482257;9535.141837234682;9625;10263.948680256552;10803.405812680063;10816.837747433952;10924.945375273392;10956.726081848017 16:42:29 INFO - PID 8726 | __end_tp_report 16:42:29 INFO - PID 8726 | __start_cc_report 16:42:29 INFO - PID 8726 | _x_x_mozilla_cycle_collect,1422 16:42:29 INFO - PID 8726 | __end_cc_report 16:42:29 INFO - PID 8726 | __startTimestamp1494373349981__endTimestamp 16:42:29 INFO - PID 8726 | 16:42:29 INFO - PID 8726 | ------- Summary: start ------- 16:42:29 INFO - PID 8726 | Number of tests: 6 16:42:29 INFO - PID 8726 | 16:42:29 INFO - PID 8726 | [#0] dojo.html Cycles:165 Average:5094.70 Median:5277.16 stddev:606.10 (11.5%) stddev-sans-first:577.95 16:42:29 INFO - PID 8726 | Values: 2693.7 2717.4 2755.7 2756.8 2767.6 5014.6 5109.1 5135.3 5146.6 5160.1 5138.7 5158.6 5183.1 5189.7 5236.9 4325.2 4554.9 4598.3 4662.3 4688.2 4621.1 4642.1 4666.7 4677.4 4689.0 4524.5 4552.6 4573.1 4578.7 4600.9 4582.0 4588.3 4594.3 4597.7 4600.4 4532.2 4593.4 4604.4 4614.3 4616.6 5011.8 5022.4 5022.7 5076.9 5086.0 5541.6 5562.1 5564.4 5566.7 5618.7 5528.2 5562.1 5576.3 5602.4 5614.0 5139.9 5222.2 5269.1 5270.9 5272.4 5730.1 5761.5 5767.9 5781.5 5784.1 5403.2 5456.3 5484.8 5485.2 5549.1 5583.2 5590.8 5594.4 5620.4 5644.0 5522.3 5525.4 5526.8 5531.6 5533.8 5336.7 5426.8 5502.9 5530.6 5581.3 4550.8 4552.3 4584.8 4596.0 4596.8 3896.4 3909.3 3915.8 3956.5 3968.3 4691.2 4741.7 4745.7 4762.7 4784.2 5571.7 5633.4 5647.4 5676.9 5681.9 4744.9 4747.3 4757.7 4760.4 4804.0 4823.7 4913.6 4924.3 4924.4 4926.3 5123.4 5225.1 5277.2 5283.9 5283.9 5581.3 5656.0 5663.2 5665.9 5677.1 5264.9 5275.4 5278.2 5278.4 5324.6 5439.2 5465.7 5515.7 5569.7 5577.4 5619.1 5653.5 5658.2 5660.9 5690.4 5323.3 5423.3 5426.0 5467.2 5480.0 5356.7 5427.8 5473.4 5477.6 5481.3 5321.9 5330.1 5332.8 5346.7 5350.8 5268.6 5453.3 5458.9 5464.6 5506.7 5234.8 5274.2 5326.4 5342.6 5348.7 16:42:29 INFO - PID 8726 | 16:42:29 INFO - PID 8726 | [#1] ext.html Cycles:180 Average:28984.75 Median:30591.66 stddev:36896.68 (120.6%) stddev-sans-first:36939.04 16:42:29 INFO - PID 8726 | Values: 698.3 750.4 770.6 1069.0 1075.7 25830.0 32491.7 33075.8 33095.0 33234.8 34983.8 35348.6 35383.8 35411.0 35430.6 5273.1 6829.1 6969.5 6973.2 6987.8 5324.4 6724.1 6900.2 6902.7 6903.4 6959.7 6999.0 7001.2 7010.1 7011.0 5264.6 6902.9 6949.6 6961.2 6981.3 5387.4 6577.4 6849.5 6873.0 6876.6 32520.0 33111.0 33144.7 33148.5 33185.0 3036.8 3079.2 3081.6 3082.1 3083.8 22082.0 22128.3 22162.1 22165.8 22178.0 2772.0 2781.2 2781.4 2783.5 2790.1 130603.0 131086.0 131411.0 131591.0 131850.0 41634.8 41755.0 41802.4 41834.6 41890.6 43879.0 43965.3 44016.3 44171.0 44178.0 10925.7 11113.8 11115.4 11140.8 11141.2 6981.8 7098.8 8659.6 8684.9 8685.8 11873.5 11973.2 12150.9 12194.8 12242.8 5023.3 5056.1 5076.6 5168.3 5180.4 892.5 932.4 937.0 942.2 971.9 21037.2 21622.8 21714.9 21797.8 22117.1 1004.8 1005.0 1009.9 1036.1 1039.6 11037.6 11319.3 11362.6 11537.5 11697.9 151719.0 152385.0 152412.0 152726.2 153520.2 40954.6 40996.8 40998.0 41063.8 41202.6 1243.2 1296.1 1296.1 1300.6 1301.6 19707.4 19800.9 19809.4 21473.5 21639.7 30503.8 30581.1 30602.2 30661.2 30677.2 143561.0 143565.0 143865.0 143893.0 144348.0 28626.9 28877.6 28986.6 29698.7 29955.7 36433.3 36467.8 36546.5 36567.6 37023.6 25720.9 27382.2 27873.7 28365.6 28781.0 26741.7 27770.7 27993.0 28065.7 28775.7 30902.0 30972.8 31164.4 32299.2 32780.2 27289.3 27357.7 27662.0 27852.7 28742.2 21507.8 22618.7 22635.8 22689.9 22712.4 16:42:29 INFO - PID 8726 | 16:42:29 INFO - PID 8726 | [#2] jquery.html Cycles:180 Average:24583.66 Median:38573.71 stddev:60985.25 (158.1%) stddev-sans-first:61129.29 16:42:29 INFO - PID 8726 | Values: 392.6 415.7 417.8 431.0 440.8 11900.5 13582.5 17690.6 17886.2 18167.6 18702.9 19071.0 19102.0 19177.9 19185.5 4445.4 5295.6 5508.2 5512.8 5514.9 5324.9 5347.6 5399.3 5399.4 5400.5 5318.2 5382.2 5384.1 5384.7 5390.3 5172.8 5357.3 5360.6 5363.0 5376.6 4711.6 4865.5 4899.6 4900.6 4900.9 21742.0 21800.7 22213.6 22402.4 22684.4 1621.9 1654.7 1655.2 1655.9 1656.0 13992.7 14258.9 15100.0 15203.5 15207.9 2079.2 2110.9 2122.7 2127.8 2128.9 67419.0 87430.3 88200.6 90185.0 90705.5 10432.5 10721.2 10852.2 10945.8 10959.2 15413.0 15592.5 15598.1 15609.3 15625.5 7713.0 7718.6 7770.7 8014.6 8049.2 7285.4 7287.9 7318.6 7487.6 7494.5 6845.3 6996.6 7086.8 7089.9 7131.7 1971.6 2021.4 2026.0 2029.1 2157.6 868.1 896.7 898.2 907.5 918.1 17057.5 17093.5 17686.9 17817.1 17840.1 896.4 908.7 910.0 917.3 920.9 9140.4 9332.9 9676.3 9797.4 9934.4 347789.0 353252.0 353408.0 384819.0 393173.0 74948.6 75514.6 75729.6 76188.6 76484.0 1106.7 1136.0 1154.5 1157.6 1158.5 17004.9 17061.6 17425.9 17742.7 18603.6 38290.4 38495.4 38652.0 38757.8 38935.4 46924.3 47271.0 47776.0 48112.3 49342.5 7587.7 7938.6 8016.4 8293.4 8552.5 12011.8 12104.9 12145.8 12370.4 12635.6 10319.7 10503.9 10722.2 10867.6 11005.4 10236.8 10247.4 10256.4 10362.7 10390.3 10319.2 10452.2 10609.4 10833.0 11319.8 8042.8 8082.9 8096.9 8183.2 8304.8 10710.8 10717.7 10783.8 10952.3 11160.2 16:42:29 INFO - PID 8726 | 16:42:29 INFO - PID 8726 | [#3] mootools.html Cycles:180 Average:6254.60 Median:4138.08 stddev:4032.87 (97.5%) stddev-sans-first:4026.73 16:42:29 INFO - PID 8726 | Values: 1261.7 1318.1 1338.3 1349.1 1353.5 9608.8 10040.0 10045.2 10049.9 10053.2 9947.0 10286.8 10333.2 10335.9 10339.2 2052.6 2099.6 2101.6 2103.1 2106.0 1739.1 1815.1 2039.5 2085.7 2099.5 2149.7 2239.5 2242.9 2243.2 2243.3 2211.7 2222.2 2233.2 2233.9 2235.0 2195.6 2199.8 2200.8 2203.6 2205.6 9813.9 9861.1 9940.9 9948.6 9949.7 5423.2 5634.2 5642.5 5644.9 5645.5 3098.1 3168.1 3353.9 3362.1 3374.6 1082.8 1097.2 1107.8 1158.1 1161.3 14501.6 14834.2 14834.4 14858.9 14870.4 4738.5 4903.3 5145.3 5179.9 5198.8 12345.2 12375.7 12376.4 12382.4 12385.8 5755.7 5755.9 5756.1 5760.7 5764.4 5022.1 5056.4 5155.8 5204.8 5230.8 4084.6 4113.6 4132.6 4143.5 4182.5 1203.0 1289.9 1298.8 1312.3 1333.5 641.4 671.0 721.3 733.6 741.7 5776.8 5830.2 5858.9 5870.7 6091.0 845.9 861.4 867.5 884.8 888.2 3045.5 3126.3 3146.4 3156.5 3271.6 12838.3 13291.3 13329.1 13343.5 13348.4 12743.9 13181.1 13181.6 13189.3 13196.1 7614.9 7625.2 7738.0 7760.8 7764.8 5522.3 5547.4 5618.9 5700.8 5759.1 11415.9 11533.8 11589.8 11648.0 11691.9 12013.3 12044.6 12058.3 12064.7 12261.2 7442.8 7646.8 7649.0 7649.0 7652.0 9390.2 9411.1 9507.1 9519.8 9529.9 7910.0 7922.6 7928.6 7980.0 8102.2 7986.6 7995.3 8071.2 8153.0 8238.0 7141.1 7230.9 7233.0 7233.5 7251.8 4810.5 4845.5 4956.1 4994.2 5075.8 5196.7 5286.6 5356.0 5358.6 5406.9 16:42:29 INFO - PID 8726 | 16:42:29 INFO - PID 8726 | [#4] prototype.html Cycles:180 Average:4596.61 Median:5263.68 stddev:1360.83 (25.9%) stddev-sans-first:1327.07 16:42:29 INFO - PID 8726 | Values: 365.3 383.1 390.2 392.7 400.9 5347.0 5364.5 5388.9 5404.4 5414.4 5065.2 5187.7 5208.8 5218.4 5249.5 4007.9 4015.5 4020.1 4021.3 4023.5 4008.5 4017.5 4018.4 4031.6 4031.7 3800.8 3964.2 3967.6 3984.0 3985.6 3937.9 3958.8 3966.8 3972.9 3973.5 3460.8 3480.8 3491.1 3500.1 3505.5 4940.6 5050.6 5083.6 5084.2 5103.2 4661.0 4664.2 4674.3 4680.6 4696.0 5501.6 5515.9 5532.4 5540.0 5551.5 3750.0 3868.5 3895.0 3902.0 3910.5 5583.1 5695.3 5742.4 5863.8 5901.6 3977.3 3977.4 3979.2 3979.4 3988.7 3819.7 4036.4 4045.6 4048.5 4053.2 4502.3 4524.0 4583.2 4607.9 4628.3 5552.4 5578.9 5588.3 5590.6 5590.8 1357.5 1394.1 1396.0 1401.3 1405.0 924.4 924.6 935.2 937.2 946.3 4859.8 4872.3 4913.0 4926.4 4954.7 5764.7 5828.0 5831.3 5832.3 5841.8 4836.7 4936.6 4937.4 4948.0 4961.3 3068.7 3077.4 3093.3 3095.4 3096.8 5317.1 5319.3 5378.9 5414.7 5423.6 5908.9 5928.2 5934.3 5934.5 5942.1 5384.4 5385.0 5394.5 5410.4 5415.7 5671.1 5753.9 5776.2 5781.2 5781.9 5439.2 5566.3 5672.1 5677.9 5690.5 5207.3 5298.2 5410.2 5411.0 5477.9 3995.3 3996.0 3999.1 4001.8 4002.5 5723.3 5772.0 5798.5 5803.9 5853.7 5587.9 5612.4 5615.5 5628.8 5632.1 5459.7 5618.7 5625.0 5631.2 5643.5 5496.0 5516.4 5536.8 5537.4 5538.6 5647.4 5658.5 5669.1 5669.7 5684.3 5277.9 5414.5 5442.7 5454.5 5470.4 16:42:29 INFO - PID 8726 | 16:42:29 INFO - PID 8726 | [#5] yui.html Cycles:180 Average:15429.24 Median:3682.80 stddev:18192.01 (494.0%) stddev-sans-first:18209.63 16:42:29 INFO - PID 8726 | Values: 746.3 759.3 767.4 770.4 776.6 13193.5 14111.7 14113.6 14114.2 14122.2 13820.4 15973.8 16322.3 16422.8 16429.6 908.8 912.7 913.5 913.6 915.9 914.4 916.2 916.5 916.5 918.1 967.5 967.8 968.3 968.5 969.7 954.6 960.3 963.7 965.7 967.5 709.7 712.8 712.8 713.2 713.3 14834.7 14953.0 15074.0 15105.8 15210.2 15510.5 15642.1 15919.9 16135.7 16144.4 11112.7 11208.3 11225.9 11228.1 11229.0 2908.8 2912.6 2943.9 2973.1 2975.6 66087.3 68834.3 69249.0 69786.7 70535.0 12338.6 12399.3 12546.4 12596.1 12599.4 21996.1 22267.4 22494.2 22543.0 22561.8 6397.7 6459.7 6463.7 6466.7 6467.8 3026.4 3100.5 3103.6 3108.5 3112.2 3577.8 3640.0 3664.6 3682.5 3683.1 713.6 722.1 725.0 726.4 728.4 575.4 585.1 587.9 588.1 589.2 9600.0 9610.2 9960.9 10223.7 10564.4 585.1 589.4 602.6 602.6 620.8 4308.7 4553.2 4579.1 4581.2 4773.3 63099.7 63426.9 63979.4 67494.7 67974.3 56586.7 56657.0 56908.4 57133.0 57565.4 37809.6 48488.8 50681.0 52886.7 54674.2 10141.8 10781.7 11540.9 11550.7 11615.5 24470.5 24796.3 24921.6 25872.7 27743.0 41531.6 42526.6 42651.4 43429.7 43970.8 13382.7 14070.0 14103.3 14138.9 14217.6 15470.7 15644.0 15828.9 15840.2 15918.1 13827.2 13832.8 13962.4 13984.8 14004.0 13240.7 13253.5 13316.8 13431.3 13505.1 14038.7 14104.5 14297.9 14334.6 14411.4 9289.8 9412.8 9424.7 9535.1 9625.0 10263.9 10803.4 10816.8 10924.9 10956.7 16:42:29 INFO - PID 8726 | -------- Summary: end -------- 16:42:29 INFO - PID 8726 | 16:42:30 INFO - TEST-INFO | 8726: exit 0 16:42:30 INFO - TEST-OK | dromaeo_css | took 1121428ms 16:42:30 INFO - TEST-START | kraken 16:42:30 INFO - operating with platform_type : linux_ 16:42:30 INFO - Initialising browser for kraken test... 16:42:30 INFO - TEST-INFO | started process 9057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BpdYs/profile http://localhost:51920/getInfo.html) 16:42:34 INFO - PID 9057 | __metrics Screen width/height:1600/1200 16:42:34 INFO - PID 9057 | colorDepth:24 16:42:34 INFO - PID 9057 | Browser inner width/height: 1024/695 16:42:34 INFO - PID 9057 | __metrics 16:42:35 INFO - PID 9057 | 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" 16:42:35 INFO - PID 9057 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:42:36 INFO - TEST-INFO | 9057: exit 0 16:42:36 INFO - Browser initialized. 16:42:36 INFO - Running cycle 1/1 for kraken test... 16:42:36 INFO - TEST-INFO | started process 9159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BpdYs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:48 INFO - PID 9159 | RSS: Main: 163270656 16:42:48 INFO - PID 9159 | 16:42:51 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51920/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:52 INFO - PID 9159 | RSS: Main: 239013888 16:42:52 INFO - PID 9159 | 16:42:55 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51920/tests/kraken/driver.html?testName=audio-dft) 16:42:55 INFO - PID 9159 | RSS: Main: 201928704 16:42:55 INFO - PID 9159 | 16:42:58 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51920/tests/kraken/driver.html?testName=audio-fft) 16:42:59 INFO - PID 9159 | RSS: Main: 286208000 16:42:59 INFO - PID 9159 | 16:43:01 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51920/tests/kraken/driver.html?testName=audio-oscillator) 16:43:02 INFO - PID 9159 | RSS: Main: 195010560 16:43:02 INFO - PID 9159 | 16:43:04 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51920/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:43:04 INFO - PID 9159 | RSS: Main: 199454720 16:43:04 INFO - PID 9159 | 16:43:08 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51920/tests/kraken/driver.html?testName=imaging-darkroom) 16:43:08 INFO - PID 9159 | RSS: Main: 259563520 16:43:08 INFO - PID 9159 | 16:43:12 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51920/tests/kraken/driver.html?testName=imaging-desaturate) 16:43:13 INFO - PID 9159 | RSS: Main: 258617344 16:43:13 INFO - PID 9159 | 16:43:15 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51920/tests/kraken/driver.html?testName=json-parse-financial) 16:43:16 INFO - PID 9159 | RSS: Main: 256856064 16:43:16 INFO - PID 9159 | 16:43:18 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51920/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:43:18 INFO - PID 9159 | RSS: Main: 221528064 16:43:18 INFO - PID 9159 | 16:43:20 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51920/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:43:21 INFO - PID 9159 | RSS: Main: 226840576 16:43:21 INFO - PID 9159 | 16:43:23 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51920/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:43:23 INFO - PID 9159 | RSS: Main: 236175360 16:43:23 INFO - PID 9159 | 16:43:26 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:43:27 INFO - PID 9159 | RSS: Main: 244674560 16:43:27 INFO - PID 9159 | 16:43:30 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:43:31 INFO - PID 9159 | RSS: Main: 240427008 16:43:31 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | Cycle 1(1): loaded http://localhost:51920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51920/tests/kraken/driver.html?testName=ai-astar) 16:43:33 INFO - PID 9159 | RSS: Main: 290275328 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | __start_tp_report 16:43:33 INFO - PID 9159 | _x_x_mozilla_page_load 16:43:33 INFO - PID 9159 | _x_x_mozilla_page_load_details 16:43:33 INFO - PID 9159 | |i|pagename|runs| 16:43:33 INFO - PID 9159 | |0;ai-astar;111;111;111;112;113;112;112;111;112;113 16:43:33 INFO - PID 9159 | |1;audio-beat-detection;157;124;121;169;122;122;128;126;142;120 16:43:33 INFO - PID 9159 | |2;audio-dft;161;160;164;161;162;162;159;160;162;161 16:43:33 INFO - PID 9159 | |3;audio-fft;73;74;75;108;75;74;74;75;95;75 16:43:33 INFO - PID 9159 | |4;audio-oscillator;84;84;119;84;84;83;107;83;84;105 16:43:33 INFO - PID 9159 | |5;imaging-gaussian-blur;113;113;113;112;113;113;113;113;113;113 16:43:33 INFO - PID 9159 | |6;imaging-darkroom;148;148;148;148;149;149;149;148;149;150 16:43:33 INFO - PID 9159 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 16:43:33 INFO - PID 9159 | |8;json-parse-financial;53;53;52;51;54;53;53;53;54;53 16:43:33 INFO - PID 9159 | |9;json-stringify-tinderbox;55;55;54;54;54;54;55;54;55;56 16:43:33 INFO - PID 9159 | |10;stanford-crypto-aes;80;80;80;80;81;80;80;80;80;89 16:43:33 INFO - PID 9159 | |11;stanford-crypto-ccm;136;130;129;129;130;126;133;140;173;128 16:43:33 INFO - PID 9159 | |12;stanford-crypto-pbkdf2;180;193;189;186;185;189;185;185;186;186 16:43:33 INFO - PID 9159 | |13;stanford-crypto-sha256-iterative;70;69;74;75;71;69;68;69;73;67 16:43:33 INFO - PID 9159 | __end_tp_report 16:43:33 INFO - PID 9159 | __start_cc_report 16:43:33 INFO - PID 9159 | _x_x_mozilla_cycle_collect,1978 16:43:33 INFO - PID 9159 | __end_cc_report 16:43:33 INFO - PID 9159 | __startTimestamp1494373413278__endTimestamp 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | ------- Summary: start ------- 16:43:33 INFO - PID 9159 | Number of tests: 14 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 16:43:33 INFO - PID 9159 | Values: 111.0 111.0 111.0 112.0 113.0 112.0 112.0 111.0 112.0 113.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:127.00 stddev:17.20 (13.5%) stddev-sans-first:15.92 16:43:33 INFO - PID 9159 | Values: 157.0 124.0 121.0 169.0 122.0 122.0 128.0 126.0 142.0 120.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.40 (0.9%) stddev-sans-first:1.48 16:43:33 INFO - PID 9159 | Values: 161.0 160.0 164.0 161.0 162.0 162.0 159.0 160.0 162.0 161.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#3] audio-fft Cycles:10 Average:79.80 Median:75.00 stddev:11.86 (15.8%) stddev-sans-first:12.32 16:43:33 INFO - PID 9159 | Values: 73.0 74.0 75.0 108.0 75.0 74.0 74.0 75.0 95.0 75.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:13.35 (15.9%) stddev-sans-first:13.87 16:43:33 INFO - PID 9159 | Values: 84.0 84.0 119.0 84.0 84.0 83.0 107.0 83.0 84.0 105.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:43:33 INFO - PID 9159 | Values: 113.0 113.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 113.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 16:43:33 INFO - PID 9159 | Values: 148.0 148.0 148.0 148.0 149.0 149.0 149.0 148.0 149.0 150.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:43:33 INFO - PID 9159 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 16:43:33 INFO - PID 9159 | Values: 53.0 53.0 52.0 51.0 54.0 53.0 53.0 53.0 54.0 53.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 16:43:33 INFO - PID 9159 | Values: 55.0 55.0 54.0 54.0 54.0 54.0 55.0 54.0 55.0 56.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:2.83 (3.5%) stddev-sans-first:2.98 16:43:33 INFO - PID 9159 | Values: 80.0 80.0 80.0 80.0 81.0 80.0 80.0 80.0 80.0 89.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:131.50 stddev:13.84 (10.5%) stddev-sans-first:14.68 16:43:33 INFO - PID 9159 | Values: 136.0 130.0 129.0 129.0 130.0 126.0 133.0 140.0 173.0 128.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:186.00 stddev:3.41 (1.8%) stddev-sans-first:2.71 16:43:33 INFO - PID 9159 | Values: 180.0 193.0 189.0 186.0 185.0 189.0 185.0 185.0 186.0 186.0 16:43:33 INFO - PID 9159 | 16:43:33 INFO - PID 9159 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:2.68 (3.8%) stddev-sans-first:2.83 16:43:33 INFO - PID 9159 | Values: 70.0 69.0 74.0 75.0 71.0 69.0 68.0 69.0 73.0 67.0 16:43:33 INFO - PID 9159 | -------- Summary: end -------- 16:43:33 INFO - PID 9159 | 16:43:34 INFO - TEST-INFO | 9159: exit 0 16:43:34 INFO - TEST-OK | kraken | took 63554ms 16:43:34 INFO - SUITE-END | took 1184s 16:43:34 INFO - Completed test suite (00:19:45) 16:43:34 INFO - javascript benchmark 16:43:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6641.762037991, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2693.703692593814, 2717.415755612543, 2755.7244275572443, 2756.765674917631, 2767.571026490894, 5014.598832093433, 5109.105906466372, 5135.255387968742, 5146.562542183914, 5160.122779127548, 5138.7173705446185, 5158.638895277332, 5183.144781111121, 5189.740512974355, 5236.8690782730455, 4325.243082460573, 4554.863354099366, 4598.310253461991, 4662.254039353704, 4688.226442636961, 4621.075784843045, 4642.141203877293, 4666.743329116897, 4677.4387073551225, 4689.0, 4524.47968483622, 4552.56750608695, 4573.131105090022, 4578.702384345041, 4600.907981840378, 4581.954180458186, 4588.311753237042, 4594.33382159585, 4597.655175861791, 4600.401947746805, 4532.206863798822, 4593.356930029799, 4604.355390245369, 4614.330922016289, 4616.607588354994, 5011.824586139468, 5022.372203474566, 5022.748862556858, 5076.898462030776, 5086.0, 5541.5843811714285, 5562.0978360786385, 5564.387917329091, 5566.66600003997, 5618.7190640468225, 5528.226048353234, 5562.054450743383, 5576.33084029915, 5602.439756024406, 5613.971930140364, 5139.897202055975, 5222.216667499905, 5269.104252277122, 5270.92093618596, 5272.420033796279, 5730.140478928194, 5761.510271626875, 5767.8558036049435, 5781.53747700183, 5784.1034639630925, 5403.162509810985, 5456.290682211366, 5484.8354549363585, 5485.232067510552, 5549.139883318092, 5583.246261754693, 5590.8043218487155, 5594.356648985337, 5620.409856965041, 5644.040513112781, 5522.337319521683, 5525.392206857243, 5526.834194974157, 5531.557475401958, 5533.7786488540005, 5336.733163341817, 5426.810061647823, 5502.862428439241, 5530.585206109477, 5581.3302403711, 4550.772461376918, 4552.3171524270965, 4584.816607335736, 4596.011857450664, 4596.770161491912, 3896.3765797472834, 3909.315869722844, 3915.784631845219, 3956.5054368203973, 3968.3452230381663, 4691.155591993405, 4741.691790033637, 4745.715257084586, 4762.690425122356, 4784.234522476387, 5571.721413929368, 5633.352164501053, 5647.435256474402, 5676.8864622707315, 5681.886362272731, 4744.905101898012, 4747.264174053027, 4757.738324392191, 4760.428748550127, 4804.039192161582, 4823.662343635911, 4913.631477639191, 4924.285978533164, 4924.384451943507, 4926.3349447824085, 5123.410807757155, 5225.137852254487, 5277.155655095166, 5283.920741188808, 5283.947160528499, 5581.302337207849, 5656.038473459439, 5663.207150998781, 5665.943340566541, 5677.063284558001, 5264.894702106013, 5275.366955965309, 5278.208268759717, 5278.4193738687945, 5324.6006549508165, 5439.156930675752, 5465.672059676433, 5515.696636685021, 5569.693666848362, 5577.414371491097, 5619.072852979376, 5653.491185793134, 5658.20785090096, 5660.943390566042, 5690.430956904276, 5323.281357016753, 5423.267858839164, 5425.969065877471, 5467.152591348347, 5480.04099282616, 5356.732163391893, 5427.782888684566, 5473.425290344616, 5477.616566840283, 5481.260029896072, 5321.920171197357, 5330.0938840398, 5332.840014799563, 5346.652467589594, 5350.785968561214, 5268.604854635841, 5453.318335208099, 5458.9454105458435, 5464.644798088111, 5506.669599824023, 5234.842954711365, 5274.208868669731, 5326.414094449685, 5342.599305052059, 5348.652337598043], "value": 5050.800739647779, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.343557056367, 750.40717832912, 770.5954373953674, 1069.0432063303344, 1075.6826736112846, 25830.0, 32491.67508324916, 33075.83462082686, 33095.0, 33234.845644294495, 34983.82508087462, 35348.64651353492, 35383.82308088463, 35411.0, 35430.645693543054, 5273.077211487994, 6829.112215411989, 6969.512134150612, 6973.163220413558, 6987.790366289019, 5324.41431442541, 6724.125863637721, 6900.20647625522, 6902.689378977958, 6903.413209877166, 6959.652017399135, 6999.020137180799, 7001.159860816709, 7010.053642758214, 7011.018457415966, 5264.552513036397, 6902.930970690279, 6949.583025018515, 6961.199462061877, 6981.301869813004, 5387.4073851876265, 6577.440917522016, 6849.452043836481, 6872.965635171842, 6876.621785801779, 32520.0, 33111.0, 33144.66855331464, 33148.50277245843, 33185.0, 3036.8481575921114, 3079.1532328609587, 3081.599392079038, 3082.1215953453384, 3083.753299736038, 22082.0, 22128.33614991553, 22162.11351545936, 22165.778342216694, 22178.0, 2772.0, 2781.207355903558, 2781.3741908070724, 2783.5268004439295, 2790.0513825299295, 130602.99999999905, 131086.0, 131411.0, 131591.0, 131850.0, 41634.79182604067, 41755.0, 41802.35668184817, 41834.581654183676, 41890.58109418928, 43879.0, 43965.34051989223, 44016.3397549037, 44171.0, 44178.0, 10925.672229833117, 11113.777724445466, 11115.444227788577, 11140.777184456265, 11141.2201145919, 6981.82545436358, 7098.787036388917, 8659.610317535726, 8684.913150868411, 8685.785124793138, 11873.525058997717, 11973.221740586834, 12150.878491215151, 12194.75610487803, 12242.755144897052, 5023.296738456619, 5056.064628043824, 5076.593872490192, 5168.2764412982215, 5180.378354597397, 892.5269607108243, 932.3520153493257, 936.9531523423938, 942.1661829281136, 971.8979507151789, 21037.15851365959, 21622.78377216239, 21714.89142554277, 21797.782022179894, 22117.115315387528, 1004.7889943112028, 1004.9648262310784, 1009.8939611340851, 1036.0520124086377, 1039.6361273554196, 11037.558497660004, 11319.320840749417, 11362.602308919148, 11537.48081336342, 11697.883021169679, 151719.0, 152385.0, 152412.0, 152726.23636881966, 153520.23239883952, 40954.59045409508, 40996.79501602473, 40998.0, 41063.794681026404, 41202.58797412048, 1243.185713357752, 1296.0538806671184, 1296.0538806671184, 1300.635821969831, 1301.5965050834272, 19707.408777736116, 19800.90099549493, 19809.40571782849, 21473.46316342104, 21639.675404869253, 30503.847480762455, 30581.08256752301, 30602.234944126576, 30661.23346916345, 30677.233069172555, 143561.0, 143565.0, 143865.0, 143893.0, 144348.0, 28626.85686571637, 28877.56683649789, 28986.565201522415, 29698.703012969592, 29955.700442996163, 36433.27133457369, 36467.817660911525, 36546.45180322351, 36567.63432365749, 37023.62976370202, 25720.87139564365, 27382.178534643994, 27873.721262787112, 28365.574516381857, 28781.0, 26741.732582673925, 27770.72229277762, 27993.02024429135, 28065.71934280631, 28775.71662755338, 30902.0, 30972.845135774176, 31164.376712466077, 32299.192520186243, 32780.18049548685, 27289.31776705598, 27357.72642273552, 27662.0, 27852.721472785823, 28742.20971667588, 21507.784922151204, 22618.660720088883, 22635.773642264026, 22689.886550567142, 22712.432189195402], "value": 14185.291924368583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.64073372863834, 415.74016239850096, 417.82451370424417, 430.97414155150693, 440.79503031090536, 11900.46447909844, 13582.524611638595, 17690.557736056606, 17886.195121219545, 18167.636647267063, 18702.90648546759, 19071.0, 19102.0, 19177.904110479427, 19185.52036199096, 4445.377647129389, 5295.602829787762, 5508.20131080993, 5512.751926163332, 5514.889702205954, 5324.893502129955, 5347.572194224472, 5399.325084364455, 5399.379071406799, 5400.540954018894, 5318.175682769177, 5382.165764306539, 5384.138537833947, 5384.730763461831, 5390.272313237721, 5172.767225474844, 5357.330333708286, 5360.571154307646, 5362.973185134068, 5376.569874410077, 4711.623070154379, 4865.537773911473, 4899.608031357483, 4900.58345040672, 4900.926486102711, 21742.0, 21800.672989905164, 22213.555728885494, 22402.439939001655, 22684.432889177737, 1621.9432319868747, 1654.710425675502, 1655.180685560655, 1655.925483353252, 1656.0, 13992.720145597134, 14258.857411425857, 15100.0, 15203.467878624195, 15207.923960380238, 2079.170330109509, 2110.915563377463, 2122.681597760333, 2127.8297736181066, 2128.8935553222277, 67418.9999999995, 87430.25139497174, 88200.55899720524, 90185.0, 90705.54647226722, 10432.530536125892, 10721.195910306758, 10852.240343175901, 10945.83581246282, 10959.232853700323, 15413.0, 15592.454264100703, 15598.142102184262, 15609.297581608855, 15625.531234062997, 7712.9614351927885, 7718.614069296513, 7770.689172433153, 8014.599270036475, 8049.235322644339, 7285.380742636829, 7287.890681639779, 7318.560886346836, 7487.588182649898, 7494.5128566643, 6845.349691779273, 6996.580205187705, 7086.822829429306, 7089.92910070903, 7131.679074441663, 1971.6253911756721, 2021.3935819254166, 2025.9594808103755, 2029.0869108901054, 2157.6448622392018, 868.1492137705085, 896.7264984179757, 898.2185498616245, 907.5371560504191, 918.1140199707314, 17057.48827535176, 17093.487195384158, 17686.850354726903, 17817.109144542723, 17840.10799460048, 896.408370475483, 908.6774195160755, 909.9863502047475, 917.3028498341308, 920.9033051529627, 9140.405873618327, 9332.906670933204, 9676.274279429072, 9797.412155270564, 9934.403935763732, 347789.0, 353252.0, 353408.0, 384819.0, 393173.0, 74948.62525687445, 75514.62242688751, 75729.62135189289, 76188.61905690435, 76484.0, 1106.7454485468227, 1135.9545618175346, 1154.5324143721807, 1157.579353011848, 1158.5481662151767, 17004.914975425538, 17061.573460663087, 17425.912870435568, 17742.73385899187, 18603.627927441645, 38290.42564361481, 38495.422568660935, 38652.0, 38757.806210969895, 38935.44258229639, 46924.296135558674, 47271.0, 47776.0, 48112.27831582459, 49342.50657493379, 7587.696492140473, 7938.64276107565, 8016.4388492807275, 8293.377996650395, 8552.486850788973, 12011.81982270284, 12104.878951210376, 12145.817812732992, 12370.381480926098, 12635.620931372074, 10319.678072433942, 10503.947480262856, 10722.24944253926, 10867.619633312795, 11005.449727513433, 10236.846447303147, 10247.436390998566, 10256.38461692301, 10362.740931476774, 10390.272680912565, 10319.174466042548, 10452.216083793897, 10609.416482093558, 10833.0, 11319.773604528027, 8042.758717238492, 8082.878756818534, 8096.919030809617, 8183.222593853575, 8304.83390332202, 10710.785784284426, 10717.678469645924, 10783.838242426213, 10952.288101273392, 11160.162987776112], "value": 8794.727621528958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1261.6782720406297, 1318.0905175428954, 1338.337522926151, 1349.0691422918185, 1353.546561901763, 9608.807823843528, 10040.0, 10045.196384289258, 10049.949750251257, 10053.24600654952, 9947.0, 10286.794264114731, 10333.173346132311, 10335.896641033587, 10339.22455815815, 2052.6407878621217, 2099.580083983202, 2101.6112019276406, 2103.0851579562864, 2106.031225636209, 1739.0522165419814, 1815.0561707911877, 2039.4799326171806, 2085.6871469279654, 2099.454141923103, 2149.720536330275, 2239.4513344230604, 2242.9439264018447, 2243.181238847817, 2243.2933625907785, 2211.7235345581803, 2222.2444368914566, 2233.2072114399316, 2233.8994745236423, 2234.9888250558806, 2195.637719776235, 2199.7800219978035, 2200.8459407841456, 2203.5592881423618, 2205.6029914615365, 9813.90186098137, 9861.063198996084, 9940.900590994142, 9948.602055917754, 9949.701508954742, 5423.2136340230445, 5634.154876768476, 5642.520385767215, 5644.85887852807, 5645.5483561314995, 3098.148009297439, 3168.1446009577285, 3353.9329213415594, 3362.09223509651, 3374.6119196292493, 1082.8213344798098, 1097.1771171621283, 1107.789519991199, 1158.067755456857, 1161.2625982501088, 14501.564953051426, 14834.184119873402, 14834.406623735038, 14858.851411485855, 14870.405183792634, 4738.526147385234, 4903.289023091632, 5145.331106956071, 5179.948200517946, 5198.818041368534, 12345.197562158432, 12375.6906077347, 12376.443060062318, 12382.380880955916, 12385.814212786816, 5755.7122143893475, 5755.9424405756245, 5756.050251708505, 5760.654360738369, 5764.365919748824, 5022.146235140035, 5056.418511871108, 5155.793768249303, 5204.843854684365, 5230.790768369298, 4084.642040846397, 4113.609207125318, 4132.628063474302, 4143.523494798137, 4182.53992060873, 1202.9939850300868, 1289.9032572557096, 1298.7792075347213, 1312.343828085957, 1333.4532841534924, 641.3618449642636, 670.9899351509731, 721.3435773446244, 733.6478490324674, 741.7403908632043, 5776.815752770672, 5830.2129212555765, 5858.94141058584, 5870.706464676749, 6090.969545152246, 845.8773477845677, 861.4228466927174, 867.4751775175928, 884.8363052835246, 888.2183678362999, 3045.512717965115, 3126.343038189763, 3146.4493713600027, 3156.510740835174, 3271.6401195868434, 12838.29389383593, 13291.268980206181, 13329.133606315558, 13343.532976345781, 13348.399322030531, 12743.872561274455, 13181.143225690299, 13181.60455186346, 13189.274589897648, 13196.142250753863, 7614.923850761532, 7625.23747625233, 7737.961310193413, 7760.805979850436, 7764.805879853049, 5522.282103326542, 5547.44525547442, 5618.915716264178, 5700.771969121189, 5759.136129580596, 11415.942920285677, 11533.769324613628, 11589.826152607886, 11648.0, 11691.941540292244, 12013.339266340436, 12044.638660840188, 12058.276503409823, 12064.698382540506, 12261.203021803554, 7442.776716698508, 7646.847063058819, 7648.961755191189, 7649.0, 7651.961740191264, 9390.154886060287, 9411.058894110534, 9507.096825801538, 9519.809603808024, 9529.904700952902, 7909.960450197712, 7922.564258965812, 7928.603569821371, 7980.0, 8102.230288122619, 7986.640601173078, 7995.320397766255, 8071.192880711882, 8152.959235203786, 8238.0, 7141.143062832493, 7230.927690723025, 7232.963835180791, 7233.4574906883245, 7251.782446526613, 4810.542998415145, 4845.5221157547285, 4956.132676781621, 4994.225894986283, 5075.822346218012, 5196.68819870809, 5286.603504737083, 5356.035913535445, 5358.598105142208, 5406.864828379322], "value": 4722.682818124264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.28404327518064, 383.07487417885807, 390.2176136845626, 392.6623104130449, 400.9037830920579, 5347.021602007263, 5364.54401375883, 5388.8922221555595, 5404.378496472907, 5414.35027796664, 5065.164247899102, 5187.729006393439, 5208.843734687956, 5218.39988401334, 5249.4750524947485, 4007.8797636070817, 4015.518137823465, 4020.135670830771, 4021.336479480882, 4023.4769479967563, 4008.458858054169, 4017.4777278953693, 4018.437418761361, 4031.6169963853386, 4031.737937034098, 3800.8289626966853, 3964.1873415949663, 3967.583403742609, 3984.0, 3985.641292283694, 3937.8621748238675, 3958.821853016607, 3966.781826999528, 3972.940405893914, 3973.4834471518807, 3460.809655468948, 3480.7911525308564, 3491.14466955595, 3500.1424650960676, 3505.4917037029486, 4940.580050695695, 5050.570701490377, 5083.593312534988, 5084.186530155194, 5103.183490641517, 4661.044485880387, 4664.160451118797, 4674.252119660872, 4680.648951328664, 4695.953040469586, 5501.60680104156, 5515.944840551583, 5532.3914369419335, 5540.0, 5551.528120109796, 3750.0, 3868.4777555030273, 3894.9805250973845, 3901.9804900975314, 3910.4720862683457, 5583.134614134816, 5695.316562012544, 5742.425757424224, 5863.794767183171, 5901.557383196277, 3977.3039718049226, 3977.423273625366, 3979.2041591681777, 3979.4428779970826, 3988.720789544762, 3819.694424446038, 4036.3945408189006, 4045.554988951213, 4048.4534587830267, 4053.1691003344245, 4502.302143167814, 4524.0, 4583.243764778774, 4607.861764147081, 4628.282616194495, 5552.361478430033, 5578.86052848682, 5588.329400471888, 5590.552755779528, 5590.8043218487155, 1357.4773712120707, 1394.1286695815115, 1395.9860401396058, 1401.341369556307, 1404.95082672106, 924.3945215883607, 924.5700749151677, 935.2004036548789, 937.1986951156799, 946.342292106979, 4859.80560777572, 4872.293517439952, 4912.971363481911, 4926.374296482152, 4954.653174277766, 5764.691265995776, 5828.0, 5831.271091113611, 5832.300123985064, 5841.795537156179, 4836.671179294512, 4936.580390666762, 4937.432195297515, 4947.950520494821, 4961.330220420269, 3068.6931306869133, 3077.415291094685, 3093.2885436349766, 3095.411871744361, 3096.8296743679316, 5317.14925611908, 5319.255304257407, 5378.91931621026, 5414.675119492843, 5423.566114710814, 5908.852278693067, 5928.199693041471, 5934.317553481319, 5934.525237980951, 5942.108683697394, 5384.380796208407, 5385.0, 5394.541463975527, 5410.3507579090765, 5415.729213539386, 5671.120976248523, 5753.9136912945505, 5776.220210271727, 5781.161731548986, 5781.94218057814, 5439.211314359317, 5566.276384070207, 5672.14917762339, 5677.943220567741, 5690.459406356389, 5207.3490813648295, 5298.15229563268, 5410.161424979135, 5410.97294513525, 5477.917831232455, 3995.34076877312, 3995.9800200998807, 3999.06022084804, 4001.779902105412, 4002.519697636186, 5723.255976723, 5771.950957410227, 5798.478136967693, 5803.912941305799, 5853.678047707247, 5587.916181257366, 5612.354579223278, 5615.522680572197, 5628.802991895264, 5632.098864181711, 5459.682764325788, 5618.6628802272, 5624.987502249471, 5631.155326700864, 5643.463870932255, 5495.972520137374, 5516.420775818642, 5536.778528858962, 5537.418571049981, 5538.6122971391615, 5647.3787883333625, 5658.490735833795, 5669.149627555899, 5669.7165141741925, 5684.261046063985, 5277.894442111213, 5414.458554144711, 5442.700651464207, 5454.481824226692, 5470.398256191896], "value": 4180.7518302808285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.302207436047, 759.2938567132567, 767.4244316762424, 770.4183341577109, 776.5845272779064, 13193.472261109557, 14111.71776564468, 14113.57659270221, 14114.223717695548, 14122.152670839756, 13820.447182112703, 15973.84026159741, 16322.34710611577, 16422.83577164228, 16429.589260268498, 908.7546362482109, 912.6760000199899, 913.5386629751999, 913.5751875377948, 915.9358844880861, 914.3553794574842, 916.2486760856101, 916.4638686368482, 916.5234078279291, 918.081918081918, 967.5210770668529, 967.8016006718641, 968.3124981263312, 968.4963818814213, 969.7139343893568, 954.6324665003954, 960.3373672166183, 963.734972882456, 965.6958058211711, 967.4823969176492, 709.7480394459996, 712.7647876200894, 712.768350286159, 713.1976526407791, 713.2795876165111, 14834.703305933928, 14953.0, 15074.0, 15105.848941510554, 15210.239488025554, 15510.534683959499, 15642.139682317467, 15919.885608007444, 16135.677286454205, 16144.354225830954, 11112.722181945435, 11208.27146235492, 11225.943870280596, 11228.101751859913, 11229.0, 2908.7527560157414, 2912.577676236955, 2943.9116826495238, 2973.108067579739, 2975.613170287849, 66087.3391266086, 68834.31165688329, 69249.0, 69786.65106674434, 70535.0, 12338.568150114703, 12399.25604463735, 12546.372681365896, 12596.118271720892, 12599.370031498389, 21996.120155193934, 22267.443313916956, 22494.21270255566, 22543.0, 22561.774382255968, 6397.744090236339, 6459.677016149174, 6463.741450341934, 6466.6766661666725, 6467.773627923094, 3026.3644634626976, 3100.5039193728894, 3103.6120484939383, 3108.4715598348334, 3112.1752735525106, 3577.821108944542, 3640.0, 3664.5708173812236, 3682.5212722345923, 3683.079230192452, 713.5932518464425, 722.068531594248, 724.9891251631229, 726.4188649080714, 728.4136270302457, 575.4245754245754, 585.0609771316975, 587.9059350503899, 588.1471865794615, 589.1722130406786, 9599.952000240093, 9610.183134433652, 9960.900390996143, 10223.7444063899, 10564.418956957441, 585.1223165252122, 589.351713115578, 602.5510994309268, 602.5541099586275, 620.798240571816, 4308.719933204395, 4553.180427523078, 4579.107074120515, 4581.2440947243995, 4773.331733557305, 63099.6845015772, 63426.948879712705, 63979.36020639827, 67494.66252668705, 67974.32025679779, 56586.71706641523, 56657.0, 56908.43091569114, 57133.0, 57565.424345756845, 37809.62190378061, 48488.7575562127, 50681.0, 52886.73556632269, 54674.179887301725, 10141.84787228207, 10781.73045673833, 11540.884591153981, 11550.711232219262, 11615.477303521193, 24470.456521956094, 24796.25611231666, 24921.626175607016, 25872.741272587034, 27743.0, 41531.584684152775, 42526.57473425226, 42651.3602295972, 43429.70269310995, 43970.78014610035, 13382.732345353234, 14070.0, 14103.2948352584, 14138.858611413754, 14217.64455888611, 15470.690586187988, 15644.0, 15828.92085539611, 15840.207989600243, 15918.124503152438, 13827.202463679658, 13832.792508112587, 13962.371693273624, 13984.790228146383, 14004.0, 13240.735185296047, 13253.536126235536, 13316.800247996482, 13431.328433578477, 13505.12216705911, 14038.719225615634, 14104.506342277971, 14297.928510357382, 14334.641633958818, 14411.351489182802, 9289.767755806159, 9412.764680883032, 9424.717258482257, 9535.141837234682, 9625.0, 10263.948680256552, 10803.405812680063, 10816.837747433952, 10924.945375273392, 10956.726081848017], "value": 6899.273581669019, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 112.0, 113.0, 112.0, 112.0, 111.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 121.0, 169.0, 122.0, 122.0, 128.0, 126.0, 142.0, 120.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 164.0, 161.0, 162.0, 162.0, 159.0, 160.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 108.0, 75.0, 74.0, 74.0, 75.0, 95.0, 75.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 119.0, 84.0, 84.0, 83.0, 107.0, 83.0, 84.0, 105.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 149.0, 148.0, 149.0, 150.0], "value": 148.6, "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": [53.0, 53.0, 52.0, 51.0, 54.0, 53.0, 53.0, 53.0, 54.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 81.0, 80.0, 80.0, 80.0, 80.0, 89.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 130.0, 129.0, 129.0, 130.0, 126.0, 133.0, 140.0, 173.0, 128.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 193.0, 189.0, 186.0, 185.0, 189.0, 185.0, 185.0, 186.0, 186.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 74.0, 75.0, 71.0, 69.0, 68.0, 69.0, 73.0, 67.0], "value": 70.5, "unit": "score"}]}]} 16:43:34 INFO - Return code: 0 16:43:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:43:35 INFO - # TBPL SUCCESS # 16:43:35 INFO - Running post-action listener: _resource_record_post_action 16:43:35 INFO - [mozharness: 2017-05-09 23:43:35.061988Z] Finished run-tests step (success) 16:43:35 INFO - Running post-run listener: _resource_record_post_run 16:43:35 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 365125632; Read time: 16; Write time: 216828 16:43:35 INFO - TinderboxPrint: CPU usage
12.9% 16:43:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:43:35 INFO - TinderboxPrint: I/O write bytes / time
365,125,632 / 216,828 16:43:35 INFO - TinderboxPrint: CPU idle
8,351.6 (87.0%) 16:43:35 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 16:43:35 INFO - TinderboxPrint: Swap in / out
0 / 0 16:43:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 95379456; Read time: 0; Write time: 58472 16:43:35 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 269746176; Read time: 0; Write time: 158356 16:43:35 INFO - Running post-run listener: _upload_blobber_files 16:43:35 INFO - Blob upload gear active. 16:43:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:43:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:43:35 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'] 16:43:35 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 16:43:36 INFO - (blobuploader) - INFO - Open directory for files ... 16:43:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:43:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:43:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:37 INFO - (blobuploader) - INFO - Done attempting. 16:43:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:43:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:43:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:38 INFO - (blobuploader) - INFO - Done attempting. 16:43:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:43:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:43:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:41 INFO - (blobuploader) - INFO - Done attempting. 16:43:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:43:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:43:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:42 INFO - (blobuploader) - INFO - Done attempting. 16:43:42 INFO - (blobuploader) - INFO - Iteration through files over. 16:43:42 INFO - Return code: 0 16:43:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:43:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:43:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70517f8ed445979a57c6b23b5c39f3c07f8e8d9c0b9f2ad5c2c04b20041600102384748353d91f0784e9d0148f6bf6314e8369d79364b7085e255e9ac2abd694", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04e676bb640a840eafdf526fd711ee628080a7f0ed1f85f65ec4fea717879a4cd926a6f4d18b237bddcbff36c93985d68b6d7bdb3358a8312324da8e19397c5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/075c1e3e20ff0a6aa5a56862d9d38b02ee1641b3f6ac6447a0fb9e88174ba3998f259f49c1b2e2f69a296b7b1987dd6aa8e0ad55731bdccff38544e49e4e5fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65d7cce356db9242e1ec68c2aa7f41d69025b65509c3cd1849106df6a34b68f13c77584055098fbe0034f1eb75a4ead494d149d73728c2194487799a4971ea1"} 16:43:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:43:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:43:42 INFO - Contents: 16:43:42 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70517f8ed445979a57c6b23b5c39f3c07f8e8d9c0b9f2ad5c2c04b20041600102384748353d91f0784e9d0148f6bf6314e8369d79364b7085e255e9ac2abd694", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04e676bb640a840eafdf526fd711ee628080a7f0ed1f85f65ec4fea717879a4cd926a6f4d18b237bddcbff36c93985d68b6d7bdb3358a8312324da8e19397c5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/075c1e3e20ff0a6aa5a56862d9d38b02ee1641b3f6ac6447a0fb9e88174ba3998f259f49c1b2e2f69a296b7b1987dd6aa8e0ad55731bdccff38544e49e4e5fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65d7cce356db9242e1ec68c2aa7f41d69025b65509c3cd1849106df6a34b68f13c77584055098fbe0034f1eb75a4ead494d149d73728c2194487799a4971ea1"} 16:43:42 INFO - Running post-run listener: copy_logs_to_upload_dir 16:43:42 INFO - Copying logs to upload dir... 16:43:42 INFO - mkdir: /builds/slave/test/build/upload/logs 16:43:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.522776 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-09 16:43:42.257916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 16:43:42.261818) ========= 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=920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70517f8ed445979a57c6b23b5c39f3c07f8e8d9c0b9f2ad5c2c04b20041600102384748353d91f0784e9d0148f6bf6314e8369d79364b7085e255e9ac2abd694", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04e676bb640a840eafdf526fd711ee628080a7f0ed1f85f65ec4fea717879a4cd926a6f4d18b237bddcbff36c93985d68b6d7bdb3358a8312324da8e19397c5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/075c1e3e20ff0a6aa5a56862d9d38b02ee1641b3f6ac6447a0fb9e88174ba3998f259f49c1b2e2f69a296b7b1987dd6aa8e0ad55731bdccff38544e49e4e5fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65d7cce356db9242e1ec68c2aa7f41d69025b65509c3cd1849106df6a34b68f13c77584055098fbe0034f1eb75a4ead494d149d73728c2194487799a4971ea1"} build_url:https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/UddWIBvDQoK8diXReAZw7Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70517f8ed445979a57c6b23b5c39f3c07f8e8d9c0b9f2ad5c2c04b20041600102384748353d91f0784e9d0148f6bf6314e8369d79364b7085e255e9ac2abd694", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04e676bb640a840eafdf526fd711ee628080a7f0ed1f85f65ec4fea717879a4cd926a6f4d18b237bddcbff36c93985d68b6d7bdb3358a8312324da8e19397c5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/075c1e3e20ff0a6aa5a56862d9d38b02ee1641b3f6ac6447a0fb9e88174ba3998f259f49c1b2e2f69a296b7b1987dd6aa8e0ad55731bdccff38544e49e4e5fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65d7cce356db9242e1ec68c2aa7f41d69025b65509c3cd1849106df6a34b68f13c77584055098fbe0034f1eb75a4ead494d149d73728c2194487799a4971ea1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 16:43:42.287880) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:43:42.288203) ========= 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=920470bf432669ad7e3a5387000001ca-1494372165.245848-526428746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:43:42.372795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 16:43:42.373098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 16:43:42.373386) ========= ========= Total master_lag: 0.16 =========