builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1494413546.91 results: success (0) revision: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:26.912848) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:26.913268) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:26.913563) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:26.928760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:26.929125) ========= 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=32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-10 03:52:28-- 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% 221M=0s 2017-05-10 03:52:28 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137891 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:27.081678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:27.084792) ========= 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=32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016262 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:27.134260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-10 03:52:27.134601) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 --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 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 --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=32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-10 03:52:28,397 truncating revision to first 12 chars 2017-05-10 03:52:28,397 Setting DEBUG logging. 2017-05-10 03:52:28,397 attempt 1/10 2017-05-10 03:52:28,397 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/120d8562d4a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 03:52:29,084 unpacking tar archive at: mozilla-central-120d8562d4a5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.028778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-10 03:52:28.180035) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:28.180394) ========= script_repo_revision: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:28.183823) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:28.184104) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 03:52:28.194683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-05-10 03:52:28.195049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:52:29 INFO - MultiFileLogger online at 20170510 03:52:29 in /builds/slave/test 03:52:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:52:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:52:29 INFO - {'append_to_log': False, 03:52:29 INFO - 'base_work_dir': '/builds/slave/test', 03:52:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:52:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:52:29 INFO - 'branch': 'Firefox-Non-PGO', 03:52:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:52:29 INFO - 'config_files': ('talos/linux_config.py',), 03:52:29 INFO - 'default_actions': ('clobber', 03:52:29 INFO - 'read-buildbot-config', 03:52:29 INFO - 'download-and-extract', 03:52:29 INFO - 'populate-webroot', 03:52:29 INFO - 'create-virtualenv', 03:52:29 INFO - 'install', 03:52:29 INFO - 'run-tests'), 03:52:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:52:29 INFO - 'download_minidump_stackwalk': True, 03:52:29 INFO - 'download_symbols': 'ondemand', 03:52:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:52:29 INFO - 'tooltool.py': '/tools/tooltool.py', 03:52:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:52:29 INFO - '/tools/misc-python/virtualenv.py')}, 03:52:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:52:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:52:29 INFO - 'gecko_profile': False, 03:52:29 INFO - 'gecko_profile_interval': 0, 03:52:29 INFO - 'installer_path': 'installer.exe', 03:52:29 INFO - 'log_level': 'info', 03:52:29 INFO - 'log_name': 'talos', 03:52:29 INFO - 'log_to_console': True, 03:52:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:52:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:52:29 INFO - 'opt_config_files': (), 03:52:29 INFO - 'pip_index': False, 03:52:29 INFO - 'suite': 'dromaeojs', 03:52:29 INFO - 'system_bits': '32', 03:52:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:52:29 INFO - 'title': 'talos-linux64-ix-008', 03:52:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:52:29 INFO - 'use_talos_json': True, 03:52:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:52:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:52:29 INFO - 'work_dir': 'build'} 03:52:29 INFO - [mozharness: 2017-05-10 10:52:29.554379Z] Running clobber step. 03:52:29 INFO - Running pre-action listener: _resource_record_pre_action 03:52:29 INFO - Running main action method: clobber 03:52:29 INFO - rmtree: /builds/slave/test/build 03:52:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:52:30 INFO - Running post-action listener: _resource_record_post_action 03:52:30 INFO - [mozharness: 2017-05-10 10:52:30.489409Z] Finished clobber step (success) 03:52:30 INFO - [mozharness: 2017-05-10 10:52:30.489509Z] Running read-buildbot-config step. 03:52:30 INFO - Running pre-action listener: _resource_record_pre_action 03:52:30 INFO - Running main action method: read_buildbot_config 03:52:30 INFO - Using buildbot properties: 03:52:30 INFO - { 03:52:30 INFO - "project": "", 03:52:30 INFO - "product": "firefox", 03:52:30 INFO - "who": "nobody@mozilla.org", 03:52:30 INFO - "installer_path": "public/build/target.tar.bz2", 03:52:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:52:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:52:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:52:30 INFO - "stage_platform": "linux64", 03:52:30 INFO - "basedir": "/builds/slave/test", 03:52:30 INFO - "buildnumber": 983, 03:52:30 INFO - "platform": "ubuntu64_hw", 03:52:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:52:30 INFO - "slavebuilddir": "test", 03:52:30 INFO - "taskId": "P9oLhnKcSJiJ_PIG1flC2Q", 03:52:30 INFO - "branch": "mozilla-central", 03:52:30 INFO - "script_repo_revision": "production", 03:52:30 INFO - "revision": "120d8562d4a53e4f78bd86c6f5076f6db265e5a3", 03:52:30 INFO - "slavename": "talos-linux64-ix-008", 03:52:30 INFO - "repo_path": "mozilla-central" 03:52:30 INFO - } 03:52:30 INFO - Finding installer, test and symbols from parent task. 03:52:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P9oLhnKcSJiJ_PIG1flC2Q'}, attempt #1 03:52:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P9oLhnKcSJiJ_PIG1flC2Q'}, attempt #1 03:52:34 INFO - Task dependencies: dAXFeU0MQnm-NZmdmiLGmw 03:52:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw'}, attempt #1 03:52:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.tar.bz2 03:52:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/test_packages.json 03:52:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.crashreporter-symbols.zip 03:52:34 INFO - Running post-action listener: _resource_record_post_action 03:52:34 INFO - [mozharness: 2017-05-10 10:52:34.851562Z] Finished read-buildbot-config step (success) 03:52:34 INFO - [mozharness: 2017-05-10 10:52:34.851782Z] Running download-and-extract step. 03:52:34 INFO - Running pre-action listener: _resource_record_pre_action 03:52:34 INFO - Running main action method: download_and_extract 03:52:34 INFO - mkdir: /builds/slave/test/build/tests 03:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:34 INFO - trying https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.test_packages.json 03:52:34 INFO - Downloading https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:52:35 INFO - Downloaded 986 bytes. 03:52:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:52:35 INFO - Using the following test package requirements: 03:52:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:52:35 INFO - u'common': [u'target.common.tests.zip'], 03:52:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:52:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:52:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:52:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:52:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:52:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:52:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:52:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:52:35 INFO - u'target.web-platform.tests.zip'], 03:52:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:52:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:52:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.common.tests.zip 03:52:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:52:35 INFO - Fetch https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.common.tests.zip into memory 03:52:36 INFO - Content-Length response header: 60580016 03:52:36 INFO - Bytes received: 60580016 03:52:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:52:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.common.tests.zip 03:52:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:52:46 INFO - Fetch https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.common.tests.zip into memory 03:52:47 INFO - Content-Length response header: 60580016 03:52:47 INFO - Bytes received: 60580016 03:52:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.talos.tests.zip 03:52:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:52:58 INFO - Fetch https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.talos.tests.zip into memory 03:52:59 INFO - Content-Length response header: 14409362 03:52:59 INFO - Bytes received: 14409362 03:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:59 INFO - trying https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.tar.bz2 03:52:59 INFO - Downloading https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:52:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:53:00 INFO - Downloaded 68412563 bytes. 03:53:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.tar.bz2 03:53:00 INFO - mkdir: /builds/slave/test/properties 03:53:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:53:00 INFO - Writing to file /builds/slave/test/properties/build_url 03:53:00 INFO - Contents: 03:53:00 INFO - build_url:https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.tar.bz2 03:53:00 INFO - Running post-action listener: _resource_record_post_action 03:53:00 INFO - Running post-action listener: set_extra_try_arguments 03:53:00 INFO - [mozharness: 2017-05-10 10:53:00.494300Z] Finished download-and-extract step (success) 03:53:00 INFO - [mozharness: 2017-05-10 10:53:00.494397Z] Running populate-webroot step. 03:53:00 INFO - Running pre-action listener: _resource_record_pre_action 03:53:00 INFO - Running main action method: populate_webroot 03:53:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:53:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:53:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:53:00 INFO - '--tppagecycles', 03:53:00 INFO - '7'], 03:53:00 INFO - 'tests': ['tsvgm']}}, 03:53:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:53:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:53:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:53:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:53:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:53:00 INFO - 'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:53:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:53:00 INFO - 'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['damp', 'tps']}, 03:53:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:53:00 INFO - 'tests': ['damp', 'tps']}, 03:53:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['dromaeo_dom']}, 03:53:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:53:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:53:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:53:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['a11yr', 03:53:00 INFO - 'ts_paint', 03:53:00 INFO - 'tpaint', 03:53:00 INFO - 'sessionrestore', 03:53:00 INFO - 'sessionrestore_no_auto_restore', 03:53:00 INFO - 'tabpaint']}, 03:53:00 INFO - 'other-e10s': {'tests': ['a11yr', 03:53:00 INFO - 'ts_paint', 03:53:00 INFO - 'tpaint', 03:53:00 INFO - 'sessionrestore', 03:53:00 INFO - 'sessionrestore_no_auto_restore', 03:53:00 INFO - 'tabpaint']}, 03:53:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:53:00 INFO - 'ts_paint', 03:53:00 INFO - 'tpaint', 03:53:00 INFO - 'sessionrestore', 03:53:00 INFO - 'sessionrestore_no_auto_restore', 03:53:00 INFO - 'tabpaint']}, 03:53:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:53:00 INFO - 'ts_paint', 03:53:00 INFO - 'tpaint', 03:53:00 INFO - 'sessionrestore', 03:53:00 INFO - 'sessionrestore_no_auto_restore', 03:53:00 INFO - 'tabpaint']}, 03:53:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['a11yr', 03:53:00 INFO - 'ts_paint', 03:53:00 INFO - 'tpaint', 03:53:00 INFO - 'sessionrestore', 03:53:00 INFO - 'sessionrestore_no_auto_restore', 03:53:00 INFO - 'tabpaint']}, 03:53:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['a11yr', 03:53:00 INFO - 'ts_paint', 03:53:00 INFO - 'tpaint', 03:53:00 INFO - 'sessionrestore', 03:53:00 INFO - 'sessionrestore_no_auto_restore', 03:53:00 INFO - 'tabpaint']}, 03:53:00 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:53:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:53:00 INFO - 'bloom_basic_ref']}, 03:53:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['tsvgx', 03:53:00 INFO - 'tsvgr_opacity', 03:53:00 INFO - 'tart', 03:53:00 INFO - 'tscrollx', 03:53:00 INFO - 'cart', 03:53:00 INFO - 'tsvg_static']}, 03:53:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:53:00 INFO - 'tsvgr_opacity', 03:53:00 INFO - 'tart', 03:53:00 INFO - 'tscrollx', 03:53:00 INFO - 'cart', 03:53:00 INFO - 'tsvg_static']}, 03:53:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:53:00 INFO - 'talos_options': ['--disable-e10s'], 03:53:00 INFO - 'tests': ['tp5o']}, 03:53:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:53:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:53:00 INFO - 'talos_options': ['--disable-e10s', 03:53:00 INFO - '--xperf_path', 03:53:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:00 INFO - 'tests': ['tp5n']}, 03:53:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:53:00 INFO - 'talos_options': ['--xperf_path', 03:53:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:00 INFO - 'tests': ['tp5n']}}, 03:53:00 INFO - 'talos.zip': {'path': '', 03:53:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:53:00 INFO - Running post-action listener: _resource_record_post_action 03:53:00 INFO - [mozharness: 2017-05-10 10:53:00.508146Z] Finished populate-webroot step (success) 03:53:00 INFO - [mozharness: 2017-05-10 10:53:00.508236Z] Running create-virtualenv step. 03:53:00 INFO - Running pre-action listener: _resource_record_pre_action 03:53:00 INFO - Running main action method: create_virtualenv 03:53:00 INFO - Creating virtualenv /builds/slave/test/build/venv 03:53:00 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 03:53:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:53:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:53:00 INFO - Using real prefix '/usr' 03:53:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:53:01 INFO - Installing distribute.............................................................................................................................................................................................done. 03:53:03 INFO - Installing pip.................done. 03:53:03 INFO - Return code: 0 03:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:53:03 INFO - Reading from file tmpfile_stdout 03:53:03 INFO - Output received: 03:53:03 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) 03:53:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:53:03 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')]} 03:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:03 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')]} 03:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:03 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 0x1cee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2060770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, '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': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', '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 03:53:03 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 03:53:03 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 03:53:03 INFO - Using env: {'DISPLAY': ':0', 03:53:03 INFO - 'HOME': '/home/cltbld', 03:53:03 INFO - 'LANG': 'en_US.UTF-8', 03:53:03 INFO - 'LANGUAGE': 'en_US:en', 03:53:03 INFO - 'LOGNAME': 'cltbld', 03:53:03 INFO - 'MAIL': '/var/mail/cltbld', 03:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:03 INFO - 'MOZ_NO_REMOTE': '1', 03:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:03 INFO - 'NO_EM_RESTART': '1', 03:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:03 INFO - 'PWD': '/builds/slave/test', 03:53:03 INFO - 'SHELL': '/bin/bash', 03:53:03 INFO - 'SHLVL': '1', 03:53:03 INFO - 'TERM': 'linux', 03:53:03 INFO - 'TMOUT': '86400', 03:53:03 INFO - 'USER': 'cltbld', 03:53:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:03 INFO - '_': '/tools/buildbot/bin/python'} 03:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:03 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 03:53:03 INFO - Cleaning up... 03:53:03 INFO - Return code: 0 03:53:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:53:03 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')]} 03:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:03 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')]} 03:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:03 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 0x1cee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2060770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, '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': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', '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 03:53:03 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 03:53:03 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 03:53:03 INFO - Using env: {'DISPLAY': ':0', 03:53:03 INFO - 'HOME': '/home/cltbld', 03:53:03 INFO - 'LANG': 'en_US.UTF-8', 03:53:03 INFO - 'LANGUAGE': 'en_US:en', 03:53:03 INFO - 'LOGNAME': 'cltbld', 03:53:03 INFO - 'MAIL': '/var/mail/cltbld', 03:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:03 INFO - 'MOZ_NO_REMOTE': '1', 03:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:03 INFO - 'NO_EM_RESTART': '1', 03:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:03 INFO - 'PWD': '/builds/slave/test', 03:53:03 INFO - 'SHELL': '/bin/bash', 03:53:03 INFO - 'SHLVL': '1', 03:53:03 INFO - 'TERM': 'linux', 03:53:03 INFO - 'TMOUT': '86400', 03:53:03 INFO - 'USER': 'cltbld', 03:53:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:03 INFO - '_': '/tools/buildbot/bin/python'} 03:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:03 INFO - Downloading/unpacking psutil>=3.1.1 03:53:03 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 03:53:03 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 03:53:03 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 03:53:03 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 03:53:03 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 03:53:03 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 03:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:04 INFO - Installing collected packages: psutil 03:53:04 INFO - Running setup.py install for psutil 03:53:05 INFO - building 'psutil._psutil_linux' extension 03:53:05 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 03:53:05 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 03:53:05 INFO - building 'psutil._psutil_posix' extension 03:53:05 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 03:53:05 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 03:53:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:05 INFO - Successfully installed psutil 03:53:05 INFO - Cleaning up... 03:53:05 INFO - Return code: 0 03:53:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2060770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, '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': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', '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 03:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:53:05 INFO - Using env: {'DISPLAY': ':0', 03:53:05 INFO - 'HOME': '/home/cltbld', 03:53:05 INFO - 'LANG': 'en_US.UTF-8', 03:53:05 INFO - 'LANGUAGE': 'en_US:en', 03:53:05 INFO - 'LOGNAME': 'cltbld', 03:53:05 INFO - 'MAIL': '/var/mail/cltbld', 03:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:05 INFO - 'MOZ_NO_REMOTE': '1', 03:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:05 INFO - 'NO_EM_RESTART': '1', 03:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:05 INFO - 'PWD': '/builds/slave/test', 03:53:05 INFO - 'SHELL': '/bin/bash', 03:53:05 INFO - 'SHLVL': '1', 03:53:05 INFO - 'TERM': 'linux', 03:53:05 INFO - 'TMOUT': '86400', 03:53:05 INFO - 'USER': 'cltbld', 03:53:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:05 INFO - '_': '/tools/buildbot/bin/python'} 03:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:53:05 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 03:53:05 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 03:53:05 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 03:53:05 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 03:53:05 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 03:53:05 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 03:53:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:53:06 INFO - Installing collected packages: mozsystemmonitor 03:53:06 INFO - Running setup.py install for mozsystemmonitor 03:53:07 INFO - Successfully installed mozsystemmonitor 03:53:07 INFO - Cleaning up... 03:53:07 INFO - Return code: 0 03:53:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:07 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 0x1cee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2060770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, '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': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', '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 03:53:07 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 03:53:07 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 03:53:07 INFO - Using env: {'DISPLAY': ':0', 03:53:07 INFO - 'HOME': '/home/cltbld', 03:53:07 INFO - 'LANG': 'en_US.UTF-8', 03:53:07 INFO - 'LANGUAGE': 'en_US:en', 03:53:07 INFO - 'LOGNAME': 'cltbld', 03:53:07 INFO - 'MAIL': '/var/mail/cltbld', 03:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:07 INFO - 'MOZ_NO_REMOTE': '1', 03:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:07 INFO - 'NO_EM_RESTART': '1', 03:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:07 INFO - 'PWD': '/builds/slave/test', 03:53:07 INFO - 'SHELL': '/bin/bash', 03:53:07 INFO - 'SHLVL': '1', 03:53:07 INFO - 'TERM': 'linux', 03:53:07 INFO - 'TMOUT': '86400', 03:53:07 INFO - 'USER': 'cltbld', 03:53:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:07 INFO - '_': '/tools/buildbot/bin/python'} 03:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:07 INFO - Downloading/unpacking jsonschema==2.5.1 03:53:07 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 03:53:07 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 03:53:07 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 03:53:07 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 03:53:07 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 03:53:07 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 03:53:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:53:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:53:08 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 03:53:08 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 03:53:08 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 03:53:08 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 03:53:08 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 03:53:08 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 03:53:08 INFO - Downloading functools32-3.2.3-2.tar.gz 03:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:53:08 INFO - warning: no files found matching '*.txt' 03:53:08 INFO - no previously-included directories found matching 'build' 03:53:08 INFO - no previously-included directories found matching 'dist' 03:53:08 INFO - no previously-included directories found matching '.git*' 03:53:08 INFO - Installing collected packages: jsonschema, functools32 03:53:08 INFO - Running setup.py install for functools32 03:53:08 INFO - warning: no files found matching '*.txt' 03:53:08 INFO - no previously-included directories found matching 'build' 03:53:08 INFO - no previously-included directories found matching 'dist' 03:53:08 INFO - no previously-included directories found matching '.git*' 03:53:08 INFO - Successfully installed jsonschema functools32 03:53:08 INFO - Cleaning up... 03:53:08 INFO - Return code: 0 03:53:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:53:08 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')]} 03:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:08 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')]} 03:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:08 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 0x1cee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2060770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, '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': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', '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 03:53:08 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 03:53:08 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 03:53:08 INFO - Using env: {'DISPLAY': ':0', 03:53:08 INFO - 'HOME': '/home/cltbld', 03:53:08 INFO - 'LANG': 'en_US.UTF-8', 03:53:08 INFO - 'LANGUAGE': 'en_US:en', 03:53:08 INFO - 'LOGNAME': 'cltbld', 03:53:08 INFO - 'MAIL': '/var/mail/cltbld', 03:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:08 INFO - 'MOZ_NO_REMOTE': '1', 03:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:08 INFO - 'NO_EM_RESTART': '1', 03:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:08 INFO - 'PWD': '/builds/slave/test', 03:53:08 INFO - 'SHELL': '/bin/bash', 03:53:08 INFO - 'SHLVL': '1', 03:53:08 INFO - 'TERM': 'linux', 03:53:08 INFO - 'TMOUT': '86400', 03:53:08 INFO - 'USER': 'cltbld', 03:53:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:08 INFO - '_': '/tools/buildbot/bin/python'} 03:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:53:08 INFO - Cleaning up... 03:53:08 INFO - Return code: 0 03:53:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:53:08 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')]} 03:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:08 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')]} 03:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:08 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 0x1cee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2060770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, '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': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', '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 03:53:08 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 03:53:08 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 03:53:08 INFO - Using env: {'DISPLAY': ':0', 03:53:08 INFO - 'HOME': '/home/cltbld', 03:53:08 INFO - 'LANG': 'en_US.UTF-8', 03:53:08 INFO - 'LANGUAGE': 'en_US:en', 03:53:08 INFO - 'LOGNAME': 'cltbld', 03:53:08 INFO - 'MAIL': '/var/mail/cltbld', 03:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:08 INFO - 'MOZ_NO_REMOTE': '1', 03:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:08 INFO - 'NO_EM_RESTART': '1', 03:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:08 INFO - 'PWD': '/builds/slave/test', 03:53:08 INFO - 'SHELL': '/bin/bash', 03:53:08 INFO - 'SHLVL': '1', 03:53:08 INFO - 'TERM': 'linux', 03:53:08 INFO - 'TMOUT': '86400', 03:53:08 INFO - 'USER': 'cltbld', 03:53:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:08 INFO - '_': '/tools/buildbot/bin/python'} 03:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:53:09 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 03:53:09 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 03:53:09 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 03:53:09 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 03:53:09 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 03:53:09 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 03:53:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:53:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:53:10 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 03:53:10 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 03:53:10 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 03:53:10 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 03:53:10 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 03:53:10 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 03:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:53:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:53:10 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 03:53:10 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 03:53:10 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 03:53:10 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 03:53:10 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 03:53:10 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 03:53:10 INFO - Downloading docopt-0.6.1.tar.gz 03:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:53:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:53:10 INFO - Running setup.py install for blobuploader 03:53:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:53:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:53:11 INFO - Running setup.py install for requests 03:53:11 INFO - Running setup.py install for docopt 03:53:11 INFO - Successfully installed blobuploader requests docopt 03:53:11 INFO - Cleaning up... 03:53:11 INFO - Return code: 0 03:53:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:11 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')]} 03:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:11 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')]} 03:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:11 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 0x1cee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2060770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, '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': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', '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 03:53:11 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 03:53:11 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 03:53:11 INFO - Using env: {'DISPLAY': ':0', 03:53:11 INFO - 'HOME': '/home/cltbld', 03:53:11 INFO - 'LANG': 'en_US.UTF-8', 03:53:11 INFO - 'LANGUAGE': 'en_US:en', 03:53:11 INFO - 'LOGNAME': 'cltbld', 03:53:11 INFO - 'MAIL': '/var/mail/cltbld', 03:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:11 INFO - 'MOZ_NO_REMOTE': '1', 03:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:11 INFO - 'NO_EM_RESTART': '1', 03:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:11 INFO - 'PWD': '/builds/slave/test', 03:53:11 INFO - 'SHELL': '/bin/bash', 03:53:11 INFO - 'SHLVL': '1', 03:53:11 INFO - 'TERM': 'linux', 03:53:11 INFO - 'TMOUT': '86400', 03:53:11 INFO - 'USER': 'cltbld', 03:53:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:11 INFO - '_': '/tools/buildbot/bin/python'} 03:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:11 INFO - Running setup.py (path:/tmp/pip-Tz9j92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:11 INFO - Running setup.py (path:/tmp/pip-JNTmWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:11 INFO - Running setup.py (path:/tmp/pip-bczU4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:11 INFO - Running setup.py (path:/tmp/pip-iQk1Id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:12 INFO - Running setup.py (path:/tmp/pip-b73O47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:12 INFO - Running setup.py (path:/tmp/pip-x4Ke6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:12 INFO - Running setup.py (path:/tmp/pip-F9_U2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:12 INFO - Running setup.py (path:/tmp/pip-kzoVj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:12 INFO - Running setup.py (path:/tmp/pip-RcxQ0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:12 INFO - Running setup.py (path:/tmp/pip-H4waAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:12 INFO - Running setup.py (path:/tmp/pip-I1StIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:12 INFO - Running setup.py (path:/tmp/pip-hgCnsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:12 INFO - Running setup.py (path:/tmp/pip-fqCwvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:12 INFO - Running setup.py (path:/tmp/pip-yLtOx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:12 INFO - Running setup.py (path:/tmp/pip-QLWGkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:12 INFO - Running setup.py (path:/tmp/pip-h8xrUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:12 INFO - Running setup.py (path:/tmp/pip-0hCwz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:53:12 INFO - Running setup.py install for manifestparser 03:53:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:53:13 INFO - Running setup.py install for mozcrash 03:53:13 INFO - Running setup.py install for mozdebug 03:53:13 INFO - Running setup.py install for mozdevice 03:53:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:53:13 INFO - Running setup.py install for mozfile 03:53:13 INFO - Running setup.py install for mozhttpd 03:53:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:53:13 INFO - Running setup.py install for mozinfo 03:53:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:53:13 INFO - Running setup.py install for mozInstall 03:53:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:53:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:53:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:53:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:53:13 INFO - Running setup.py install for mozleak 03:53:13 INFO - Running setup.py install for mozlog 03:53:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:53:14 INFO - Running setup.py install for moznetwork 03:53:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:53:14 INFO - Running setup.py install for mozprocess 03:53:14 INFO - Running setup.py install for mozprofile 03:53:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:53:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:53:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:53:14 INFO - Running setup.py install for mozrunner 03:53:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:53:14 INFO - Running setup.py install for mozscreenshot 03:53:14 INFO - Running setup.py install for moztest 03:53:14 INFO - Running setup.py install for mozversion 03:53:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:53:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:53:14 INFO - Cleaning up... 03:53:14 INFO - Return code: 0 03:53:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:14 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')]} 03:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:14 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')]} 03:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:14 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 0x1cee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2060770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, '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': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', '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 03:53:14 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 03:53:14 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 03:53:14 INFO - Using env: {'DISPLAY': ':0', 03:53:14 INFO - 'HOME': '/home/cltbld', 03:53:14 INFO - 'LANG': 'en_US.UTF-8', 03:53:14 INFO - 'LANGUAGE': 'en_US:en', 03:53:14 INFO - 'LOGNAME': 'cltbld', 03:53:14 INFO - 'MAIL': '/var/mail/cltbld', 03:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:14 INFO - 'MOZ_NO_REMOTE': '1', 03:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:14 INFO - 'NO_EM_RESTART': '1', 03:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:14 INFO - 'PWD': '/builds/slave/test', 03:53:14 INFO - 'SHELL': '/bin/bash', 03:53:14 INFO - 'SHLVL': '1', 03:53:14 INFO - 'TERM': 'linux', 03:53:14 INFO - 'TMOUT': '86400', 03:53:14 INFO - 'USER': 'cltbld', 03:53:14 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:14 INFO - '_': '/tools/buildbot/bin/python'} 03:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:14 INFO - Running setup.py (path:/tmp/pip-8KgO28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:15 INFO - Running setup.py (path:/tmp/pip-lbNnwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:15 INFO - Running setup.py (path:/tmp/pip-ef8oRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:15 INFO - Running setup.py (path:/tmp/pip-BbVx1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:15 INFO - Running setup.py (path:/tmp/pip-Za0ohr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:15 INFO - Running setup.py (path:/tmp/pip-n2MQVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:15 INFO - Running setup.py (path:/tmp/pip-f4Go45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:15 INFO - Running setup.py (path:/tmp/pip-PHP96v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:15 INFO - Running setup.py (path:/tmp/pip-d3ynCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:15 INFO - Running setup.py (path:/tmp/pip-VIwjF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:15 INFO - Running setup.py (path:/tmp/pip-2CqWv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:15 INFO - Running setup.py (path:/tmp/pip-Rn2uNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:15 INFO - Running setup.py (path:/tmp/pip-mLuAWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:15 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)) 03:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:15 INFO - Running setup.py (path:/tmp/pip-A8xlnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:16 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)) 03:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:16 INFO - Running setup.py (path:/tmp/pip-BEnrVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:16 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)) 03:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:16 INFO - Running setup.py (path:/tmp/pip-m1z5xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:16 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)) 03:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:16 INFO - Running setup.py (path:/tmp/pip-h6g4iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:16 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)) 03:53:16 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)) 03:53:16 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)) 03:53:16 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)) 03:53:16 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)) 03:53:16 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)) 03:53:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:53:16 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 03:53:16 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 03:53:16 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 03:53:16 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 03:53:16 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 03:53:16 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 03:53:17 INFO - Downloading blessings-1.6.tar.gz 03:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:53:17 INFO - Installing collected packages: blessings 03:53:17 INFO - Running setup.py install for blessings 03:53:17 INFO - Successfully installed blessings 03:53:17 INFO - Cleaning up... 03:53:17 INFO - Return code: 0 03:53:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:53:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:17 INFO - Reading from file tmpfile_stdout 03:53:17 INFO - Current package versions: 03:53:18 INFO - argparse == 1.2.1 03:53:18 INFO - blessings == 1.6 03:53:18 INFO - blobuploader == 1.2.4 03:53:18 INFO - docopt == 0.6.1 03:53:18 INFO - functools32 == 3.2.3-2 03:53:18 INFO - jsonschema == 2.5.1 03:53:18 INFO - manifestparser == 1.1 03:53:18 INFO - mozInstall == 1.12 03:53:18 INFO - mozcrash == 1.0 03:53:18 INFO - mozdebug == 0.1 03:53:18 INFO - mozdevice == 0.50 03:53:18 INFO - mozfile == 1.2 03:53:18 INFO - mozhttpd == 0.7 03:53:18 INFO - mozinfo == 0.9 03:53:18 INFO - mozleak == 0.1 03:53:18 INFO - mozlog == 3.4 03:53:18 INFO - moznetwork == 0.27 03:53:18 INFO - mozprocess == 0.25 03:53:18 INFO - mozprofile == 0.28 03:53:18 INFO - mozrunner == 6.13 03:53:18 INFO - mozscreenshot == 0.1 03:53:18 INFO - mozsystemmonitor == 0.3 03:53:18 INFO - moztest == 0.8 03:53:18 INFO - mozversion == 1.4 03:53:18 INFO - psutil == 3.1.1 03:53:18 INFO - requests == 1.2.3 03:53:18 INFO - wsgiref == 0.1.2 03:53:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:18 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')]} 03:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:18 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')]} 03:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:18 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 0x1cee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2060770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, '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': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', '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 03:53:18 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 03:53:18 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 03:53:18 INFO - Using env: {'DISPLAY': ':0', 03:53:18 INFO - 'HOME': '/home/cltbld', 03:53:18 INFO - 'LANG': 'en_US.UTF-8', 03:53:18 INFO - 'LANGUAGE': 'en_US:en', 03:53:18 INFO - 'LOGNAME': 'cltbld', 03:53:18 INFO - 'MAIL': '/var/mail/cltbld', 03:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:18 INFO - 'MOZ_NO_REMOTE': '1', 03:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:18 INFO - 'NO_EM_RESTART': '1', 03:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:18 INFO - 'PWD': '/builds/slave/test', 03:53:18 INFO - 'SHELL': '/bin/bash', 03:53:18 INFO - 'SHLVL': '1', 03:53:18 INFO - 'TERM': 'linux', 03:53:18 INFO - 'TMOUT': '86400', 03:53:18 INFO - 'USER': 'cltbld', 03:53:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:18 INFO - '_': '/tools/buildbot/bin/python'} 03:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:18 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)) 03:53:18 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)) 03:53:18 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)) 03:53:18 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)) 03:53:18 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)) 03:53:18 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)) 03:53:18 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)) 03:53:18 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)) 03:53:18 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)) 03:53:18 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)) 03:53:18 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)) 03:53:18 INFO - Cleaning up... 03:53:18 INFO - Return code: 0 03:53:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:53:18 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')]} 03:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:18 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')]} 03:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:18 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 0x1cee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2060770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, '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': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', '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 03:53:18 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 03:53:18 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 03:53:18 INFO - Using env: {'DISPLAY': ':0', 03:53:18 INFO - 'HOME': '/home/cltbld', 03:53:18 INFO - 'LANG': 'en_US.UTF-8', 03:53:18 INFO - 'LANGUAGE': 'en_US:en', 03:53:18 INFO - 'LOGNAME': 'cltbld', 03:53:18 INFO - 'MAIL': '/var/mail/cltbld', 03:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:18 INFO - 'MOZ_NO_REMOTE': '1', 03:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:18 INFO - 'NO_EM_RESTART': '1', 03:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:18 INFO - 'PWD': '/builds/slave/test', 03:53:18 INFO - 'SHELL': '/bin/bash', 03:53:18 INFO - 'SHLVL': '1', 03:53:18 INFO - 'TERM': 'linux', 03:53:18 INFO - 'TMOUT': '86400', 03:53:18 INFO - 'USER': 'cltbld', 03:53:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:18 INFO - '_': '/tools/buildbot/bin/python'} 03:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:53:18 INFO - Cleaning up... 03:53:18 INFO - Return code: 0 03:53:18 INFO - Running post-action listener: _resource_record_post_action 03:53:18 INFO - Running post-action listener: _start_resource_monitoring 03:53:18 INFO - Starting resource monitoring. 03:53:18 INFO - [mozharness: 2017-05-10 10:53:18.516556Z] Finished create-virtualenv step (success) 03:53:18 INFO - [mozharness: 2017-05-10 10:53:18.517082Z] Running install step. 03:53:18 INFO - Running pre-action listener: _resource_record_pre_action 03:53:18 INFO - Running main action method: install 03:53:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:18 INFO - Reading from file tmpfile_stdout 03:53:18 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:18 INFO - Reading from file tmpfile_stdout 03:53:18 INFO - Output received: 03:53:18 INFO - Usage: mozinstall [options] installer 03:53:18 INFO - Options: 03:53:18 INFO - -h, --help show this help message and exit 03:53:18 INFO - -d DEST, --destination=DEST 03:53:18 INFO - Directory to install application into. [default: 03:53:18 INFO - "/builds/slave/test"] 03:53:18 INFO - --app=APP Application being installed. [default: firefox] 03:53:18 INFO - mkdir: /builds/slave/test/build/application 03:53:18 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'] 03:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:53:35 INFO - Reading from file tmpfile_stdout 03:53:35 INFO - Output received: 03:53:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:53:35 INFO - Running post-action listener: _resource_record_post_action 03:53:35 INFO - [mozharness: 2017-05-10 10:53:35.852438Z] Finished install step (success) 03:53:35 INFO - [mozharness: 2017-05-10 10:53:35.852779Z] Running run-tests step. 03:53:35 INFO - Running pre-action listener: _resource_record_pre_action 03:53:35 INFO - Running main action method: run_tests 03:53:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:53:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:53:35 INFO - Python 2.7.3 03:53:35 INFO - Return code: 0 03:53:35 INFO - grabbing minidump binary from tooltool 03:53:35 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')]} 03:53:35 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 0x205da30>, '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 0x205e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205eca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:53:35 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 03:53:35 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 03:53:35 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 03:53:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:53:35 INFO - Return code: 0 03:53:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:53:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:53:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:53:35 INFO - ENV: RUST_BACKTRACE is now 1 03:53:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:53:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:53:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 03:53:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 03:53:35 INFO - Using env: {'DISPLAY': ':0', 03:53:35 INFO - 'HOME': '/home/cltbld', 03:53:35 INFO - 'LANG': 'en_US.UTF-8', 03:53:35 INFO - 'LANGUAGE': 'en_US:en', 03:53:35 INFO - 'LOGNAME': 'cltbld', 03:53:35 INFO - 'MAIL': '/var/mail/cltbld', 03:53:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:35 INFO - 'MOZ_NO_REMOTE': '1', 03:53:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:35 INFO - 'NO_EM_RESTART': '1', 03:53:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:35 INFO - 'PWD': '/builds/slave/test', 03:53:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:35 INFO - 'RUST_BACKTRACE': '1', 03:53:35 INFO - 'SHELL': '/bin/bash', 03:53:35 INFO - 'SHLVL': '1', 03:53:35 INFO - 'TERM': 'linux', 03:53:35 INFO - 'TMOUT': '86400', 03:53:35 INFO - 'USER': 'cltbld', 03:53:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792', 03:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:35 INFO - '_': '/tools/buildbot/bin/python'} 03:53:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 03:53:36 INFO - mozversion application_buildid: 20170510100226 03:53:36 INFO - mozversion application_changeset: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 03:53:36 INFO - mozversion application_display_name: Nightly 03:53:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:36 INFO - mozversion application_name: Firefox 03:53:36 INFO - mozversion application_remotingname: firefox 03:53:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:53:36 INFO - mozversion application_vendor: Mozilla 03:53:36 INFO - mozversion application_version: 55.0a1 03:53:36 INFO - mozversion platform_buildid: 20170510100226 03:53:36 INFO - mozversion platform_changeset: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 03:53:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:53:36 INFO - mozversion platform_version: 55.0a1 03:53:36 INFO - using testdate: 1494413616 03:53:36 INFO - actual date: 1494413616 03:53:36 INFO - starting webserver on 'localhost:53941' 03:53:36 INFO - SUITE-START | Running 2 tests 03:53:36 INFO - TEST-START | dromaeo_css 03:53:36 INFO - operating with platform_type : linux_ 03:53:36 INFO - Initialising browser for dromaeo_css test... 03:53:36 INFO - TEST-INFO | started process 27711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnhqqFN/profile http://localhost:53941/getInfo.html) 03:53:39 INFO - PID 27711 | __metrics Screen width/height:1600/1200 03:53:39 INFO - PID 27711 | colorDepth:24 03:53:39 INFO - PID 27711 | Browser inner width/height: 1024/695 03:53:39 INFO - PID 27711 | __metrics 03:53:40 INFO - PID 27711 | 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" 03:53:40 INFO - PID 27711 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:53:41 INFO - TEST-INFO | 27711: exit 0 03:53:41 INFO - Browser initialized. 03:53:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:53:41 INFO - TEST-INFO | started process 27807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnhqqFN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:53 INFO - PID 27807 | RSS: Main: 144621568 03:53:53 INFO - PID 27807 | 03:56:56 INFO - PID 27807 | Cycle 1(1): loaded http://localhost:53941/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53941/tests/dromaeo/cssquery-ext.html) 03:56:57 INFO - PID 27807 | RSS: Main: 256933888 03:56:57 INFO - PID 27807 | 03:59:59 INFO - PID 27807 | Cycle 1(1): loaded http://localhost:53941/tests/dromaeo/cssquery-ext.html (next: http://localhost:53941/tests/dromaeo/cssquery-jquery.html) 04:00:00 INFO - PID 27807 | RSS: Main: 233021440 04:00:00 INFO - PID 27807 | 04:03:01 INFO - PID 27807 | Cycle 1(1): loaded http://localhost:53941/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53941/tests/dromaeo/cssquery-mootools.html) 04:03:02 INFO - PID 27807 | RSS: Main: 177311744 04:03:02 INFO - PID 27807 | 04:06:04 INFO - PID 27807 | Cycle 1(1): loaded http://localhost:53941/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53941/tests/dromaeo/cssquery-prototype.html) 04:06:05 INFO - PID 27807 | RSS: Main: 189988864 04:06:05 INFO - PID 27807 | 04:09:07 INFO - PID 27807 | Cycle 1(1): loaded http://localhost:53941/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53941/tests/dromaeo/cssquery-yui.html) 04:09:08 INFO - PID 27807 | RSS: Main: 177078272 04:09:08 INFO - PID 27807 | 04:12:10 INFO - PID 27807 | Cycle 1(1): loaded http://localhost:53941/tests/dromaeo/cssquery-yui.html (next: http://localhost:53941/tests/dromaeo/cssquery-dojo.html) 04:12:10 INFO - PID 27807 | RSS: Main: 266878976 04:12:10 INFO - PID 27807 | 04:12:10 INFO - PID 27807 | __start_tp_report 04:12:10 INFO - PID 27807 | _x_x_mozilla_page_load 04:12:10 INFO - PID 27807 | _x_x_mozilla_page_load_details 04:12:10 INFO - PID 27807 | |i|pagename|runs| 04:12:10 INFO - PID 27807 | |0;dojo.html;3426.434638284683;3431.879884204052;3446.4313388290934;3475.9826200868993;3491.0574144980856;5842.503387212092;5979.581429299951;6022.427869352416;6029.186059881915;6044.24446944132;5876.618019828708;5912.615679980809;5923.822285331436;5931.169636250928;5960.970195149029;5219.269302297691;5303.469653034685;5314.521693047625;5323.60072994525;5340.759665815028;5387.78448862045;5416.133418653017;5419.59353048521;5420.756065977021;5421.566274698014;5250.921236181442;5376.489233522809;5409.080456322435;5449.455054494559;5458.781648734066;5163.8192663256605;5216.895662086737;5304.92042619361;5320.840374788762;5399.811006614769;5244.842654720364;5270.4729527047375;5323.22813192085;5338.46615338463;5338.492843179892;5924.289085309747;5934.673592952386;5960.523158147381;5968.432998865101;5980.342162362137;6290.119383286344;6485.286618471964;6500.382463665944;6503.837404064889;6504.284528701839;6410.2628197757385;6443.548951573392;6475.967620161916;6565.310642382528;6567.343265673395;6021.909671354933;6022.45797878193;6030.260366059201;6030.758769649165;6087.96956015226;6554.475641948633;6568.244651865097;6608.8347791305605;6619.271880093186;6631.966840165865;6206.224221972254;6293.181886354836;6310.652914089677;6338.809835704937;6403.295637479873;6232.937670623326;6311.684415779193;6336;6418.807435776934;6497.480201583862;6377.617342959345;6480.25477070143;6495.3179916109075;6499.707513161919;6503.902441463382;6296.464800492009;6515.348465153446;6522.21733391996;6527.3472652734345;6529.640869752209;4872.8781780455065;4877.634177436636;4879.268109783561;4880.438749543848;4882.414110306786;4362.825486980549;4408.360787685831;4409.691321607521;4411.1618792429335;4412.0955204183065;6073.392660733891;6097.908531372033;6098.908516372258;6100.633961962297;6105.877882442326;6383.265924418658;6415.166028416369;6432.71052802625;6541.967290163519;6543.378379053982;6158.199434073542;6173.84565385869;6177.81466556004;6184.103305020837;6187.504999600022;5674.460926212003;5679.290088738908;5679.432056794288;5683.516901063374;5698.544116470673;6624.536282460182;6711.597304161668;6721.1598550181225;6862.3137686230975;6880.449564034865;6505.544611877123;6525.543211975116;6540.182477190351;6541.672916354259;6547.934520654732;6838;6841.657917104026;6845.110135682329;6846.5892046477375;6853.074834897225;6235.251769787655;6326.145970294136;6410.5192110592825;6419.101325814297;6425.132607098169;6334.303226645157;6409;6549.803505894831;6560.967195163994;6567.573107747981;6356.173697419306;6373.8725225496155;6377.74489020434;6380.680965951591;6385.840353991188;6299.937000629935;6311.463525600376;6338.841528961812;6374.139491168633;6376.553641245254;6129.236538068469;6181.81454556364;6219.067139928866;6313.116163736989;6333.809985700436;6323.7786677466065;6370.394812492806;6372.139761132188;6383.6808159592765;6389.9680501597195;6041.395860413923;6066.666333351708;6125.019996800491;6171.413715697002;6181.258249010148 04:12:10 INFO - PID 27807 | |1;ext.html;726.3934614596811;776.6039319946827;786.4416264452241;1142.7828712544622;1173.354654939783;28583.285417864565;33263.66736332639;36063.639363606424;36074;36126.27747445053;37421.62578374215;37679.62320376795;37703.4344484833;37756;37799.43300850483;5564.4713752193475;7028.543144695591;7142.1429428468655;7154;7155.034070400481;5614.2701448811595;7066.293370662944;7225.963870180642;7232.529885557448;7237.167725711558;7305.890411643803;7342.559446433204;7346.375558077543;7350;7353.301436363537;5526.557875370001;7265.164506081789;7282.417406607458;7314.26857314267;7327.816804579875;5518.172274158868;7000.124984376953;7159.67781449836;7175.210726820045;7178.569285842814;34681.30637387238;34784.30431391383;34955.65044349549;34980.47529287063;35093.29813403718;3381.5096810962273;3417.3848707232687;3421.726261899042;3422.349753546818;3427.091820667525;27420.314492137655;27428.177154685392;27436.17691469259;27449.725502744917;27632.171034868985;3627.6916462100753;3643.981780091083;3646.3254297954963;3646.507721457596;3651.7991510466913;190022;190112;190339;190976;192687;46277.7686111574;46371.30443043357;46451.30323045157;46452.30321545179;46571.30143047857;49152.01695966061;49155.508444915096;49166.75416622894;49262.753686232056;49321;14003.369848356848;14068.577942661737;14080.71838563223;14086.577402677936;14092.718145637029;9294.72115836526;9485.241180705527;11407.714807129889;11412.942935285437;11425.31448113116;12252;12305.507779688713;12321.876781232073;12577.182483138567;12595.118341715992;5159.974200128975;5275.657082289639;5296.602754793406;5345.893082138336;5394.352677678704;1034.5034383495813;1085.2186425773589;1090.1387903556101;1093.7648405592677;1114.777044591085;25318.746812531637;25364.873175634373;25366.1121860734;25506.872465637553;25545.23364299074;1167.976640467203;1170.414792603698;1171.8285283737243;1178.8467499225046;1199.064729510983;12951.834334909714;13011.609651710463;13107.606771796862;13198;13227.404766785517;223538;225046;225248;225856;226076;48420;48532.27201591979;48541.75729121332;48568.27147592789;48579.5142048575;1424.9928750356182;1452.4661041432387;1485.866272035522;1492.5074725340612;1498.3706843125913;23297.068117275798;24414.511709766062;24597;24652;24677.259682209562;35674.8216258917;35906.28187436289;35946.64053359433;35952.225016372904;35990;195831;196138;196595;196740;197541;29064.564031539965;29505.11484655464;31687.52468712925;32284.192895176868;32814.17964550905;37694;37981;39290.410643840936;39605.60394396019;39621.60378396179;29326;29671.40657186801;29990.100296991124;30050.849745751133;30124.84937575298;30123.54814677738;30371.544426833174;30478.390432191674;31312.843435782674;31502.52746208763;35857.262837945804;35923.82038089897;35929;36056.819715901256;36173.27653446969;30506.237344066576;30705.846470767505;30926.38147237088;31458.37083258276;31503.84248078745;24975.500489989736;25918.22245332643;25995.524386101348;26289;26453.735462645127 04:12:10 INFO - PID 27807 | |2;jquery.html;416.91036427168154;445.2119748045957;446.4976900986391;452;471.17309122490025;18844.623107537856;19763.209471621136;20352;20556.794432055674;20620.89689551552;19779;20123.39629811104;20130.09414576344;21786.89106554469;22298.442538936535;5496.972515137419;5697.715114244292;5699.401562835905;5702.258706368167;5711.171880077386;5339.679619222839;5494.945050549483;5538.224648549206;5628.634138780986;5695.03184458643;5492.176173573956;5503.2020357048405;5506.972465137669;5507.476789704971;5508.614396992212;5353.197020446925;5445.401005889349;5479;5484.670919744828;5512.118061110224;5005.799768009275;5016.724080175589;5020.598352131858;5024.196128619404;5026.773795179226;25917.61123583148;26653.866730666417;26921.865390673116;27052.323691907663;27331.86334068337;2129.9787002130092;2181.825453963679;2184.923527676524;2185.2242453928943;2185.7049298344677;16701.83298167027;17156.485305440856;17272.30910763568;17374;17706.29174833005;2088.3839267416147;2147.248463037924;2161.567686462698;2187.157944191482;2196.8681879087144;108427.90920716122;110664.4466777669;110794.44602776934;111305;114149.85850141475;12703.93648031754;12704.936475317565;12714;12999.675008124683;13218;18154.18306176225;18223.817761822476;18230.361937332396;18250.36123735663;18255.543611409554;8644.351673624504;8784.209421152127;8910.331725120643;8974.237189838806;8975.820483590292;8062.596870156469;8109.959450202711;8189.1401402853035;8369.288610468178;8378.8324233515;7770.261825126604;7943.24539168778;7976.481528700616;8019.879701804478;8053.879191812128;2112.8943552822298;2124.214040804912;2131.4138611881544;2152.0853637204127;2290.2900100968754;998.9800203996025;1024.99487502562;1055.0978913029403;1062.511244827388;1081.9729506762237;20533.38399848007;21050.578988420453;21085.472863178544;21244;21514.354569362946;1040.4641609571077;1050.4590136079926;1055.150603763962;1065.7655315830505;1084.6529110684662;11271.323720576627;11675.708107297385;11707.121965852595;11752.58865939688;11776.70558236051;471092;473206;478155;478340;479758;99766.5011674937;100517;103308;103344;107583.46208268909;1237.3442075699893;1242.236024844714;1281.0392205845617;1294.3528235882059;1296.3323888197397;20494.48763780858;20896.37310880676;21631.891840540695;21657.566848663253;21730;42869.356959646255;45902.73750724902;47871;48396;49865.501344986085;59971.10043349441;60560;60909;61025;61500.69249653723;8740.825183496167;9148.451092934445;9450.243980481682;10023.799524009333;10279.331843430153;16054.919725401765;16225.756613651041;16233.18834058316;16345.754813678042;16463.670726585642;13753.312334383041;13904;13913.095648782797;13930.791038134234;14026.29868506591;12253;12381.133320667466;12656.114072015238;12710.618681439571;13269.867301326864;14027.929860350632;14110.576682699535;14349.354279057676;14491.637709056937;14517.85482145165;9339.57971891253;9351.85972210431;9422.199113075465;9534.713958581253;9653.46905920181;13576.52482163159;13757.724845503235;13758.174509529461;13790.862091378958;14077.084989475652 04:12:10 INFO - PID 27807 | |3;mootools.html;1152.4929031226254;1284.7173621803204;1327.9601611951646;1346.9595912122627;1360.2110775750066;9461.621535138585;11036.944815275923;11353.716157096076;11371.601993930213;11392.202545821796;11120.833187502194;11193.552257909674;11205.551777928873;11219.102471802256;11229.887701122987;1973.506623344164;2310.861348319102;2345.566070277004;2348.9177878774244;2349.4713689419914;2062.3194345865827;2285.337252196861;2348.6946696929376;2369.0050178924807;2372.2764556810166;2336.334144768741;2349.7650234976536;2350.529894021194;2356.5051339218785;2358.1864256831363;2246.640537514006;2249.6063188941953;2251.4371407148133;2254.7632498587577;2259.2883241778786;2179.9891000545053;2191.22211614876;2199.285232299493;2199.615067363221;2201.086549082129;10902.61840835575;10939.12487001038;10995.505202265836;11054.944725276402;11072.280301780358;6314.778982735582;6539.5749276297365;6549.6070235786;6550;6560.835979100513;3672;3744.588095309541;3898.961010389888;3904.4728961590104;3918.3534716771696;1309.8559158492558;1340.6648337915522;1356.3760670091672;1427.136582367663;1451.811264535614;16781.24484398205;16800.915995420066;16895.324187032627;16912.915435422867;16975.745363819427;5388.137897936312;5566.415526369754;5614.63504872182;5618.494335509824;5765.971170144123;14323.283835808168;14374.425022998963;14385;14390.841373794015;14399.424023039172;6247.500199983991;6478;6530.444912182517;6544.083828264047;6643.169603799525;5089.440161582223;5156.123459011977;6008.489278411296;6057.848553786191;6060.606060606046;4093.1202223766977;4534.77326133692;4554.612857907115;4641.443026836801;4740.715557066587;1439.9280035998368;1446.4937271954732;1455.32327467728;1473.7126260379337;1482.2440555316866;853.2363534636465;860.2257967829004;862.8144948835904;870.525563567857;904.9819003619891;6970.756023539152;7171.282871712787;7179.784606461814;7204.351608355273;7337.523061001125;981.764376549623;985.5170966226498;987.8024395121005;999.5052449037773;999.5951639585979;4101.441452248127;4233.5131459882505;4283.121959998193;4344.891377715519;4376.081022985209;14906.850931490762;15467.303971321093;15483.612909677124;15493.612659683598;15514.767278490832;15150.621234469007;15210.136093846817;15332.15673137988;15356.385744570092;15374.231288435534;9232.815343693088;9431.434113953184;9496.762580935532;9514.096160864707;9516.714498565054;6854.451643868579;6917.584944903322;6939.271376505394;6973.302669733189;7010.334018268256;13379.130356526795;13406.195628262336;13718;13723.588292350845;13791.448342066205;13804.792928105886;13874.445022199;14128.576142715736;14175.929120354745;14425.062370945854;9421.481818500048;9555.474448905377;9584.66453674118;9586.514090316012;9589.712308630753;9730.221582273543;10531.736706582396;11021.889781102407;11161.609343672932;11174.27367221128;9111.17999380059;9173.633054677739;9326.72019839406;9389.671361502315;9665.806683866424;9157.450552966844;9197.356185066981;9216.2626989842;9267;9295.30285228597;7972.960135199287;8190.624718831472;8224.876626850482;8261;8287.585620718819;6090.908636370546;6108.908366374597;6175.783847565313;6176.69116544162;6372.840678983062;6103.389661033861;6148.846278843064;6162.599431036968;6220.688965551613;6329.17720696325 04:12:10 INFO - PID 27807 | |4;prototype.html;398.440191530899;406.790502891011;407.03735665151925;409.1096403906401;416.82285028862736;5503.862403439916;5930.436608522189;5940.287165540136;5984.850378740528;6028.69856507174;5540.695261760601;5727.799527016556;5736.856578585537;5814.854628634275;5888.499477544403;4510.210713125206;4579.931301030479;4593.242115051013;4633.096546173498;4667.276572131325;4621.768911554425;4646.047560250157;4653.790014596196;4656.996237426874;4672.345871577982;4502.4371953505815;4571.725696458223;4619.468761092467;4620.214563524209;4637.165310244155;4611.930821037688;4628.09752098341;4637.65217608679;4640.118377508263;4644.9535504644855;4226.535081141072;4234.17433600448;4243.554426785174;4244.936325955113;4245.341971994346;5623.831285061455;5703.258576385085;5714.857128571777;5739.62692424991;5810.070388737824;5486.231927530149;5552.472515111099;5566.86082847928;5569;5586.525145362649;6195.535334849904;6269.467095296905;6275.403836635513;6292.905606415908;6319.58922670025;4777.856664300077;4787.234042553209;4787.832425865113;4790.137775200463;4797.352357431737;6582.835429114262;6609.93390066098;6647.567908085959;6648.634325112117;6660.300668429793;4743.383360163226;4894.26586012094;4941.481144479778;4965.751712414365;4968.30443737877;5082.161443361804;5084.821986258588;5090.974545127325;5095.668781529189;5095.719735414587;5459.874863303427;5472.124460086447;5554.139363313336;5561.6663000220115;5577.581681373913;6344.111824344595;6348.238211414568;6352.6823658816875;6366.172397588284;6402.935970640234;1642.8767842411867;1687.6202854357916;1692.4753326468833;1717.3388245525562;1740.26908698347;1212.4604550974732;1223.7150991458932;1228.91397602167;1231.3658465890073;1236.3756303067073;5968.253968253968;6013.428724271274;6026.758929642853;6041.184440100618;6049.243844519435;6386.2975072741965;6429;6439.678016099177;6450.322916041769;6458.930873549633;5802.274715660543;5908;5966.164736936832;5982.982892908216;6009;3359.798412095282;3399.4390925497014;3407.5740532433447;3407.9148021299666;3428.434308339146;6510.479161667055;6634.369734875179;6659.367360100783;6684.264730879697;6720.260771315151;6539.476841852736;6542.574732642363;6546.607203567801;6573.5398522103;6578.3092775258865;6479.8056058318325;6627.502937279627;6693.497987651043;6713.798586042329;6719.496037797185;6387.498937749718;6388.4569811566535;6404.583702059537;6425.678716064272;6442.645654489048;6150.938490615036;6359.55483116196;6362.650054247061;6369.777057802955;6382;6635.469162467088;6644.60132392058;6658.201015878126;6672.065910772592;6680.799576012728;4901.730404827768;4907.55831975124;4927.236278376858;4941.77762000718;4942.678725882806;6099.268087829489;6244.4380005797875;6274.937250627435;6375.171227740364;6444.485545896804;6066.939330606638;6187.659678717714;6202.131701561875;6226;6252.718627661675;6084.60450070744;6225.252969643671;6227.283862355705;6241.937580624136;6258.186435763321;6196.318404975359;6232.127502149793;6247.96876015617;6248.625082495065;6274.905876411949;6186.350433204629;6215.34738852414;6219;6258.624482531062;6258.655773932477;5965.550764015152;6052.576319657582;6077.574569780073;6096.268447786294;6099.207103076749 04:12:10 INFO - PID 27807 | |5;yui.html;717.7344382578447;732.8900664900265;754.9320561149495;765.3341592814251;776.7048521561806;14185.14889106653;14874;14895.92552037241;14941.954063215593;14983.550493485212;13448.798268025963;14530.782038269408;14589.854101458983;14606.561803145923;14624.853751462482;960.2414092866644;981.0728861226108;981.4994352880046;981.8085473332703;985.256131620629;991.1377101921339;991.7669347703284;997.5860018092483;998.3810037776552;998.4009594243432;1036.0571879589575;1040.3029969920133;1041.3595638682193;1041.8020576090557;1043.8695163104612;999.3953658036928;1006.6828948881152;1018.6689325969015;1020.5611587017579;1031.5048776587244;743.6096049573963;745.6085555083624;745.7501736918084;746.1009483572283;746.3245762584816;12878.549250776272;12911.806322905164;13011.089223754341;13035.608931732064;13040.478380864753;15534.378624854991;15581.844181558152;15942.760858587131;16065.759013614805;16078.035317880964;12161.331126788024;12409.813852792215;12477.064220183522;12483.375831208494;12494.937525312405;2986.7013298670176;3196.9200769980703;3277.6394596594355;3293.604767427924;3302.3890580242733;87680.56159719224;90432;90435;90475.54762226212;92519;13796.448142074205;13961.65095872591;14133.434662613381;14162;14166.150030998173;25621.3594660135;25862.6120608191;25901.870490647427;26428.603570946452;26607.46785064288;6937.549059311129;7059.18819335783;7088.7518936838;7119.6084215368655;7124.43004559634;3829.8276577554075;3924.7448915820382;3925.9607403925597;3942.250972315251;3957.8021098945514;4069.5116586009867;4123.299039163349;4183.895402614959;4184.267753143188;4188.623023927861;792.861249281385;815.5881279953585;816.0941355095839;816.9714060007872;817.1093508076225;613.7115555688819;625.1373105114913;629.0784001437916;637.1589501857596;647.1102234427661;10945.616903408343;11421.600243991421;11598.246114002563;11827.2903625781;12224.511019559119;668.301624802083;685.9759908403182;690.1063123255396;693.2339764560088;698.3958875572594;5079;5137.306463627438;5247.711375874287;5293.391260005072;5318.215830760613;77670.6116469414;78513.60743196247;80796.59601702071;80826.59586702028;84037;74699;76090;76337.61831190808;76965.61517192378;77945.61027194827;52087;62754.90706965397;64324.035139472944;64516.354836451974;64726.352736472974;12670.809937850756;13510.054296199172;13511.121777084458;13522;13544.661383465493;34304.656953430145;34557.29804582216;34728;34755.478667820506;36355.81822090979;40510.392344115455;41177.1764564713;42024.369634454895;42101.57898421099;42738.35892461553;15173.468928587446;15336.156511391535;15409.537713868154;15543.300551474984;15785.447509337118;16596.58508537296;17602.647947041245;17624.55938601545;17688.55778605545;17892;17094.91452542729;17508.82491175072;17597.736033959245;17607.823921760617;17611.911940440215;15738.370465181264;15808.60478488047;15830.129342885792;16079.67840643204;16169.838301617303;15766.76349854776;15882.920585397;15993.1203783793;16235.107069111313;16339.673206535565;11666.824997624874;11905.880941190824;12001.579944701894;12041;12175.817362739743;13793;14170.787438188228;14191.07757995727;14191.64520886986;14302.713945721236 04:12:10 INFO - PID 27807 | __end_tp_report 04:12:10 INFO - PID 27807 | __start_cc_report 04:12:10 INFO - PID 27807 | _x_x_mozilla_cycle_collect,1149 04:12:10 INFO - PID 27807 | __end_cc_report 04:12:10 INFO - PID 27807 | __startTimestamp1494414730322__endTimestamp 04:12:10 INFO - PID 27807 | 04:12:10 INFO - PID 27807 | ------- Summary: start ------- 04:12:10 INFO - PID 27807 | Number of tests: 6 04:12:10 INFO - PID 27807 | 04:12:10 INFO - PID 27807 | [#0] dojo.html Cycles:165 Average:5979.42 Median:6206.22 stddev:716.54 (11.5%) stddev-sans-first:690.18 04:12:10 INFO - PID 27807 | Values: 3426.4 3431.9 3446.4 3476.0 3491.1 5842.5 5979.6 6022.4 6029.2 6044.2 5876.6 5912.6 5923.8 5931.2 5961.0 5219.3 5303.5 5314.5 5323.6 5340.8 5387.8 5416.1 5419.6 5420.8 5421.6 5250.9 5376.5 5409.1 5449.5 5458.8 5163.8 5216.9 5304.9 5320.8 5399.8 5244.8 5270.5 5323.2 5338.5 5338.5 5924.3 5934.7 5960.5 5968.4 5980.3 6290.1 6485.3 6500.4 6503.8 6504.3 6410.3 6443.5 6476.0 6565.3 6567.3 6021.9 6022.5 6030.3 6030.8 6088.0 6554.5 6568.2 6608.8 6619.3 6632.0 6206.2 6293.2 6310.7 6338.8 6403.3 6232.9 6311.7 6336.0 6418.8 6497.5 6377.6 6480.3 6495.3 6499.7 6503.9 6296.5 6515.3 6522.2 6527.3 6529.6 4872.9 4877.6 4879.3 4880.4 4882.4 4362.8 4408.4 4409.7 4411.2 4412.1 6073.4 6097.9 6098.9 6100.6 6105.9 6383.3 6415.2 6432.7 6542.0 6543.4 6158.2 6173.8 6177.8 6184.1 6187.5 5674.5 5679.3 5679.4 5683.5 5698.5 6624.5 6711.6 6721.2 6862.3 6880.4 6505.5 6525.5 6540.2 6541.7 6547.9 6838.0 6841.7 6845.1 6846.6 6853.1 6235.3 6326.1 6410.5 6419.1 6425.1 6334.3 6409.0 6549.8 6561.0 6567.6 6356.2 6373.9 6377.7 6380.7 6385.8 6299.9 6311.5 6338.8 6374.1 6376.6 6129.2 6181.8 6219.1 6313.1 6333.8 6323.8 6370.4 6372.1 6383.7 6390.0 6041.4 6066.7 6125.0 6171.4 6181.3 04:12:10 INFO - PID 27807 | 04:12:10 INFO - PID 27807 | [#1] ext.html Cycles:180 Average:36161.57 Median:33038.92 stddev:53082.07 (160.7%) stddev-sans-first:53164.30 04:12:10 INFO - PID 27807 | Values: 726.4 776.6 786.4 1142.8 1173.4 28583.3 33263.7 36063.6 36074.0 36126.3 37421.6 37679.6 37703.4 37756.0 37799.4 5564.5 7028.5 7142.1 7154.0 7155.0 5614.3 7066.3 7226.0 7232.5 7237.2 7305.9 7342.6 7346.4 7350.0 7353.3 5526.6 7265.2 7282.4 7314.3 7327.8 5518.2 7000.1 7159.7 7175.2 7178.6 34681.3 34784.3 34955.7 34980.5 35093.3 3381.5 3417.4 3421.7 3422.3 3427.1 27420.3 27428.2 27436.2 27449.7 27632.2 3627.7 3644.0 3646.3 3646.5 3651.8 190022.0 190112.0 190339.0 190976.0 192687.0 46277.8 46371.3 46451.3 46452.3 46571.3 49152.0 49155.5 49166.8 49262.8 49321.0 14003.4 14068.6 14080.7 14086.6 14092.7 9294.7 9485.2 11407.7 11412.9 11425.3 12252.0 12305.5 12321.9 12577.2 12595.1 5160.0 5275.7 5296.6 5345.9 5394.4 1034.5 1085.2 1090.1 1093.8 1114.8 25318.7 25364.9 25366.1 25506.9 25545.2 1168.0 1170.4 1171.8 1178.8 1199.1 12951.8 13011.6 13107.6 13198.0 13227.4 223538.0 225046.0 225248.0 225856.0 226076.0 48420.0 48532.3 48541.8 48568.3 48579.5 1425.0 1452.5 1485.9 1492.5 1498.4 23297.1 24414.5 24597.0 24652.0 24677.3 35674.8 35906.3 35946.6 35952.2 35990.0 195831.0 196138.0 196595.0 196740.0 197541.0 29064.6 29505.1 31687.5 32284.2 32814.2 37694.0 37981.0 39290.4 39605.6 39621.6 29326.0 29671.4 29990.1 30050.8 30124.8 30123.5 30371.5 30478.4 31312.8 31502.5 35857.3 35923.8 35929.0 36056.8 36173.3 30506.2 30705.8 30926.4 31458.4 31503.8 24975.5 25918.2 25995.5 26289.0 26453.7 04:12:10 INFO - PID 27807 | 04:12:10 INFO - PID 27807 | [#2] jquery.html Cycles:180 Average:31118.01 Median:11833.22 stddev:79388.09 (670.9%) stddev-sans-first:79577.33 04:12:10 INFO - PID 27807 | Values: 416.9 445.2 446.5 452.0 471.2 18844.6 19763.2 20352.0 20556.8 20620.9 19779.0 20123.4 20130.1 21786.9 22298.4 5497.0 5697.7 5699.4 5702.3 5711.2 5339.7 5494.9 5538.2 5628.6 5695.0 5492.2 5503.2 5507.0 5507.5 5508.6 5353.2 5445.4 5479.0 5484.7 5512.1 5005.8 5016.7 5020.6 5024.2 5026.8 25917.6 26653.9 26921.9 27052.3 27331.9 2130.0 2181.8 2184.9 2185.2 2185.7 16701.8 17156.5 17272.3 17374.0 17706.3 2088.4 2147.2 2161.6 2187.2 2196.9 108427.9 110664.4 110794.4 111305.0 114149.9 12703.9 12704.9 12714.0 12999.7 13218.0 18154.2 18223.8 18230.4 18250.4 18255.5 8644.4 8784.2 8910.3 8974.2 8975.8 8062.6 8110.0 8189.1 8369.3 8378.8 7770.3 7943.2 7976.5 8019.9 8053.9 2112.9 2124.2 2131.4 2152.1 2290.3 999.0 1025.0 1055.1 1062.5 1082.0 20533.4 21050.6 21085.5 21244.0 21514.4 1040.5 1050.5 1055.2 1065.8 1084.7 11271.3 11675.7 11707.1 11752.6 11776.7 471092.0 473206.0 478155.0 478340.0 479758.0 99766.5 100517.0 103308.0 103344.0 107583.5 1237.3 1242.2 1281.0 1294.4 1296.3 20494.5 20896.4 21631.9 21657.6 21730.0 42869.4 45902.7 47871.0 48396.0 49865.5 59971.1 60560.0 60909.0 61025.0 61500.7 8740.8 9148.5 9450.2 10023.8 10279.3 16054.9 16225.8 16233.2 16345.8 16463.7 13753.3 13904.0 13913.1 13930.8 14026.3 12253.0 12381.1 12656.1 12710.6 13269.9 14027.9 14110.6 14349.4 14491.6 14517.9 9339.6 9351.9 9422.2 9534.7 9653.5 13576.5 13757.7 13758.2 13790.9 14077.1 04:12:10 INFO - PID 27807 | 04:12:10 INFO - PID 27807 | [#3] mootools.html Cycles:180 Average:7218.22 Median:3901.72 stddev:4670.43 (119.7%) stddev-sans-first:4661.29 04:12:10 INFO - PID 27807 | Values: 1152.5 1284.7 1328.0 1347.0 1360.2 9461.6 11036.9 11353.7 11371.6 11392.2 11120.8 11193.6 11205.6 11219.1 11229.9 1973.5 2310.9 2345.6 2348.9 2349.5 2062.3 2285.3 2348.7 2369.0 2372.3 2336.3 2349.8 2350.5 2356.5 2358.2 2246.6 2249.6 2251.4 2254.8 2259.3 2180.0 2191.2 2199.3 2199.6 2201.1 10902.6 10939.1 10995.5 11054.9 11072.3 6314.8 6539.6 6549.6 6550.0 6560.8 3672.0 3744.6 3899.0 3904.5 3918.4 1309.9 1340.7 1356.4 1427.1 1451.8 16781.2 16800.9 16895.3 16912.9 16975.7 5388.1 5566.4 5614.6 5618.5 5766.0 14323.3 14374.4 14385.0 14390.8 14399.4 6247.5 6478.0 6530.4 6544.1 6643.2 5089.4 5156.1 6008.5 6057.8 6060.6 4093.1 4534.8 4554.6 4641.4 4740.7 1439.9 1446.5 1455.3 1473.7 1482.2 853.2 860.2 862.8 870.5 905.0 6970.8 7171.3 7179.8 7204.4 7337.5 981.8 985.5 987.8 999.5 999.6 4101.4 4233.5 4283.1 4344.9 4376.1 14906.9 15467.3 15483.6 15493.6 15514.8 15150.6 15210.1 15332.2 15356.4 15374.2 9232.8 9431.4 9496.8 9514.1 9516.7 6854.5 6917.6 6939.3 6973.3 7010.3 13379.1 13406.2 13718.0 13723.6 13791.4 13804.8 13874.4 14128.6 14175.9 14425.1 9421.5 9555.5 9584.7 9586.5 9589.7 9730.2 10531.7 11021.9 11161.6 11174.3 9111.2 9173.6 9326.7 9389.7 9665.8 9157.5 9197.4 9216.3 9267.0 9295.3 7973.0 8190.6 8224.9 8261.0 8287.6 6090.9 6108.9 6175.8 6176.7 6372.8 6103.4 6148.8 6162.6 6220.7 6329.2 04:12:10 INFO - PID 27807 | 04:12:10 INFO - PID 27807 | [#4] prototype.html Cycles:180 Average:5323.74 Median:5965.86 stddev:1512.65 (25.4%) stddev-sans-first:1471.03 04:12:10 INFO - PID 27807 | Values: 398.4 406.8 407.0 409.1 416.8 5503.9 5930.4 5940.3 5984.9 6028.7 5540.7 5727.8 5736.9 5814.9 5888.5 4510.2 4579.9 4593.2 4633.1 4667.3 4621.8 4646.0 4653.8 4657.0 4672.3 4502.4 4571.7 4619.5 4620.2 4637.2 4611.9 4628.1 4637.7 4640.1 4645.0 4226.5 4234.2 4243.6 4244.9 4245.3 5623.8 5703.3 5714.9 5739.6 5810.1 5486.2 5552.5 5566.9 5569.0 5586.5 6195.5 6269.5 6275.4 6292.9 6319.6 4777.9 4787.2 4787.8 4790.1 4797.4 6582.8 6609.9 6647.6 6648.6 6660.3 4743.4 4894.3 4941.5 4965.8 4968.3 5082.2 5084.8 5091.0 5095.7 5095.7 5459.9 5472.1 5554.1 5561.7 5577.6 6344.1 6348.2 6352.7 6366.2 6402.9 1642.9 1687.6 1692.5 1717.3 1740.3 1212.5 1223.7 1228.9 1231.4 1236.4 5968.3 6013.4 6026.8 6041.2 6049.2 6386.3 6429.0 6439.7 6450.3 6458.9 5802.3 5908.0 5966.2 5983.0 6009.0 3359.8 3399.4 3407.6 3407.9 3428.4 6510.5 6634.4 6659.4 6684.3 6720.3 6539.5 6542.6 6546.6 6573.5 6578.3 6479.8 6627.5 6693.5 6713.8 6719.5 6387.5 6388.5 6404.6 6425.7 6442.6 6150.9 6359.6 6362.7 6369.8 6382.0 6635.5 6644.6 6658.2 6672.1 6680.8 4901.7 4907.6 4927.2 4941.8 4942.7 6099.3 6244.4 6274.9 6375.2 6444.5 6066.9 6187.7 6202.1 6226.0 6252.7 6084.6 6225.3 6227.3 6241.9 6258.2 6196.3 6232.1 6248.0 6248.6 6274.9 6186.4 6215.3 6219.0 6258.6 6258.7 5965.6 6052.6 6077.6 6096.3 6099.2 04:12:10 INFO - PID 27807 | 04:12:10 INFO - PID 27807 | [#5] yui.html Cycles:180 Average:18348.40 Median:3237.28 stddev:23128.94 (714.5%) stddev-sans-first:23155.93 04:12:10 INFO - PID 27807 | Values: 717.7 732.9 754.9 765.3 776.7 14185.1 14874.0 14895.9 14942.0 14983.6 13448.8 14530.8 14589.9 14606.6 14624.9 960.2 981.1 981.5 981.8 985.3 991.1 991.8 997.6 998.4 998.4 1036.1 1040.3 1041.4 1041.8 1043.9 999.4 1006.7 1018.7 1020.6 1031.5 743.6 745.6 745.8 746.1 746.3 12878.5 12911.8 13011.1 13035.6 13040.5 15534.4 15581.8 15942.8 16065.8 16078.0 12161.3 12409.8 12477.1 12483.4 12494.9 2986.7 3196.9 3277.6 3293.6 3302.4 87680.6 90432.0 90435.0 90475.5 92519.0 13796.4 13961.7 14133.4 14162.0 14166.2 25621.4 25862.6 25901.9 26428.6 26607.5 6937.5 7059.2 7088.8 7119.6 7124.4 3829.8 3924.7 3926.0 3942.3 3957.8 4069.5 4123.3 4183.9 4184.3 4188.6 792.9 815.6 816.1 817.0 817.1 613.7 625.1 629.1 637.2 647.1 10945.6 11421.6 11598.2 11827.3 12224.5 668.3 686.0 690.1 693.2 698.4 5079.0 5137.3 5247.7 5293.4 5318.2 77670.6 78513.6 80796.6 80826.6 84037.0 74699.0 76090.0 76337.6 76965.6 77945.6 52087.0 62754.9 64324.0 64516.4 64726.4 12670.8 13510.1 13511.1 13522.0 13544.7 34304.7 34557.3 34728.0 34755.5 36355.8 40510.4 41177.2 42024.4 42101.6 42738.4 15173.5 15336.2 15409.5 15543.3 15785.4 16596.6 17602.6 17624.6 17688.6 17892.0 17094.9 17508.8 17597.7 17607.8 17611.9 15738.4 15808.6 15830.1 16079.7 16169.8 15766.8 15882.9 15993.1 16235.1 16339.7 11666.8 11905.9 12001.6 12041.0 12175.8 13793.0 14170.8 14191.1 14191.6 14302.7 04:12:10 INFO - PID 27807 | -------- Summary: end -------- 04:12:10 INFO - PID 27807 | 04:12:11 INFO - TEST-INFO | 27807: exit 0 04:12:11 INFO - TEST-OK | dromaeo_css | took 1115039ms 04:12:11 INFO - TEST-START | kraken 04:12:11 INFO - operating with platform_type : linux_ 04:12:11 INFO - Initialising browser for kraken test... 04:12:11 INFO - TEST-INFO | started process 28138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfGYdRI/profile http://localhost:53941/getInfo.html) 04:12:14 INFO - PID 28138 | __metrics Screen width/height:1600/1200 04:12:14 INFO - PID 28138 | colorDepth:24 04:12:14 INFO - PID 28138 | Browser inner width/height: 1024/695 04:12:14 INFO - PID 28138 | __metrics 04:12:15 INFO - PID 28138 | 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" 04:12:15 INFO - PID 28138 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:12:16 INFO - TEST-INFO | 28138: exit 0 04:12:16 INFO - Browser initialized. 04:12:16 INFO - Running cycle 1/1 for kraken test... 04:12:16 INFO - TEST-INFO | started process 28238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfGYdRI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:28 INFO - PID 28238 | RSS: Main: 144871424 04:12:28 INFO - PID 28238 | 04:12:30 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53941/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:31 INFO - PID 28238 | RSS: Main: 217350144 04:12:31 INFO - PID 28238 | 04:12:34 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53941/tests/kraken/driver.html?testName=audio-dft) 04:12:34 INFO - PID 28238 | RSS: Main: 178679808 04:12:34 INFO - PID 28238 | 04:12:37 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53941/tests/kraken/driver.html?testName=audio-fft) 04:12:38 INFO - PID 28238 | RSS: Main: 258686976 04:12:38 INFO - PID 28238 | 04:12:40 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53941/tests/kraken/driver.html?testName=audio-oscillator) 04:12:40 INFO - PID 28238 | RSS: Main: 170790912 04:12:40 INFO - PID 28238 | 04:12:43 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53941/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:43 INFO - PID 28238 | RSS: Main: 173547520 04:12:43 INFO - PID 28238 | 04:12:46 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53941/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:47 INFO - PID 28238 | RSS: Main: 230260736 04:12:47 INFO - PID 28238 | 04:12:50 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53941/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:51 INFO - PID 28238 | RSS: Main: 251146240 04:12:51 INFO - PID 28238 | 04:12:53 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53941/tests/kraken/driver.html?testName=json-parse-financial) 04:12:54 INFO - PID 28238 | RSS: Main: 263966720 04:12:54 INFO - PID 28238 | 04:12:55 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53941/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:56 INFO - PID 28238 | RSS: Main: 198041600 04:12:56 INFO - PID 28238 | 04:12:58 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53941/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:58 INFO - PID 28238 | RSS: Main: 202792960 04:12:58 INFO - PID 28238 | 04:13:00 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53941/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:13:01 INFO - PID 28238 | RSS: Main: 212656128 04:13:01 INFO - PID 28238 | 04:13:03 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:13:04 INFO - PID 28238 | RSS: Main: 216506368 04:13:04 INFO - PID 28238 | 04:13:07 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:13:08 INFO - PID 28238 | RSS: Main: 216887296 04:13:08 INFO - PID 28238 | 04:13:09 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:53941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53941/tests/kraken/driver.html?testName=ai-astar) 04:13:10 INFO - PID 28238 | RSS: Main: 267440128 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | __start_tp_report 04:13:10 INFO - PID 28238 | _x_x_mozilla_page_load 04:13:10 INFO - PID 28238 | _x_x_mozilla_page_load_details 04:13:10 INFO - PID 28238 | |i|pagename|runs| 04:13:10 INFO - PID 28238 | |0;ai-astar;106;109;109;108;110;108;108;107;107;107 04:13:10 INFO - PID 28238 | |1;audio-beat-detection;151;118;119;157;119;117;119;118;138;124 04:13:10 INFO - PID 28238 | |2;audio-dft;161;161;162;161;161;162;164;161;162;162 04:13:10 INFO - PID 28238 | |3;audio-fft;75;74;75;116;75;75;73;74;93;74 04:13:10 INFO - PID 28238 | |4;audio-oscillator;84;83;102;82;81;81;96;82;83;114 04:13:10 INFO - PID 28238 | |5;imaging-gaussian-blur;114;113;113;113;113;113;113;113;113;113 04:13:10 INFO - PID 28238 | |6;imaging-darkroom;146;147;147;146;147;147;146;146;146;146 04:13:10 INFO - PID 28238 | |7;imaging-desaturate;94;94;94;95;94;94;93;93;94;93 04:13:10 INFO - PID 28238 | |8;json-parse-financial;47;49;45;46;49;47;48;48;47;47 04:13:10 INFO - PID 28238 | |9;json-stringify-tinderbox;53;53;54;54;54;53;53;53;53;54 04:13:10 INFO - PID 28238 | |10;stanford-crypto-aes;79;79;78;79;79;78;78;79;78;77 04:13:10 INFO - PID 28238 | |11;stanford-crypto-ccm;134;131;122;121;122;123;132;125;205;129 04:13:10 INFO - PID 28238 | |12;stanford-crypto-pbkdf2;190;184;181;171;180;176;172;192;178;184 04:13:10 INFO - PID 28238 | |13;stanford-crypto-sha256-iterative;65;64;65;64;65;65;64;65;64;63 04:13:10 INFO - PID 28238 | __end_tp_report 04:13:10 INFO - PID 28238 | __start_cc_report 04:13:10 INFO - PID 28238 | _x_x_mozilla_cycle_collect,1722 04:13:10 INFO - PID 28238 | __end_cc_report 04:13:10 INFO - PID 28238 | __startTimestamp1494414790162__endTimestamp 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | ------- Summary: start ------- 04:13:10 INFO - PID 28238 | Number of tests: 14 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.00 stddev:1.20 (1.1%) stddev-sans-first:1.05 04:13:10 INFO - PID 28238 | Values: 106.0 109.0 109.0 108.0 110.0 108.0 108.0 107.0 107.0 107.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:121.50 stddev:15.09 (12.4%) stddev-sans-first:13.52 04:13:10 INFO - PID 28238 | Values: 151.0 118.0 119.0 157.0 119.0 117.0 119.0 118.0 138.0 124.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 04:13:10 INFO - PID 28238 | Values: 161.0 161.0 162.0 161.0 161.0 162.0 164.0 161.0 162.0 162.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:13.83 (18.4%) stddev-sans-first:14.53 04:13:10 INFO - PID 28238 | Values: 75.0 74.0 75.0 116.0 75.0 75.0 73.0 74.0 93.0 74.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.50 stddev:11.38 (13.8%) stddev-sans-first:11.94 04:13:10 INFO - PID 28238 | Values: 84.0 83.0 102.0 82.0 81.0 81.0 96.0 82.0 83.0 114.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 04:13:10 INFO - PID 28238 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:13:10 INFO - PID 28238 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:13:10 INFO - PID 28238 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 93.0 93.0 94.0 93.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#8] json-parse-financial Cycles:10 Average:47.30 Median:47.50 stddev:1.25 (2.6%) stddev-sans-first:1.32 04:13:10 INFO - PID 28238 | Values: 47.0 49.0 45.0 46.0 49.0 47.0 48.0 48.0 47.0 47.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 04:13:10 INFO - PID 28238 | Values: 53.0 53.0 54.0 54.0 54.0 53.0 53.0 53.0 53.0 54.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:79.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 04:13:10 INFO - PID 28238 | Values: 79.0 79.0 78.0 79.0 79.0 78.0 78.0 79.0 78.0 77.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:130.00 stddev:25.25 (19.4%) stddev-sans-first:26.78 04:13:10 INFO - PID 28238 | Values: 134.0 131.0 122.0 121.0 122.0 123.0 132.0 125.0 205.0 129.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:182.50 stddev:6.96 (3.8%) stddev-sans-first:6.53 04:13:10 INFO - PID 28238 | Values: 190.0 184.0 181.0 171.0 180.0 176.0 172.0 192.0 178.0 184.0 04:13:10 INFO - PID 28238 | 04:13:10 INFO - PID 28238 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 04:13:10 INFO - PID 28238 | Values: 65.0 64.0 65.0 64.0 65.0 65.0 64.0 65.0 64.0 63.0 04:13:10 INFO - PID 28238 | -------- Summary: end -------- 04:13:10 INFO - PID 28238 | 04:13:11 INFO - TEST-INFO | 28238: exit 0 04:13:11 INFO - TEST-OK | kraken | took 60071ms 04:13:11 INFO - SUITE-END | took 1175s 04:13:11 INFO - Completed test suite (00:19:35) 04:13:11 INFO - javascript benchmark 04:13:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7670.415141592497, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3426.434638284683, 3431.879884204052, 3446.4313388290934, 3475.9826200868993, 3491.0574144980856, 5842.503387212092, 5979.581429299951, 6022.427869352416, 6029.186059881915, 6044.24446944132, 5876.618019828708, 5912.615679980809, 5923.822285331436, 5931.169636250928, 5960.970195149029, 5219.269302297691, 5303.469653034685, 5314.521693047625, 5323.60072994525, 5340.759665815028, 5387.78448862045, 5416.133418653017, 5419.59353048521, 5420.756065977021, 5421.566274698014, 5250.921236181442, 5376.489233522809, 5409.080456322435, 5449.455054494559, 5458.781648734066, 5163.8192663256605, 5216.895662086737, 5304.92042619361, 5320.840374788762, 5399.811006614769, 5244.842654720364, 5270.4729527047375, 5323.22813192085, 5338.46615338463, 5338.492843179892, 5924.289085309747, 5934.673592952386, 5960.523158147381, 5968.432998865101, 5980.342162362137, 6290.119383286344, 6485.286618471964, 6500.382463665944, 6503.837404064889, 6504.284528701839, 6410.2628197757385, 6443.548951573392, 6475.967620161916, 6565.310642382528, 6567.343265673395, 6021.909671354933, 6022.45797878193, 6030.260366059201, 6030.758769649165, 6087.96956015226, 6554.475641948633, 6568.244651865097, 6608.8347791305605, 6619.271880093186, 6631.966840165865, 6206.224221972254, 6293.181886354836, 6310.652914089677, 6338.809835704937, 6403.295637479873, 6232.937670623326, 6311.684415779193, 6336.0, 6418.807435776934, 6497.480201583862, 6377.617342959345, 6480.25477070143, 6495.3179916109075, 6499.707513161919, 6503.902441463382, 6296.464800492009, 6515.348465153446, 6522.21733391996, 6527.3472652734345, 6529.640869752209, 4872.8781780455065, 4877.634177436636, 4879.268109783561, 4880.438749543848, 4882.414110306786, 4362.825486980549, 4408.360787685831, 4409.691321607521, 4411.1618792429335, 4412.0955204183065, 6073.392660733891, 6097.908531372033, 6098.908516372258, 6100.633961962297, 6105.877882442326, 6383.265924418658, 6415.166028416369, 6432.71052802625, 6541.967290163519, 6543.378379053982, 6158.199434073542, 6173.84565385869, 6177.81466556004, 6184.103305020837, 6187.504999600022, 5674.460926212003, 5679.290088738908, 5679.432056794288, 5683.516901063374, 5698.544116470673, 6624.536282460182, 6711.597304161668, 6721.1598550181225, 6862.3137686230975, 6880.449564034865, 6505.544611877123, 6525.543211975116, 6540.182477190351, 6541.672916354259, 6547.934520654732, 6838.0, 6841.657917104026, 6845.110135682329, 6846.5892046477375, 6853.074834897225, 6235.251769787655, 6326.145970294136, 6410.5192110592825, 6419.101325814297, 6425.132607098169, 6334.303226645157, 6409.0, 6549.803505894831, 6560.967195163994, 6567.573107747981, 6356.173697419306, 6373.8725225496155, 6377.74489020434, 6380.680965951591, 6385.840353991188, 6299.937000629935, 6311.463525600376, 6338.841528961812, 6374.139491168633, 6376.553641245254, 6129.236538068469, 6181.81454556364, 6219.067139928866, 6313.116163736989, 6333.809985700436, 6323.7786677466065, 6370.394812492806, 6372.139761132188, 6383.6808159592765, 6389.9680501597195, 6041.395860413923, 6066.666333351708, 6125.019996800491, 6171.413715697002, 6181.258249010148], "value": 5928.905343679182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.3934614596811, 776.6039319946827, 786.4416264452241, 1142.7828712544622, 1173.354654939783, 28583.285417864565, 33263.66736332639, 36063.639363606424, 36074.0, 36126.27747445053, 37421.62578374215, 37679.62320376795, 37703.4344484833, 37756.0, 37799.43300850483, 5564.4713752193475, 7028.543144695591, 7142.1429428468655, 7154.0, 7155.034070400481, 5614.2701448811595, 7066.293370662944, 7225.963870180642, 7232.529885557448, 7237.167725711558, 7305.890411643803, 7342.559446433204, 7346.375558077543, 7350.0, 7353.301436363537, 5526.557875370001, 7265.164506081789, 7282.417406607458, 7314.26857314267, 7327.816804579875, 5518.172274158868, 7000.124984376953, 7159.67781449836, 7175.210726820045, 7178.569285842814, 34681.30637387238, 34784.30431391383, 34955.65044349549, 34980.47529287063, 35093.29813403718, 3381.5096810962273, 3417.3848707232687, 3421.726261899042, 3422.349753546818, 3427.091820667525, 27420.314492137655, 27428.177154685392, 27436.17691469259, 27449.725502744917, 27632.171034868985, 3627.6916462100753, 3643.981780091083, 3646.3254297954963, 3646.507721457596, 3651.7991510466913, 190022.0, 190112.0, 190339.0, 190976.0, 192687.0, 46277.7686111574, 46371.30443043357, 46451.30323045157, 46452.30321545179, 46571.30143047857, 49152.01695966061, 49155.508444915096, 49166.75416622894, 49262.753686232056, 49321.0, 14003.369848356848, 14068.577942661737, 14080.71838563223, 14086.577402677936, 14092.718145637029, 9294.72115836526, 9485.241180705527, 11407.714807129889, 11412.942935285437, 11425.31448113116, 12252.0, 12305.507779688713, 12321.876781232073, 12577.182483138567, 12595.118341715992, 5159.974200128975, 5275.657082289639, 5296.602754793406, 5345.893082138336, 5394.352677678704, 1034.5034383495813, 1085.2186425773589, 1090.1387903556101, 1093.7648405592677, 1114.777044591085, 25318.746812531637, 25364.873175634373, 25366.1121860734, 25506.872465637553, 25545.23364299074, 1167.976640467203, 1170.414792603698, 1171.8285283737243, 1178.8467499225046, 1199.064729510983, 12951.834334909714, 13011.609651710463, 13107.606771796862, 13198.0, 13227.404766785517, 223538.0, 225046.0, 225248.0, 225856.0, 226076.0, 48420.0, 48532.27201591979, 48541.75729121332, 48568.27147592789, 48579.5142048575, 1424.9928750356182, 1452.4661041432387, 1485.866272035522, 1492.5074725340612, 1498.3706843125913, 23297.068117275798, 24414.511709766062, 24597.0, 24652.0, 24677.259682209562, 35674.8216258917, 35906.28187436289, 35946.64053359433, 35952.225016372904, 35990.0, 195831.0, 196138.0, 196595.0, 196740.0, 197541.0, 29064.564031539965, 29505.11484655464, 31687.52468712925, 32284.192895176868, 32814.17964550905, 37694.0, 37981.0, 39290.410643840936, 39605.60394396019, 39621.60378396179, 29326.0, 29671.40657186801, 29990.100296991124, 30050.849745751133, 30124.84937575298, 30123.54814677738, 30371.544426833174, 30478.390432191674, 31312.843435782674, 31502.52746208763, 35857.262837945804, 35923.82038089897, 35929.0, 36056.819715901256, 36173.27653446969, 30506.237344066576, 30705.846470767505, 30926.38147237088, 31458.37083258276, 31503.84248078745, 24975.500489989736, 25918.22245332643, 25995.524386101348, 26289.0, 26453.735462645127], "value": 16224.594622066332, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.91036427168154, 445.2119748045957, 446.4976900986391, 452.0, 471.17309122490025, 18844.623107537856, 19763.209471621136, 20352.0, 20556.794432055674, 20620.89689551552, 19779.0, 20123.39629811104, 20130.09414576344, 21786.89106554469, 22298.442538936535, 5496.972515137419, 5697.715114244292, 5699.401562835905, 5702.258706368167, 5711.171880077386, 5339.679619222839, 5494.945050549483, 5538.224648549206, 5628.634138780986, 5695.03184458643, 5492.176173573956, 5503.2020357048405, 5506.972465137669, 5507.476789704971, 5508.614396992212, 5353.197020446925, 5445.401005889349, 5479.0, 5484.670919744828, 5512.118061110224, 5005.799768009275, 5016.724080175589, 5020.598352131858, 5024.196128619404, 5026.773795179226, 25917.61123583148, 26653.866730666417, 26921.865390673116, 27052.323691907663, 27331.86334068337, 2129.9787002130092, 2181.825453963679, 2184.923527676524, 2185.2242453928943, 2185.7049298344677, 16701.83298167027, 17156.485305440856, 17272.30910763568, 17374.0, 17706.29174833005, 2088.3839267416147, 2147.248463037924, 2161.567686462698, 2187.157944191482, 2196.8681879087144, 108427.90920716122, 110664.4466777669, 110794.44602776934, 111305.0, 114149.85850141475, 12703.93648031754, 12704.936475317565, 12714.0, 12999.675008124683, 13218.0, 18154.18306176225, 18223.817761822476, 18230.361937332396, 18250.36123735663, 18255.543611409554, 8644.351673624504, 8784.209421152127, 8910.331725120643, 8974.237189838806, 8975.820483590292, 8062.596870156469, 8109.959450202711, 8189.1401402853035, 8369.288610468178, 8378.8324233515, 7770.261825126604, 7943.24539168778, 7976.481528700616, 8019.879701804478, 8053.879191812128, 2112.8943552822298, 2124.214040804912, 2131.4138611881544, 2152.0853637204127, 2290.2900100968754, 998.9800203996025, 1024.99487502562, 1055.0978913029403, 1062.511244827388, 1081.9729506762237, 20533.38399848007, 21050.578988420453, 21085.472863178544, 21244.0, 21514.354569362946, 1040.4641609571077, 1050.4590136079926, 1055.150603763962, 1065.7655315830505, 1084.6529110684662, 11271.323720576627, 11675.708107297385, 11707.121965852595, 11752.58865939688, 11776.70558236051, 471092.0, 473206.0, 478155.0, 478340.0, 479758.0, 99766.5011674937, 100517.0, 103308.0, 103344.0, 107583.46208268909, 1237.3442075699893, 1242.236024844714, 1281.0392205845617, 1294.3528235882059, 1296.3323888197397, 20494.48763780858, 20896.37310880676, 21631.891840540695, 21657.566848663253, 21730.0, 42869.356959646255, 45902.73750724902, 47871.0, 48396.0, 49865.501344986085, 59971.10043349441, 60560.0, 60909.0, 61025.0, 61500.69249653723, 8740.825183496167, 9148.451092934445, 9450.243980481682, 10023.799524009333, 10279.331843430153, 16054.919725401765, 16225.756613651041, 16233.18834058316, 16345.754813678042, 16463.670726585642, 13753.312334383041, 13904.0, 13913.095648782797, 13930.791038134234, 14026.29868506591, 12253.0, 12381.133320667466, 12656.114072015238, 12710.618681439571, 13269.867301326864, 14027.929860350632, 14110.576682699535, 14349.354279057676, 14491.637709056937, 14517.85482145165, 9339.57971891253, 9351.85972210431, 9422.199113075465, 9534.713958581253, 9653.46905920181, 13576.52482163159, 13757.724845503235, 13758.174509529461, 13790.862091378958, 14077.084989475652], "value": 10333.82035831598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1152.4929031226254, 1284.7173621803204, 1327.9601611951646, 1346.9595912122627, 1360.2110775750066, 9461.621535138585, 11036.944815275923, 11353.716157096076, 11371.601993930213, 11392.202545821796, 11120.833187502194, 11193.552257909674, 11205.551777928873, 11219.102471802256, 11229.887701122987, 1973.506623344164, 2310.861348319102, 2345.566070277004, 2348.9177878774244, 2349.4713689419914, 2062.3194345865827, 2285.337252196861, 2348.6946696929376, 2369.0050178924807, 2372.2764556810166, 2336.334144768741, 2349.7650234976536, 2350.529894021194, 2356.5051339218785, 2358.1864256831363, 2246.640537514006, 2249.6063188941953, 2251.4371407148133, 2254.7632498587577, 2259.2883241778786, 2179.9891000545053, 2191.22211614876, 2199.285232299493, 2199.615067363221, 2201.086549082129, 10902.61840835575, 10939.12487001038, 10995.505202265836, 11054.944725276402, 11072.280301780358, 6314.778982735582, 6539.5749276297365, 6549.6070235786, 6550.0, 6560.835979100513, 3672.0, 3744.588095309541, 3898.961010389888, 3904.4728961590104, 3918.3534716771696, 1309.8559158492558, 1340.6648337915522, 1356.3760670091672, 1427.136582367663, 1451.811264535614, 16781.24484398205, 16800.915995420066, 16895.324187032627, 16912.915435422867, 16975.745363819427, 5388.137897936312, 5566.415526369754, 5614.63504872182, 5618.494335509824, 5765.971170144123, 14323.283835808168, 14374.425022998963, 14385.0, 14390.841373794015, 14399.424023039172, 6247.500199983991, 6478.0, 6530.444912182517, 6544.083828264047, 6643.169603799525, 5089.440161582223, 5156.123459011977, 6008.489278411296, 6057.848553786191, 6060.606060606046, 4093.1202223766977, 4534.77326133692, 4554.612857907115, 4641.443026836801, 4740.715557066587, 1439.9280035998368, 1446.4937271954732, 1455.32327467728, 1473.7126260379337, 1482.2440555316866, 853.2363534636465, 860.2257967829004, 862.8144948835904, 870.525563567857, 904.9819003619891, 6970.756023539152, 7171.282871712787, 7179.784606461814, 7204.351608355273, 7337.523061001125, 981.764376549623, 985.5170966226498, 987.8024395121005, 999.5052449037773, 999.5951639585979, 4101.441452248127, 4233.5131459882505, 4283.121959998193, 4344.891377715519, 4376.081022985209, 14906.850931490762, 15467.303971321093, 15483.612909677124, 15493.612659683598, 15514.767278490832, 15150.621234469007, 15210.136093846817, 15332.15673137988, 15356.385744570092, 15374.231288435534, 9232.815343693088, 9431.434113953184, 9496.762580935532, 9514.096160864707, 9516.714498565054, 6854.451643868579, 6917.584944903322, 6939.271376505394, 6973.302669733189, 7010.334018268256, 13379.130356526795, 13406.195628262336, 13718.0, 13723.588292350845, 13791.448342066205, 13804.792928105886, 13874.445022199, 14128.576142715736, 14175.929120354745, 14425.062370945854, 9421.481818500048, 9555.474448905377, 9584.66453674118, 9586.514090316012, 9589.712308630753, 9730.221582273543, 10531.736706582396, 11021.889781102407, 11161.609343672932, 11174.27367221128, 9111.17999380059, 9173.633054677739, 9326.72019839406, 9389.671361502315, 9665.806683866424, 9157.450552966844, 9197.356185066981, 9216.2626989842, 9267.0, 9295.30285228597, 7972.960135199287, 8190.624718831472, 8224.876626850482, 8261.0, 8287.585620718819, 6090.908636370546, 6108.908366374597, 6175.783847565313, 6176.69116544162, 6372.840678983062, 6103.389661033861, 6148.846278843064, 6162.599431036968, 6220.688965551613, 6329.17720696325], "value": 5413.912856621663, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.440191530899, 406.790502891011, 407.03735665151925, 409.1096403906401, 416.82285028862736, 5503.862403439916, 5930.436608522189, 5940.287165540136, 5984.850378740528, 6028.69856507174, 5540.695261760601, 5727.799527016556, 5736.856578585537, 5814.854628634275, 5888.499477544403, 4510.210713125206, 4579.931301030479, 4593.242115051013, 4633.096546173498, 4667.276572131325, 4621.768911554425, 4646.047560250157, 4653.790014596196, 4656.996237426874, 4672.345871577982, 4502.4371953505815, 4571.725696458223, 4619.468761092467, 4620.214563524209, 4637.165310244155, 4611.930821037688, 4628.09752098341, 4637.65217608679, 4640.118377508263, 4644.9535504644855, 4226.535081141072, 4234.17433600448, 4243.554426785174, 4244.936325955113, 4245.341971994346, 5623.831285061455, 5703.258576385085, 5714.857128571777, 5739.62692424991, 5810.070388737824, 5486.231927530149, 5552.472515111099, 5566.86082847928, 5569.0, 5586.525145362649, 6195.535334849904, 6269.467095296905, 6275.403836635513, 6292.905606415908, 6319.58922670025, 4777.856664300077, 4787.234042553209, 4787.832425865113, 4790.137775200463, 4797.352357431737, 6582.835429114262, 6609.93390066098, 6647.567908085959, 6648.634325112117, 6660.300668429793, 4743.383360163226, 4894.26586012094, 4941.481144479778, 4965.751712414365, 4968.30443737877, 5082.161443361804, 5084.821986258588, 5090.974545127325, 5095.668781529189, 5095.719735414587, 5459.874863303427, 5472.124460086447, 5554.139363313336, 5561.6663000220115, 5577.581681373913, 6344.111824344595, 6348.238211414568, 6352.6823658816875, 6366.172397588284, 6402.935970640234, 1642.8767842411867, 1687.6202854357916, 1692.4753326468833, 1717.3388245525562, 1740.26908698347, 1212.4604550974732, 1223.7150991458932, 1228.91397602167, 1231.3658465890073, 1236.3756303067073, 5968.253968253968, 6013.428724271274, 6026.758929642853, 6041.184440100618, 6049.243844519435, 6386.2975072741965, 6429.0, 6439.678016099177, 6450.322916041769, 6458.930873549633, 5802.274715660543, 5908.0, 5966.164736936832, 5982.982892908216, 6009.0, 3359.798412095282, 3399.4390925497014, 3407.5740532433447, 3407.9148021299666, 3428.434308339146, 6510.479161667055, 6634.369734875179, 6659.367360100783, 6684.264730879697, 6720.260771315151, 6539.476841852736, 6542.574732642363, 6546.607203567801, 6573.5398522103, 6578.3092775258865, 6479.8056058318325, 6627.502937279627, 6693.497987651043, 6713.798586042329, 6719.496037797185, 6387.498937749718, 6388.4569811566535, 6404.583702059537, 6425.678716064272, 6442.645654489048, 6150.938490615036, 6359.55483116196, 6362.650054247061, 6369.777057802955, 6382.0, 6635.469162467088, 6644.60132392058, 6658.201015878126, 6672.065910772592, 6680.799576012728, 4901.730404827768, 4907.55831975124, 4927.236278376858, 4941.77762000718, 4942.678725882806, 6099.268087829489, 6244.4380005797875, 6274.937250627435, 6375.171227740364, 6444.485545896804, 6066.939330606638, 6187.659678717714, 6202.131701561875, 6226.0, 6252.718627661675, 6084.60450070744, 6225.252969643671, 6227.283862355705, 6241.937580624136, 6258.186435763321, 6196.318404975359, 6232.127502149793, 6247.96876015617, 6248.625082495065, 6274.905876411949, 6186.350433204629, 6215.34738852414, 6219.0, 6258.624482531062, 6258.655773932477, 5965.550764015152, 6052.576319657582, 6077.574569780073, 6096.268447786294, 6099.207103076749], "value": 4860.0631819272785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.7344382578447, 732.8900664900265, 754.9320561149495, 765.3341592814251, 776.7048521561806, 14185.14889106653, 14874.0, 14895.92552037241, 14941.954063215593, 14983.550493485212, 13448.798268025963, 14530.782038269408, 14589.854101458983, 14606.561803145923, 14624.853751462482, 960.2414092866644, 981.0728861226108, 981.4994352880046, 981.8085473332703, 985.256131620629, 991.1377101921339, 991.7669347703284, 997.5860018092483, 998.3810037776552, 998.4009594243432, 1036.0571879589575, 1040.3029969920133, 1041.3595638682193, 1041.8020576090557, 1043.8695163104612, 999.3953658036928, 1006.6828948881152, 1018.6689325969015, 1020.5611587017579, 1031.5048776587244, 743.6096049573963, 745.6085555083624, 745.7501736918084, 746.1009483572283, 746.3245762584816, 12878.549250776272, 12911.806322905164, 13011.089223754341, 13035.608931732064, 13040.478380864753, 15534.378624854991, 15581.844181558152, 15942.760858587131, 16065.759013614805, 16078.035317880964, 12161.331126788024, 12409.813852792215, 12477.064220183522, 12483.375831208494, 12494.937525312405, 2986.7013298670176, 3196.9200769980703, 3277.6394596594355, 3293.604767427924, 3302.3890580242733, 87680.56159719224, 90432.0, 90435.0, 90475.54762226212, 92519.0, 13796.448142074205, 13961.65095872591, 14133.434662613381, 14162.0, 14166.150030998173, 25621.3594660135, 25862.6120608191, 25901.870490647427, 26428.603570946452, 26607.46785064288, 6937.549059311129, 7059.18819335783, 7088.7518936838, 7119.6084215368655, 7124.43004559634, 3829.8276577554075, 3924.7448915820382, 3925.9607403925597, 3942.250972315251, 3957.8021098945514, 4069.5116586009867, 4123.299039163349, 4183.895402614959, 4184.267753143188, 4188.623023927861, 792.861249281385, 815.5881279953585, 816.0941355095839, 816.9714060007872, 817.1093508076225, 613.7115555688819, 625.1373105114913, 629.0784001437916, 637.1589501857596, 647.1102234427661, 10945.616903408343, 11421.600243991421, 11598.246114002563, 11827.2903625781, 12224.511019559119, 668.301624802083, 685.9759908403182, 690.1063123255396, 693.2339764560088, 698.3958875572594, 5079.0, 5137.306463627438, 5247.711375874287, 5293.391260005072, 5318.215830760613, 77670.6116469414, 78513.60743196247, 80796.59601702071, 80826.59586702028, 84037.0, 74699.0, 76090.0, 76337.61831190808, 76965.61517192378, 77945.61027194827, 52087.0, 62754.90706965397, 64324.035139472944, 64516.354836451974, 64726.352736472974, 12670.809937850756, 13510.054296199172, 13511.121777084458, 13522.0, 13544.661383465493, 34304.656953430145, 34557.29804582216, 34728.0, 34755.478667820506, 36355.81822090979, 40510.392344115455, 41177.1764564713, 42024.369634454895, 42101.57898421099, 42738.35892461553, 15173.468928587446, 15336.156511391535, 15409.537713868154, 15543.300551474984, 15785.447509337118, 16596.58508537296, 17602.647947041245, 17624.55938601545, 17688.55778605545, 17892.0, 17094.91452542729, 17508.82491175072, 17597.736033959245, 17607.823921760617, 17611.911940440215, 15738.370465181264, 15808.60478488047, 15830.129342885792, 16079.67840643204, 16169.838301617303, 15766.76349854776, 15882.920585397, 15993.1203783793, 16235.107069111313, 16339.673206535565, 11666.824997624874, 11905.880941190824, 12001.579944701894, 12041.0, 12175.817362739743, 13793.0, 14170.787438188228, 14191.07757995727, 14191.64520886986, 14302.713945721236], "value": 7786.1557350845715, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1478.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 109.0, 109.0, 108.0, 110.0, 108.0, 108.0, 107.0, 107.0, 107.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 119.0, 157.0, 119.0, 117.0, 119.0, 118.0, 138.0, 124.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 164.0, 161.0, 162.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 116.0, 75.0, 75.0, 73.0, 74.0, 93.0, 74.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 102.0, 82.0, 81.0, 81.0, 96.0, 82.0, 83.0, 114.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 49.0, 45.0, 46.0, 49.0, 47.0, 48.0, 48.0, 47.0, 47.0], "value": 47.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 53.0, 53.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 79.0, 78.0, 78.0, 79.0, 78.0, 77.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 122.0, 121.0, 122.0, 123.0, 132.0, 125.0, 205.0, 129.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 184.0, 181.0, 171.0, 180.0, 176.0, 172.0, 192.0, 178.0, 184.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 63.0], "value": 64.4, "unit": "score"}]}]} 04:13:11 INFO - Return code: 0 04:13:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:13:11 INFO - # TBPL SUCCESS # 04:13:11 INFO - Running post-action listener: _resource_record_post_action 04:13:11 INFO - [mozharness: 2017-05-10 11:13:11.495190Z] Finished run-tests step (success) 04:13:11 INFO - Running post-run listener: _resource_record_post_run 04:13:11 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 379006976; Read time: 16; Write time: 267508 04:13:11 INFO - TinderboxPrint: CPU usage
12.9% 04:13:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:13:11 INFO - TinderboxPrint: I/O write bytes / time
379,006,976 / 267,508 04:13:11 INFO - TinderboxPrint: CPU idle
8,285.0 (87.1%) 04:13:11 INFO - TinderboxPrint: CPU user
1,185.0 (12.5%) 04:13:11 INFO - TinderboxPrint: Swap in / out
0 / 0 04:13:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111882240; Read time: 0; Write time: 106412 04:13:11 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 267124736; Read time: 0; Write time: 161096 04:13:12 INFO - Running post-run listener: _upload_blobber_files 04:13:12 INFO - Blob upload gear active. 04:13:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:13:12 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 04:13:12 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:13:12 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:13:12 INFO - (blobuploader) - INFO - Open directory for files ... 04:13:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:13:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:13:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:15 INFO - (blobuploader) - INFO - Done attempting. 04:13:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:13:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:13:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:16 INFO - (blobuploader) - INFO - Done attempting. 04:13:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:13:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:13:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:17 INFO - (blobuploader) - INFO - Done attempting. 04:13:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:13:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:13:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:18 INFO - (blobuploader) - INFO - Done attempting. 04:13:18 INFO - (blobuploader) - INFO - Iteration through files over. 04:13:18 INFO - Return code: 0 04:13:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:13:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:13:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e59c45f62b07b5f0b7eb3801970b8a4e6bb091d17aa00ed542a7f167b24e17b5c43975937c6665f8405b7516599e275ea29044bd517cf35f6932663405d786d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e018fa435cebbf58c85e6ddce8f74a9798562f7a05a0e1489b8ee285d202c88b0c31693fa24cba3d5d221f658fdf5fced8d371329dc889a4fd29b1f5f9ae93a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/337ba35230ca43e7892ea239b2a3d8fb7c266cad5de0408ae201441d49a17546142552e696ca20a2281c05e97434d0826f7d5ba25555a0ed3c4a55d52c69ab65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9326db702a72b16f65a8cdaf0e285307046412b5c13ffb7d118b9e2484feb02f2649e4acd473564fa46e7b66fa7d6abbfd18b088fe9cb30a514003639254eff9"} 04:13:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:13:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:13:18 INFO - Contents: 04:13:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e59c45f62b07b5f0b7eb3801970b8a4e6bb091d17aa00ed542a7f167b24e17b5c43975937c6665f8405b7516599e275ea29044bd517cf35f6932663405d786d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e018fa435cebbf58c85e6ddce8f74a9798562f7a05a0e1489b8ee285d202c88b0c31693fa24cba3d5d221f658fdf5fced8d371329dc889a4fd29b1f5f9ae93a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/337ba35230ca43e7892ea239b2a3d8fb7c266cad5de0408ae201441d49a17546142552e696ca20a2281c05e97434d0826f7d5ba25555a0ed3c4a55d52c69ab65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9326db702a72b16f65a8cdaf0e285307046412b5c13ffb7d118b9e2484feb02f2649e4acd473564fa46e7b66fa7d6abbfd18b088fe9cb30a514003639254eff9"} 04:13:18 INFO - Running post-run listener: copy_logs_to_upload_dir 04:13:18 INFO - Copying logs to upload dir... 04:13:18 INFO - mkdir: /builds/slave/test/build/upload/logs 04:13:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.293789 ========= master_lag: -0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-05-10 04:13:17.235212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 04:13:17.239885) ========= 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=32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e59c45f62b07b5f0b7eb3801970b8a4e6bb091d17aa00ed542a7f167b24e17b5c43975937c6665f8405b7516599e275ea29044bd517cf35f6932663405d786d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e018fa435cebbf58c85e6ddce8f74a9798562f7a05a0e1489b8ee285d202c88b0c31693fa24cba3d5d221f658fdf5fced8d371329dc889a4fd29b1f5f9ae93a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/337ba35230ca43e7892ea239b2a3d8fb7c266cad5de0408ae201441d49a17546142552e696ca20a2281c05e97434d0826f7d5ba25555a0ed3c4a55d52c69ab65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9326db702a72b16f65a8cdaf0e285307046412b5c13ffb7d118b9e2484feb02f2649e4acd473564fa46e7b66fa7d6abbfd18b088fe9cb30a514003639254eff9"} build_url:https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011992 build_url: 'https://queue.taskcluster.net/v1/task/dAXFeU0MQnm-NZmdmiLGmw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e59c45f62b07b5f0b7eb3801970b8a4e6bb091d17aa00ed542a7f167b24e17b5c43975937c6665f8405b7516599e275ea29044bd517cf35f6932663405d786d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e018fa435cebbf58c85e6ddce8f74a9798562f7a05a0e1489b8ee285d202c88b0c31693fa24cba3d5d221f658fdf5fced8d371329dc889a4fd29b1f5f9ae93a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/337ba35230ca43e7892ea239b2a3d8fb7c266cad5de0408ae201441d49a17546142552e696ca20a2281c05e97434d0826f7d5ba25555a0ed3c4a55d52c69ab65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9326db702a72b16f65a8cdaf0e285307046412b5c13ffb7d118b9e2484feb02f2649e4acd473564fa46e7b66fa7d6abbfd18b088fe9cb30a514003639254eff9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 04:13:17.265848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 04:13:17.266127) ========= 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=32c5991c409366f7fec8a718000001d2-1494411893.452964-117173792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004654 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 04:13:17.348974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 04:13:17.349254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 04:13:17.352527) ========= ========= Total master_lag: -0.10 =========