builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1494445336.97 results: success (0) revision: ce2218406119c36a551e3faea4e192186ee46cc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:16.968415) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:16.968877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:16.969159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:16.984345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:16.984739) ========= 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=3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-10 12:42:17-- 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% 43.4M=0s 2017-05-10 12:42:17 (43.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172182 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:17.171568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:17.171930) ========= 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=3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019653 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:17.227420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-10 12:42:17.227850) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ce2218406119c36a551e3faea4e192186ee46cc5 --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 ce2218406119c36a551e3faea4e192186ee46cc5 --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=3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-10 12:42:17,381 truncating revision to first 12 chars 2017-05-10 12:42:17,381 Setting DEBUG logging. 2017-05-10 12:42:17,381 attempt 1/10 2017-05-10 12:42:17,381 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ce2218406119?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 12:42:18,356 unpacking tar archive at: mozilla-central-ce2218406119/testing/mozharness/ program finished with exit code 0 elapsedTime=1.374384 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-10 12:42:18.616132) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:18.619551) ========= script_repo_revision: ce2218406119c36a551e3faea4e192186ee46cc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:18.620074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:18.620358) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 12:42:18.631725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-05-10 12:42:18.632118) ========= /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=3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:42:18 INFO - MultiFileLogger online at 20170510 12:42:18 in /builds/slave/test 12:42:18 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 12:42:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:42:18 INFO - {'append_to_log': False, 12:42:18 INFO - 'base_work_dir': '/builds/slave/test', 12:42:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:42:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:42:18 INFO - 'branch': 'Firefox-Non-PGO', 12:42:18 INFO - 'buildbot_json_path': 'buildprops.json', 12:42:18 INFO - 'config_files': ('talos/linux_config.py',), 12:42:18 INFO - 'default_actions': ('clobber', 12:42:18 INFO - 'read-buildbot-config', 12:42:18 INFO - 'download-and-extract', 12:42:18 INFO - 'populate-webroot', 12:42:18 INFO - 'create-virtualenv', 12:42:18 INFO - 'install', 12:42:18 INFO - 'run-tests'), 12:42:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:42:18 INFO - 'download_minidump_stackwalk': True, 12:42:18 INFO - 'download_symbols': 'ondemand', 12:42:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:42:18 INFO - 'tooltool.py': '/tools/tooltool.py', 12:42:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:42:18 INFO - '/tools/misc-python/virtualenv.py')}, 12:42:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:42:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:42:18 INFO - 'gecko_profile': False, 12:42:18 INFO - 'gecko_profile_interval': 0, 12:42:18 INFO - 'installer_path': 'installer.exe', 12:42:18 INFO - 'log_level': 'info', 12:42:18 INFO - 'log_name': 'talos', 12:42:18 INFO - 'log_to_console': True, 12:42:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:42:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:42:18 INFO - 'opt_config_files': (), 12:42:18 INFO - 'pip_index': False, 12:42:18 INFO - 'suite': 'dromaeojs', 12:42:18 INFO - 'system_bits': '32', 12:42:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:42:18 INFO - 'title': 'talos-linux64-ix-030', 12:42:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:42:18 INFO - 'use_talos_json': True, 12:42:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:42:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:42:18 INFO - 'work_dir': 'build'} 12:42:18 INFO - [mozharness: 2017-05-10 19:42:18.877901Z] Running clobber step. 12:42:18 INFO - Running pre-action listener: _resource_record_pre_action 12:42:18 INFO - Running main action method: clobber 12:42:18 INFO - rmtree: /builds/slave/test/build 12:42:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:42:19 INFO - Running post-action listener: _resource_record_post_action 12:42:19 INFO - [mozharness: 2017-05-10 19:42:19.841685Z] Finished clobber step (success) 12:42:19 INFO - [mozharness: 2017-05-10 19:42:19.841785Z] Running read-buildbot-config step. 12:42:19 INFO - Running pre-action listener: _resource_record_pre_action 12:42:19 INFO - Running main action method: read_buildbot_config 12:42:19 INFO - Using buildbot properties: 12:42:19 INFO - { 12:42:19 INFO - "project": "", 12:42:19 INFO - "product": "firefox", 12:42:19 INFO - "who": "nobody@mozilla.org", 12:42:19 INFO - "installer_path": "public/build/target.tar.bz2", 12:42:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:42:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:42:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 12:42:19 INFO - "stage_platform": "linux64", 12:42:19 INFO - "basedir": "/builds/slave/test", 12:42:19 INFO - "buildnumber": 1143, 12:42:19 INFO - "platform": "ubuntu64_hw", 12:42:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:42:19 INFO - "slavebuilddir": "test", 12:42:19 INFO - "taskId": "ZCSqjEZ5QWaGeAcgJKweWg", 12:42:19 INFO - "branch": "mozilla-central", 12:42:19 INFO - "script_repo_revision": "production", 12:42:19 INFO - "revision": "ce2218406119c36a551e3faea4e192186ee46cc5", 12:42:19 INFO - "slavename": "talos-linux64-ix-030", 12:42:19 INFO - "repo_path": "mozilla-central" 12:42:19 INFO - } 12:42:19 INFO - Finding installer, test and symbols from parent task. 12:42:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCSqjEZ5QWaGeAcgJKweWg'}, attempt #1 12:42:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCSqjEZ5QWaGeAcgJKweWg'}, attempt #1 12:42:20 INFO - Task dependencies: Us9qSO6lSYez3cEwes--pw 12:42:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw'}, attempt #1 12:42:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.tar.bz2 12:42:21 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/test_packages.json 12:42:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.crashreporter-symbols.zip 12:42:21 INFO - Running post-action listener: _resource_record_post_action 12:42:21 INFO - [mozharness: 2017-05-10 19:42:21.213916Z] Finished read-buildbot-config step (success) 12:42:21 INFO - [mozharness: 2017-05-10 19:42:21.214135Z] Running download-and-extract step. 12:42:21 INFO - Running pre-action listener: _resource_record_pre_action 12:42:21 INFO - Running main action method: download_and_extract 12:42:21 INFO - mkdir: /builds/slave/test/build/tests 12:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:21 INFO - trying https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.test_packages.json 12:42:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:42:21 INFO - Downloaded 986 bytes. 12:42:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:42:21 INFO - Using the following test package requirements: 12:42:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:42:21 INFO - u'common': [u'target.common.tests.zip'], 12:42:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:42:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:42:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:42:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:42:21 INFO - u'mozbase': [u'target.common.tests.zip'], 12:42:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:42:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:42:21 INFO - u'web-platform': [u'target.common.tests.zip', 12:42:21 INFO - u'target.web-platform.tests.zip'], 12:42:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:42:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:42:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.common.tests.zip 12:42:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:42:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.common.tests.zip into memory 12:42:22 INFO - Content-Length response header: 60737856 12:42:22 INFO - Bytes received: 60737856 12:42:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:42:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.common.tests.zip 12:42:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:42:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.common.tests.zip into memory 12:42:33 INFO - Content-Length response header: 60737856 12:42:33 INFO - Bytes received: 60737856 12:42:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.talos.tests.zip 12:42:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:42:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.talos.tests.zip into memory 12:42:45 INFO - Content-Length response header: 14409362 12:42:45 INFO - Bytes received: 14409362 12:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:45 INFO - trying https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.tar.bz2 12:42:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:42:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:42:47 INFO - Downloaded 68505654 bytes. 12:42:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.tar.bz2 12:42:47 INFO - mkdir: /builds/slave/test/properties 12:42:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:42:47 INFO - Writing to file /builds/slave/test/properties/build_url 12:42:47 INFO - Contents: 12:42:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.tar.bz2 12:42:47 INFO - Running post-action listener: _resource_record_post_action 12:42:47 INFO - Running post-action listener: set_extra_try_arguments 12:42:47 INFO - [mozharness: 2017-05-10 19:42:47.069562Z] Finished download-and-extract step (success) 12:42:47 INFO - [mozharness: 2017-05-10 19:42:47.069662Z] Running populate-webroot step. 12:42:47 INFO - Running pre-action listener: _resource_record_pre_action 12:42:47 INFO - Running main action method: populate_webroot 12:42:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:42:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:42:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:42:47 INFO - '--tppagecycles', 12:42:47 INFO - '7'], 12:42:47 INFO - 'tests': ['tsvgm']}}, 12:42:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:42:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:42:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:42:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:42:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:42:47 INFO - 'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:42:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:42:47 INFO - 'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['damp', 'tps']}, 12:42:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:42:47 INFO - 'tests': ['damp', 'tps']}, 12:42:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['dromaeo_dom']}, 12:42:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:42:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:42:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:42:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['a11yr', 12:42:47 INFO - 'ts_paint', 12:42:47 INFO - 'tpaint', 12:42:47 INFO - 'sessionrestore', 12:42:47 INFO - 'sessionrestore_no_auto_restore', 12:42:47 INFO - 'tabpaint']}, 12:42:47 INFO - 'other-e10s': {'tests': ['a11yr', 12:42:47 INFO - 'ts_paint', 12:42:47 INFO - 'tpaint', 12:42:47 INFO - 'sessionrestore', 12:42:47 INFO - 'sessionrestore_no_auto_restore', 12:42:47 INFO - 'tabpaint']}, 12:42:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:42:47 INFO - 'ts_paint', 12:42:47 INFO - 'tpaint', 12:42:47 INFO - 'sessionrestore', 12:42:47 INFO - 'sessionrestore_no_auto_restore', 12:42:47 INFO - 'tabpaint']}, 12:42:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:42:47 INFO - 'ts_paint', 12:42:47 INFO - 'tpaint', 12:42:47 INFO - 'sessionrestore', 12:42:47 INFO - 'sessionrestore_no_auto_restore', 12:42:47 INFO - 'tabpaint']}, 12:42:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['a11yr', 12:42:47 INFO - 'ts_paint', 12:42:47 INFO - 'tpaint', 12:42:47 INFO - 'sessionrestore', 12:42:47 INFO - 'sessionrestore_no_auto_restore', 12:42:47 INFO - 'tabpaint']}, 12:42:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['a11yr', 12:42:47 INFO - 'ts_paint', 12:42:47 INFO - 'tpaint', 12:42:47 INFO - 'sessionrestore', 12:42:47 INFO - 'sessionrestore_no_auto_restore', 12:42:47 INFO - 'tabpaint']}, 12:42:47 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:42:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:42:47 INFO - 'bloom_basic_ref']}, 12:42:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['tsvgx', 12:42:47 INFO - 'tsvgr_opacity', 12:42:47 INFO - 'tart', 12:42:47 INFO - 'tscrollx', 12:42:47 INFO - 'cart', 12:42:47 INFO - 'tsvg_static']}, 12:42:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:42:47 INFO - 'tsvgr_opacity', 12:42:47 INFO - 'tart', 12:42:47 INFO - 'tscrollx', 12:42:47 INFO - 'cart', 12:42:47 INFO - 'tsvg_static']}, 12:42:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:42:47 INFO - 'talos_options': ['--disable-e10s'], 12:42:47 INFO - 'tests': ['tp5o']}, 12:42:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:42:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:42:47 INFO - 'talos_options': ['--disable-e10s', 12:42:47 INFO - '--xperf_path', 12:42:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:47 INFO - 'tests': ['tp5n']}, 12:42:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:42:47 INFO - 'talos_options': ['--xperf_path', 12:42:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:47 INFO - 'tests': ['tp5n']}}, 12:42:47 INFO - 'talos.zip': {'path': '', 12:42:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:42:47 INFO - Running post-action listener: _resource_record_post_action 12:42:47 INFO - [mozharness: 2017-05-10 19:42:47.083235Z] Finished populate-webroot step (success) 12:42:47 INFO - [mozharness: 2017-05-10 19:42:47.083324Z] Running create-virtualenv step. 12:42:47 INFO - Running pre-action listener: _resource_record_pre_action 12:42:47 INFO - Running main action method: create_virtualenv 12:42:47 INFO - Creating virtualenv /builds/slave/test/build/venv 12:42:47 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 12:42:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:42:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:42:47 INFO - Using real prefix '/usr' 12:42:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:42:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:42:49 INFO - Installing pip.................done. 12:42:49 INFO - Return code: 0 12:42:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:42:49 INFO - Reading from file tmpfile_stdout 12:42:49 INFO - Output received: 12:42:49 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) 12:42:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:49 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 0x11021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1474770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', '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 12:42:49 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 12:42:49 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 12:42:49 INFO - Using env: {'DISPLAY': ':0', 12:42:49 INFO - 'HOME': '/home/cltbld', 12:42:49 INFO - 'LANG': 'en_US.UTF-8', 12:42:49 INFO - 'LANGUAGE': 'en_US:en', 12:42:49 INFO - 'LOGNAME': 'cltbld', 12:42:49 INFO - 'MAIL': '/var/mail/cltbld', 12:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:49 INFO - 'MOZ_NO_REMOTE': '1', 12:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:49 INFO - 'NO_EM_RESTART': '1', 12:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:49 INFO - 'PWD': '/builds/slave/test', 12:42:49 INFO - 'SHELL': '/bin/bash', 12:42:49 INFO - 'SHLVL': '1', 12:42:49 INFO - 'TERM': 'linux', 12:42:49 INFO - 'TMOUT': '86400', 12:42:49 INFO - 'USER': 'cltbld', 12:42:49 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:49 INFO - '_': '/tools/buildbot/bin/python'} 12:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:50 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 12:42:50 INFO - Cleaning up... 12:42:50 INFO - Return code: 0 12:42:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1474770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', '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 12:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:42:50 INFO - Using env: {'DISPLAY': ':0', 12:42:50 INFO - 'HOME': '/home/cltbld', 12:42:50 INFO - 'LANG': 'en_US.UTF-8', 12:42:50 INFO - 'LANGUAGE': 'en_US:en', 12:42:50 INFO - 'LOGNAME': 'cltbld', 12:42:50 INFO - 'MAIL': '/var/mail/cltbld', 12:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:50 INFO - 'MOZ_NO_REMOTE': '1', 12:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:50 INFO - 'NO_EM_RESTART': '1', 12:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:50 INFO - 'PWD': '/builds/slave/test', 12:42:50 INFO - 'SHELL': '/bin/bash', 12:42:50 INFO - 'SHLVL': '1', 12:42:50 INFO - 'TERM': 'linux', 12:42:50 INFO - 'TMOUT': '86400', 12:42:50 INFO - 'USER': 'cltbld', 12:42:50 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:50 INFO - '_': '/tools/buildbot/bin/python'} 12:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:50 INFO - Downloading/unpacking psutil>=3.1.1 12:42:50 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 12:42:50 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 12:42:50 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 12:42:50 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 12:42:50 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 12:42:50 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 12:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:42:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:42:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:42:51 INFO - Installing collected packages: psutil 12:42:51 INFO - Running setup.py install for psutil 12:42:51 INFO - building 'psutil._psutil_linux' extension 12:42:51 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 12:42:51 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 12:42:51 INFO - building 'psutil._psutil_posix' extension 12:42:51 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 12:42:51 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 12:42:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:42:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:42:52 INFO - Successfully installed psutil 12:42:52 INFO - Cleaning up... 12:42:52 INFO - Return code: 0 12:42:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:42:52 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')]} 12:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:52 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')]} 12:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:52 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 0x11021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1474770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', '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 12:42:52 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 12:42:52 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 12:42:52 INFO - Using env: {'DISPLAY': ':0', 12:42:52 INFO - 'HOME': '/home/cltbld', 12:42:52 INFO - 'LANG': 'en_US.UTF-8', 12:42:52 INFO - 'LANGUAGE': 'en_US:en', 12:42:52 INFO - 'LOGNAME': 'cltbld', 12:42:52 INFO - 'MAIL': '/var/mail/cltbld', 12:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:52 INFO - 'MOZ_NO_REMOTE': '1', 12:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:52 INFO - 'NO_EM_RESTART': '1', 12:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:52 INFO - 'PWD': '/builds/slave/test', 12:42:52 INFO - 'SHELL': '/bin/bash', 12:42:52 INFO - 'SHLVL': '1', 12:42:52 INFO - 'TERM': 'linux', 12:42:52 INFO - 'TMOUT': '86400', 12:42:52 INFO - 'USER': 'cltbld', 12:42:52 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:52 INFO - '_': '/tools/buildbot/bin/python'} 12:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:42:52 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 12:42:52 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 12:42:52 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 12:42:52 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 12:42:52 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 12:42:52 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 12:42:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:42:53 INFO - Installing collected packages: mozsystemmonitor 12:42:53 INFO - Running setup.py install for mozsystemmonitor 12:42:53 INFO - Successfully installed mozsystemmonitor 12:42:53 INFO - Cleaning up... 12:42:53 INFO - Return code: 0 12:42:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1474770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', '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 12:42:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:42:53 INFO - Using env: {'DISPLAY': ':0', 12:42:53 INFO - 'HOME': '/home/cltbld', 12:42:53 INFO - 'LANG': 'en_US.UTF-8', 12:42:53 INFO - 'LANGUAGE': 'en_US:en', 12:42:53 INFO - 'LOGNAME': 'cltbld', 12:42:53 INFO - 'MAIL': '/var/mail/cltbld', 12:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:53 INFO - 'MOZ_NO_REMOTE': '1', 12:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:53 INFO - 'NO_EM_RESTART': '1', 12:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:53 INFO - 'PWD': '/builds/slave/test', 12:42:53 INFO - 'SHELL': '/bin/bash', 12:42:53 INFO - 'SHLVL': '1', 12:42:53 INFO - 'TERM': 'linux', 12:42:53 INFO - 'TMOUT': '86400', 12:42:53 INFO - 'USER': 'cltbld', 12:42:53 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:53 INFO - '_': '/tools/buildbot/bin/python'} 12:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:53 INFO - Downloading/unpacking jsonschema==2.5.1 12:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:42:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:42:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:42:55 INFO - warning: no files found matching '*.txt' 12:42:55 INFO - no previously-included directories found matching 'build' 12:42:55 INFO - no previously-included directories found matching 'dist' 12:42:55 INFO - no previously-included directories found matching '.git*' 12:42:55 INFO - Installing collected packages: jsonschema, functools32 12:42:55 INFO - Running setup.py install for functools32 12:42:55 INFO - warning: no files found matching '*.txt' 12:42:55 INFO - no previously-included directories found matching 'build' 12:42:55 INFO - no previously-included directories found matching 'dist' 12:42:55 INFO - no previously-included directories found matching '.git*' 12:42:55 INFO - Successfully installed jsonschema functools32 12:42:55 INFO - Cleaning up... 12:42:55 INFO - Return code: 0 12:42:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:42:55 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')]} 12:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:55 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')]} 12:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:55 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 0x11021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1474770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', '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 12:42:55 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 12:42:55 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 12:42:55 INFO - Using env: {'DISPLAY': ':0', 12:42:55 INFO - 'HOME': '/home/cltbld', 12:42:55 INFO - 'LANG': 'en_US.UTF-8', 12:42:55 INFO - 'LANGUAGE': 'en_US:en', 12:42:55 INFO - 'LOGNAME': 'cltbld', 12:42:55 INFO - 'MAIL': '/var/mail/cltbld', 12:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:55 INFO - 'MOZ_NO_REMOTE': '1', 12:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:55 INFO - 'NO_EM_RESTART': '1', 12:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:55 INFO - 'PWD': '/builds/slave/test', 12:42:55 INFO - 'SHELL': '/bin/bash', 12:42:55 INFO - 'SHLVL': '1', 12:42:55 INFO - 'TERM': 'linux', 12:42:55 INFO - 'TMOUT': '86400', 12:42:55 INFO - 'USER': 'cltbld', 12:42:55 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:55 INFO - '_': '/tools/buildbot/bin/python'} 12:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:42:55 INFO - Cleaning up... 12:42:55 INFO - Return code: 0 12:42:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:42:55 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')]} 12:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:55 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')]} 12:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:55 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 0x11021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1474770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', '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 12:42:55 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 12:42:55 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 12:42:55 INFO - Using env: {'DISPLAY': ':0', 12:42:55 INFO - 'HOME': '/home/cltbld', 12:42:55 INFO - 'LANG': 'en_US.UTF-8', 12:42:55 INFO - 'LANGUAGE': 'en_US:en', 12:42:55 INFO - 'LOGNAME': 'cltbld', 12:42:55 INFO - 'MAIL': '/var/mail/cltbld', 12:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:55 INFO - 'MOZ_NO_REMOTE': '1', 12:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:55 INFO - 'NO_EM_RESTART': '1', 12:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:55 INFO - 'PWD': '/builds/slave/test', 12:42:55 INFO - 'SHELL': '/bin/bash', 12:42:55 INFO - 'SHLVL': '1', 12:42:55 INFO - 'TERM': 'linux', 12:42:55 INFO - 'TMOUT': '86400', 12:42:55 INFO - 'USER': 'cltbld', 12:42:55 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:55 INFO - '_': '/tools/buildbot/bin/python'} 12:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:55 INFO - Downloading/unpacking blobuploader==1.2.4 12:42:55 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 12:42:55 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 12:42:55 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 12:42:55 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 12:42:55 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 12:42:55 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 12:42:56 INFO - Downloading blobuploader-1.2.4.tar.gz 12:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:42:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:42:57 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 12:42:57 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 12:42:57 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 12:42:57 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 12:42:57 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 12:42:57 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 12:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:42:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:42:57 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 12:42:57 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 12:42:57 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 12:42:57 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 12:42:57 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 12:42:57 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 12:42:57 INFO - Downloading docopt-0.6.1.tar.gz 12:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:42:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:42:57 INFO - Running setup.py install for blobuploader 12:42:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:42:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:42:57 INFO - Running setup.py install for requests 12:42:58 INFO - Running setup.py install for docopt 12:42:58 INFO - Successfully installed blobuploader requests docopt 12:42:58 INFO - Cleaning up... 12:42:58 INFO - Return code: 0 12:42:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:58 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')]} 12:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:58 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')]} 12:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:58 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 0x11021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1474770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', '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 12:42:58 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 12:42:58 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 12:42:58 INFO - Using env: {'DISPLAY': ':0', 12:42:58 INFO - 'HOME': '/home/cltbld', 12:42:58 INFO - 'LANG': 'en_US.UTF-8', 12:42:58 INFO - 'LANGUAGE': 'en_US:en', 12:42:58 INFO - 'LOGNAME': 'cltbld', 12:42:58 INFO - 'MAIL': '/var/mail/cltbld', 12:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:58 INFO - 'MOZ_NO_REMOTE': '1', 12:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:58 INFO - 'NO_EM_RESTART': '1', 12:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:58 INFO - 'PWD': '/builds/slave/test', 12:42:58 INFO - 'SHELL': '/bin/bash', 12:42:58 INFO - 'SHLVL': '1', 12:42:58 INFO - 'TERM': 'linux', 12:42:58 INFO - 'TMOUT': '86400', 12:42:58 INFO - 'USER': 'cltbld', 12:42:58 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:58 INFO - '_': '/tools/buildbot/bin/python'} 12:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:58 INFO - Running setup.py (path:/tmp/pip-tG3vEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:58 INFO - Running setup.py (path:/tmp/pip-tGKy7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:58 INFO - Running setup.py (path:/tmp/pip-Ipwhmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:58 INFO - Running setup.py (path:/tmp/pip-YSIYXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:58 INFO - Running setup.py (path:/tmp/pip-J2KgQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:58 INFO - Running setup.py (path:/tmp/pip-xEIEwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:58 INFO - Running setup.py (path:/tmp/pip-U9sIXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:58 INFO - Running setup.py (path:/tmp/pip-3jn1_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:59 INFO - Running setup.py (path:/tmp/pip-inUteW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:59 INFO - Running setup.py (path:/tmp/pip-y287z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:59 INFO - Running setup.py (path:/tmp/pip-KjE6w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:59 INFO - Running setup.py (path:/tmp/pip-j3BGBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:59 INFO - Running setup.py (path:/tmp/pip-DsLIEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:59 INFO - Running setup.py (path:/tmp/pip-Ocqj5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:59 INFO - Running setup.py (path:/tmp/pip-lhQrx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:59 INFO - Running setup.py (path:/tmp/pip-HctD4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:59 INFO - Running setup.py (path:/tmp/pip-BXyQCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:42:59 INFO - Running setup.py install for manifestparser 12:42:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:42:59 INFO - Running setup.py install for mozcrash 12:42:59 INFO - Running setup.py install for mozdebug 12:42:59 INFO - Running setup.py install for mozdevice 12:43:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Running setup.py install for mozfile 12:43:00 INFO - Running setup.py install for mozhttpd 12:43:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Running setup.py install for mozinfo 12:43:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Running setup.py install for mozInstall 12:43:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Running setup.py install for mozleak 12:43:00 INFO - Running setup.py install for mozlog 12:43:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Running setup.py install for moznetwork 12:43:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Running setup.py install for mozprocess 12:43:00 INFO - Running setup.py install for mozprofile 12:43:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:43:00 INFO - Running setup.py install for mozrunner 12:43:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:43:01 INFO - Running setup.py install for mozscreenshot 12:43:01 INFO - Running setup.py install for moztest 12:43:01 INFO - Running setup.py install for mozversion 12:43:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:43:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:43:01 INFO - Cleaning up... 12:43:01 INFO - Return code: 0 12:43:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:01 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')]} 12:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:01 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')]} 12:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:01 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 0x11021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1474770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', '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 12:43:01 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 12:43:01 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 12:43:01 INFO - Using env: {'DISPLAY': ':0', 12:43:01 INFO - 'HOME': '/home/cltbld', 12:43:01 INFO - 'LANG': 'en_US.UTF-8', 12:43:01 INFO - 'LANGUAGE': 'en_US:en', 12:43:01 INFO - 'LOGNAME': 'cltbld', 12:43:01 INFO - 'MAIL': '/var/mail/cltbld', 12:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:01 INFO - 'MOZ_NO_REMOTE': '1', 12:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:01 INFO - 'NO_EM_RESTART': '1', 12:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:01 INFO - 'PWD': '/builds/slave/test', 12:43:01 INFO - 'SHELL': '/bin/bash', 12:43:01 INFO - 'SHLVL': '1', 12:43:01 INFO - 'TERM': 'linux', 12:43:01 INFO - 'TMOUT': '86400', 12:43:01 INFO - 'USER': 'cltbld', 12:43:01 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:01 INFO - '_': '/tools/buildbot/bin/python'} 12:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:01 INFO - Running setup.py (path:/tmp/pip-NfJTe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:01 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)) 12:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:01 INFO - Running setup.py (path:/tmp/pip-_Ar7Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:01 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)) 12:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:01 INFO - Running setup.py (path:/tmp/pip-vXQlfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:01 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)) 12:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:01 INFO - Running setup.py (path:/tmp/pip-jbc1Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:01 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)) 12:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:01 INFO - Running setup.py (path:/tmp/pip-2ozNMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:02 INFO - Running setup.py (path:/tmp/pip-JFm0vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:02 INFO - Running setup.py (path:/tmp/pip-5O8nze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:02 INFO - Running setup.py (path:/tmp/pip-ka8bcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:02 INFO - Running setup.py (path:/tmp/pip-V086G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:02 INFO - Running setup.py (path:/tmp/pip-VZ2m0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:02 INFO - Running setup.py (path:/tmp/pip-folPKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:02 INFO - Running setup.py (path:/tmp/pip-q4R5yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:02 INFO - Running setup.py (path:/tmp/pip-a9UAXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:02 INFO - Running setup.py (path:/tmp/pip-SMGEn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:02 INFO - Running setup.py (path:/tmp/pip-2ujoCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:02 INFO - Running setup.py (path:/tmp/pip-xsBFt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:02 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)) 12:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:02 INFO - Running setup.py (path:/tmp/pip-UuTNCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:02 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)) 12:43:02 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)) 12:43:02 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)) 12:43:02 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)) 12:43:02 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)) 12:43:02 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)) 12:43:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:02 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 12:43:02 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 12:43:02 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 12:43:02 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 12:43:02 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 12:43:02 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 12:43:03 INFO - Downloading blessings-1.6.tar.gz 12:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:43:04 INFO - Installing collected packages: blessings 12:43:04 INFO - Running setup.py install for blessings 12:43:04 INFO - Successfully installed blessings 12:43:04 INFO - Cleaning up... 12:43:04 INFO - Return code: 0 12:43:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:04 INFO - Reading from file tmpfile_stdout 12:43:04 INFO - Current package versions: 12:43:04 INFO - argparse == 1.2.1 12:43:04 INFO - blessings == 1.6 12:43:04 INFO - blobuploader == 1.2.4 12:43:04 INFO - docopt == 0.6.1 12:43:04 INFO - functools32 == 3.2.3-2 12:43:04 INFO - jsonschema == 2.5.1 12:43:04 INFO - manifestparser == 1.1 12:43:04 INFO - mozInstall == 1.12 12:43:04 INFO - mozcrash == 1.0 12:43:04 INFO - mozdebug == 0.1 12:43:04 INFO - mozdevice == 0.50 12:43:04 INFO - mozfile == 1.2 12:43:04 INFO - mozhttpd == 0.7 12:43:04 INFO - mozinfo == 0.9 12:43:04 INFO - mozleak == 0.1 12:43:04 INFO - mozlog == 3.4 12:43:04 INFO - moznetwork == 0.27 12:43:04 INFO - mozprocess == 0.25 12:43:04 INFO - mozprofile == 0.28 12:43:04 INFO - mozrunner == 6.13 12:43:04 INFO - mozscreenshot == 0.1 12:43:04 INFO - mozsystemmonitor == 0.3 12:43:04 INFO - moztest == 0.8 12:43:04 INFO - mozversion == 1.4 12:43:04 INFO - psutil == 3.1.1 12:43:04 INFO - requests == 1.2.3 12:43:04 INFO - wsgiref == 0.1.2 12:43:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:04 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')]} 12:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:04 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')]} 12:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:04 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 0x11021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1474770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', '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 12:43:04 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 12:43:04 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 12:43:04 INFO - Using env: {'DISPLAY': ':0', 12:43:04 INFO - 'HOME': '/home/cltbld', 12:43:04 INFO - 'LANG': 'en_US.UTF-8', 12:43:04 INFO - 'LANGUAGE': 'en_US:en', 12:43:04 INFO - 'LOGNAME': 'cltbld', 12:43:04 INFO - 'MAIL': '/var/mail/cltbld', 12:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:04 INFO - 'MOZ_NO_REMOTE': '1', 12:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:04 INFO - 'NO_EM_RESTART': '1', 12:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:04 INFO - 'PWD': '/builds/slave/test', 12:43:04 INFO - 'SHELL': '/bin/bash', 12:43:04 INFO - 'SHLVL': '1', 12:43:04 INFO - 'TERM': 'linux', 12:43:04 INFO - 'TMOUT': '86400', 12:43:04 INFO - 'USER': 'cltbld', 12:43:04 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:04 INFO - '_': '/tools/buildbot/bin/python'} 12:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:04 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)) 12:43:04 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)) 12:43:04 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)) 12:43:04 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)) 12:43:04 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)) 12:43:04 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)) 12:43:04 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)) 12:43:04 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)) 12:43:04 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)) 12:43:04 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)) 12:43:04 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)) 12:43:04 INFO - Cleaning up... 12:43:04 INFO - Return code: 0 12:43:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:43:04 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')]} 12:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:04 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')]} 12:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:04 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 0x11021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1474770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', '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 12:43:04 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 12:43:04 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 12:43:04 INFO - Using env: {'DISPLAY': ':0', 12:43:04 INFO - 'HOME': '/home/cltbld', 12:43:04 INFO - 'LANG': 'en_US.UTF-8', 12:43:04 INFO - 'LANGUAGE': 'en_US:en', 12:43:04 INFO - 'LOGNAME': 'cltbld', 12:43:04 INFO - 'MAIL': '/var/mail/cltbld', 12:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:04 INFO - 'MOZ_NO_REMOTE': '1', 12:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:04 INFO - 'NO_EM_RESTART': '1', 12:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:04 INFO - 'PWD': '/builds/slave/test', 12:43:04 INFO - 'SHELL': '/bin/bash', 12:43:04 INFO - 'SHLVL': '1', 12:43:04 INFO - 'TERM': 'linux', 12:43:04 INFO - 'TMOUT': '86400', 12:43:04 INFO - 'USER': 'cltbld', 12:43:04 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:04 INFO - '_': '/tools/buildbot/bin/python'} 12:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:43:04 INFO - Cleaning up... 12:43:04 INFO - Return code: 0 12:43:04 INFO - Running post-action listener: _resource_record_post_action 12:43:04 INFO - Running post-action listener: _start_resource_monitoring 12:43:04 INFO - Starting resource monitoring. 12:43:04 INFO - [mozharness: 2017-05-10 19:43:04.946955Z] Finished create-virtualenv step (success) 12:43:04 INFO - [mozharness: 2017-05-10 19:43:04.947475Z] Running install step. 12:43:04 INFO - Running pre-action listener: _resource_record_pre_action 12:43:04 INFO - Running main action method: install 12:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:05 INFO - Reading from file tmpfile_stdout 12:43:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:43:05 INFO - Reading from file tmpfile_stdout 12:43:05 INFO - Output received: 12:43:05 INFO - Usage: mozinstall [options] installer 12:43:05 INFO - Options: 12:43:05 INFO - -h, --help show this help message and exit 12:43:05 INFO - -d DEST, --destination=DEST 12:43:05 INFO - Directory to install application into. [default: 12:43:05 INFO - "/builds/slave/test"] 12:43:05 INFO - --app=APP Application being installed. [default: firefox] 12:43:05 INFO - mkdir: /builds/slave/test/build/application 12:43:05 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'] 12:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:43:22 INFO - Reading from file tmpfile_stdout 12:43:22 INFO - Output received: 12:43:22 INFO - /builds/slave/test/build/application/firefox/firefox 12:43:22 INFO - Running post-action listener: _resource_record_post_action 12:43:22 INFO - [mozharness: 2017-05-10 19:43:22.293633Z] Finished install step (success) 12:43:22 INFO - [mozharness: 2017-05-10 19:43:22.293916Z] Running run-tests step. 12:43:22 INFO - Running pre-action listener: _resource_record_pre_action 12:43:22 INFO - Running main action method: run_tests 12:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:43:22 INFO - Python 2.7.3 12:43:22 INFO - Return code: 0 12:43:22 INFO - grabbing minidump binary from tooltool 12:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:22 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 0x1471a30>, '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 0x14727f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:43:22 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 12:43:22 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 12:43:22 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 12:43:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:43:22 INFO - Return code: 0 12:43:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:43:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:43:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:43:22 INFO - ENV: RUST_BACKTRACE is now 1 12:43:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:43:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:43:22 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/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 12:43:22 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/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 12:43:22 INFO - Using env: {'DISPLAY': ':0', 12:43:22 INFO - 'HOME': '/home/cltbld', 12:43:22 INFO - 'LANG': 'en_US.UTF-8', 12:43:22 INFO - 'LANGUAGE': 'en_US:en', 12:43:22 INFO - 'LOGNAME': 'cltbld', 12:43:22 INFO - 'MAIL': '/var/mail/cltbld', 12:43:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:43:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:22 INFO - 'MOZ_NO_REMOTE': '1', 12:43:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:22 INFO - 'NO_EM_RESTART': '1', 12:43:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:22 INFO - 'PWD': '/builds/slave/test', 12:43:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:43:22 INFO - 'RUST_BACKTRACE': '1', 12:43:22 INFO - 'SHELL': '/bin/bash', 12:43:22 INFO - 'SHLVL': '1', 12:43:22 INFO - 'TERM': 'linux', 12:43:22 INFO - 'TMOUT': '86400', 12:43:22 INFO - 'USER': 'cltbld', 12:43:22 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616', 12:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:22 INFO - '_': '/tools/buildbot/bin/python'} 12:43:22 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/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 12:43:22 INFO - mozversion application_buildid: 20170510183715 12:43:22 INFO - mozversion application_changeset: ce2218406119c36a551e3faea4e192186ee46cc5 12:43:22 INFO - mozversion application_display_name: Nightly 12:43:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:43:22 INFO - mozversion application_name: Firefox 12:43:22 INFO - mozversion application_remotingname: firefox 12:43:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:43:22 INFO - mozversion application_vendor: Mozilla 12:43:22 INFO - mozversion application_version: 55.0a1 12:43:22 INFO - mozversion platform_buildid: 20170510183715 12:43:22 INFO - mozversion platform_changeset: ce2218406119c36a551e3faea4e192186ee46cc5 12:43:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:43:22 INFO - mozversion platform_version: 55.0a1 12:43:22 INFO - using testdate: 1494445402 12:43:22 INFO - actual date: 1494445402 12:43:22 INFO - starting webserver on 'localhost:53975' 12:43:22 INFO - SUITE-START | Running 2 tests 12:43:22 INFO - TEST-START | dromaeo_css 12:43:22 INFO - operating with platform_type : linux_ 12:43:22 INFO - Initialising browser for dromaeo_css test... 12:43:22 INFO - TEST-INFO | started process 25641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKX1CRD/profile http://localhost:53975/getInfo.html) 12:43:26 INFO - PID 25641 | __metrics Screen width/height:1600/1200 12:43:26 INFO - PID 25641 | colorDepth:24 12:43:26 INFO - PID 25641 | Browser inner width/height: 1024/695 12:43:26 INFO - PID 25641 | __metrics 12:43:27 INFO - PID 25641 | 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" 12:43:27 INFO - PID 25641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:43:28 INFO - TEST-INFO | 25641: exit 0 12:43:28 INFO - Browser initialized. 12:43:28 INFO - Running cycle 1/1 for dromaeo_css test... 12:43:28 INFO - TEST-INFO | started process 25743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKX1CRD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:43:40 INFO - PID 25743 | RSS: Main: 144384000 12:43:40 INFO - PID 25743 | 12:46:42 INFO - PID 25743 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53975/tests/dromaeo/cssquery-ext.html) 12:46:43 INFO - PID 25743 | RSS: Main: 285437952 12:46:43 INFO - PID 25743 | 12:49:45 INFO - PID 25743 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-ext.html (next: http://localhost:53975/tests/dromaeo/cssquery-jquery.html) 12:49:46 INFO - PID 25743 | RSS: Main: 223150080 12:49:46 INFO - PID 25743 | 12:52:48 INFO - PID 25743 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53975/tests/dromaeo/cssquery-mootools.html) 12:52:48 INFO - PID 25743 | RSS: Main: 177246208 12:52:48 INFO - PID 25743 | 12:55:50 INFO - PID 25743 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53975/tests/dromaeo/cssquery-prototype.html) 12:55:51 INFO - PID 25743 | RSS: Main: 185700352 12:55:51 INFO - PID 25743 | 12:58:53 INFO - PID 25743 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53975/tests/dromaeo/cssquery-yui.html) 12:58:54 INFO - PID 25743 | RSS: Main: 181170176 12:58:54 INFO - PID 25743 | 13:01:56 INFO - PID 25743 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-yui.html (next: http://localhost:53975/tests/dromaeo/cssquery-dojo.html) 13:01:56 INFO - PID 25743 | RSS: Main: 276619264 13:01:56 INFO - PID 25743 | 13:01:56 INFO - PID 25743 | __start_tp_report 13:01:56 INFO - PID 25743 | _x_x_mozilla_page_load 13:01:56 INFO - PID 25743 | _x_x_mozilla_page_load_details 13:01:56 INFO - PID 25743 | |i|pagename|runs| 13:01:56 INFO - PID 25743 | |0;dojo.html;3290.786098903571;3298.1754561359658;3317.3696997570473;3326.8170250636213;3365.192353835079;5669;5800;5808.506276966463;5844.26946631671;5857.092150716635;5816.156657284691;5827.533797296217;5905.173275741389;5911.556633252501;5918.822435326936;4823.710577365369;5064.215046667754;5167.121589329823;5195.610329225323;5227.581793456515;5198.818041368553;5202.8179013734525;5246.737663116848;5273.472652734734;5281.762320695559;5052.823151189709;5123.026624941249;5134.255532947702;5217.191335343028;5233.084210263189;5165.328507294028;5169.53474187325;5181.896362072775;5191.9480805192225;5227.738613069331;5131.358580177478;5170.663906846043;5186.740662966874;5187.429382767892;5216.374035115772;5724.856878578027;5757;5790.420957904218;5807.448292412214;5858.912116318259;6352.428281454645;6360.586561873463;6365.936340636627;6366.681665916685;6369.4585960193435;6408;6428.453581445583;6428.967855160741;6433.324500927382;6437.388448097423;5789.507891829242;5919.733611987471;5955.166276721263;5973.432523910178;5983.252093488314;6273.153124328157;6377.904331435032;6406.903896441557;6406.935930640727;6446.935530644727;6061.969690151521;6127.080937859357;6130.019196928559;6132.569672417391;6146.323904370515;6309.053641953744;6363.236411630634;6373.267074286517;6375.585586936834;6382.234131904202;6319.684015799192;6329.2721337045905;6333;6337.112804207414;6342.112104305401;6137.7447333336595;6220.315765265817;6244.094606282064;6333.904991425133;6336.651484168415;4824.782884770194;4827.758612069382;4859.392575928009;4865.829695960695;4869.245266983623;4284.978575107105;4287.164003019381;4291.871243862689;4324.675649326313;4326.459192600925;5845.152452894306;5933.821985340447;6013.45878870895;6015.218021657157;6026.0659597762415;6249.9062514062325;6326.936730632727;6361.268454127835;6361.427471527492;6382.968085159545;5894.351621321651;5946.643201407843;5951.642901425928;5967.254093238345;6008.188894499274;5411.269478620415;5499.807506737245;5503.504684578407;5504.091824848855;5504.4770746778995;6558.409743123142;6567.835804104936;6689.565178263398;6699.464042876461;6708.19501659804;6355.87288254223;6398.90401643985;6408.327125651739;6410.45511131559;6416.422521973045;6597.50518711089;6599.60402375859;6653.933460665331;6666.300038495888;6676.098726672031;6099.329073801967;6099.521645064459;6116.792316687851;6157.784477543264;6224.221972253468;6365.427111559982;6385;6386.393292637192;6387.584806987531;6389.233292004989;6056.06131049688;6071.241094863142;6140.846478838065;6159.4456498915315;6167.5682702210415;6036.849078773066;6095.786647467317;6174.598651087845;6182.381761823782;6183.598066125687;6175.135481032748;6219.937800621936;6220.626762394271;6237.345078766845;6237.5633705641985;6262.561620686508;6273.560850740404;6277.843053923689;6282.811515654537;6285;5895.233619629421;5921.970390148022;6024.1265016573225;6129.233845769279;6133.723982420891 13:01:56 INFO - PID 25743 | |1;ext.html;755.8186035351517;819.9549024803636;837.3594200436667;1134.6709454258266;1146.8623765148184;29174.85412572937;33828.66171338286;36850;36895.81552092239;36910;38835.41746873792;39262.41106383399;39320;39338.4099238511;39362;5621.522170615503;7225.674844631978;7336.449766267525;7363.116426028884;7364.079490063742;5685.971570142144;7136.072310599615;7287.672054757549;7294.343509084181;7297.051383320161;7364.963175184143;7407.777766667009;7408.962955185217;7411.629418529079;7415.777526674181;5634.521065709419;7314.768995456384;7355.779326620156;7356.705731770723;7364.815879602999;5724.942750572524;7099.467539934474;7325.816854578625;7334.789759689645;7337.156227033906;35753.28493430143;36083.09792255188;36138.45792313117;36154.8192259037;36155.096122596886;3477.826108694555;3521.9647803521893;3523.4362501999813;3523.6652518010746;3525.5240542526685;28180.436391272266;28233.15300540987;28245.71754282472;28290.858545707346;28291.575626365622;3580.3913334733156;3581.212133330689;3585.94621080684;3592.4611308303965;3593.6765691087667;187208;187262;187378;187456;187647;48165.518344816104;48308.75845620749;48326.27510587344;48332;48390.5160948393;50805.491945080816;51169.23246151311;51170.48829511732;51193.7440312796;51209.48790512122;15089.849101508844;15127.092374457568;15130.092194468147;15164.393424262906;15212.315445804745;10980;11141.2201145919;12164.2701437914;12170.513179472722;12182.147249692614;15033.398664053315;15132.621684457756;15138.243087845563;15193.088414695154;15248.542543723484;5909.231799866076;6074.635521868702;6076.688204928325;6118.082287656798;6160.383961603804;1075.4568942683895;1116.843641890136;1117.3240189685287;1120.0927248928394;1120.4173829608558;27541.31146721348;27564.76374127385;27659.86170069177;27842.443151136864;27856.44287114287;1181.228157763355;1198.856137263534;1208.468273959455;1208.812634041725;1231.5073970411727;13956.651083722989;13959.581212563638;14137.787933180805;14197.077189982825;14248.572542823731;247121;248032;248484;249695;249738;53024.20463693047;53386.73306633442;53542.732286339095;53624.19563706547;53625;1480.7852861335261;1504.3606467251375;1543.2977995012243;1547.0562956596468;1547.0717569458236;24413.460048293255;25635.35911602225;25858.482830342913;25935.221943340974;26111.216663500127;38387.232255354174;38458.42312365261;38458.42312365373;38508.2298354037;38606.42090368703;197676;198162;198972;199028;199274;30288;30509.389812204077;33555.496667549516;34344.14139646529;34574.25801968592;39693.60306396899;41151.58848411597;41235.793821030704;41538;41868.3252669902;28592.285192870346;30080.3983920316;30130.24674383158;30255.848720756254;30771.53842692406;30234.395312094075;30257.394852103276;30265.848670757387;30871.69128308778;31012.68987310188;35332.82333588418;35378.823105885334;35835.10412239715;35931.64068359283;36244.81877590595;29091.418171636025;29407.11778646644;29550.408991820474;29600.407991840475;30221.546676799426;23548.529029418973;24668.753312466644;24801.1319603813;24897.875510622333;25204.495910082063 13:01:56 INFO - PID 25743 | |2;jquery.html;436.6506794564348;443.89346556826354;454.5341025448914;459.30874034577937;464.26877667673415;17872.463826085204;18827.341043063494;19488.610227795434;19630.116644750986;19635.312764053262;19384.127714252856;20385.184592616315;20987.580248395025;21550.784492155075;21658.89170554145;5468.808591699291;5647.774089036454;5652.406497317784;5653.547716182696;5655.236543066674;5462.7268636568215;5537.889242215153;5578.665280083188;5619.297587801525;5624.606277560572;5593.272874526306;5595;5597.104463285855;5601.411851755568;5601.747921343549;5391.649542779726;5526.723663816793;5563.582731295169;5587.664740115586;5589.74846131925;5093.974530127326;5099.286099946011;5103.4896510349035;5103.795848166069;5106.489351064901;25154.371140721447;26048.73951260482;26234.606480902803;26518;26824.73175268242;2133.8506304558687;2155.385715071197;2163.697082408464;2168.8264938805014;2169.099823573231;16289;17247.568810779707;17264.827351726573;17364.218610162574;17368;2008.768991565974;2045.928392506255;2061.690746388039;2065.0500769645982;2102.5794841031857;110033.40651900109;113926.43036784846;116250;116493.41753291264;117016.41491792486;12517.311547864772;12529.373531323397;12559.497620095277;12692.746145077046;12693;17725.113744312734;17738.201780919633;17740.822591774177;17768.55578610545;17773.200205990503;8864.778380540538;9002.369834111549;9190.448573085636;9229.984701682944;9307.348485605942;8543.871841922377;8543.871841922377;8607.78480537979;8813.779655508535;8843.557822108869;7933.761987140395;7974.322182614426;8079;8160.591970401456;8163.346932245406;2202.768709285534;2244.304265677645;2248.3479790860465;2263.875486848206;2408.963865542018;1008.8940661230612;1037.4916291017348;1039.0752230514697;1039.2777019971047;1053.073295499955;18717;19797.208111675372;19966.90016549908;20007.299744508873;20045.599088018156;1046.9528871200814;1055.208593554834;1059.4914441068331;1067.423591260726;1077.2943721862193;12485.438155283035;13427.731445371039;13546.390412431465;13830.585082447542;13885.514007009706;511639;523225;526902;531920;532634;97564.51217743866;98070;100587.97648093995;104482.47758761157;104711.47644261882;1186.7626474705094;1238.646985609097;1247.108317552954;1258.370814592722;1264.1846009323936;19441.805581944565;19480.9025954875;20060.59878802445;20178;20294.59410811805;46548.767256163504;46648.766756166006;47151;47409.52590474189;47994;60412.697936510034;61490.69254653698;61924.38075619366;61958;62560.687196563726;9089.863652045357;9250.259979201783;9497.952510237405;9500.382475139093;9698.515074246401;14132.717345652823;14683.706325873636;14761.630959226106;15142.697146056797;15157.166355850093;12065.638030859089;12772.489100435878;13453.596392108253;13558.457661693421;13582.185068895898;11247.493862776031;11341.26281791681;12701.8094728581;12782.48870045225;13338.26639534835;13425.731485370434;13455.596332110052;13536.932315338361;13682.589522314347;13774.793378099135;9374.296927730311;9467.573959171716;9620.278479114235;9857.35927164732;10016.849747253651;11603.88396116028;12925.806112908502;13243.536476223286;13299.468021279428;13494.73010539764 13:01:56 INFO - PID 25743 | |3;mootools.html;1211.5759484180533;1338.1703343926763;1367.7538043152229;1369.7192075624496;1377.4903285784262;9491.477968711719;11141.442927853604;11457.942710286457;11485.196036277464;11494.540218391254;11201.383923884183;11268.830967535494;11316.038136758365;11318.717032074182;11319.434028298594;1998.1108406759;2062.267894897305;2318.988405057972;2352.6000579901374;2359.9646005309933;2292.9541409171807;2357.9410514737183;2361.527694461106;2362.7755363240462;2364.1843563970488;2268.7958083772455;2276.931692049241;2286.7941885230325;2295.449092217864;2298.080767692928;2268.296827983314;2274.260865218794;2281.566502364554;2287.3252390544744;2287.954240915181;2183.3559100065518;2189.157174487818;2191.747948985871;2196.1874106580667;2196.648536234211;11216.214864959456;11328.037116845078;11337.659870203906;11354.886451135548;11359.204855660108;5905.173275741399;6074.787382441594;6079.544034197409;6083.057126145454;6084.60450070744;3548.946765798489;3706;3797.7341586088983;3838.500994870649;3849.9807500962597;1314.66476048607;1317.7298653775954;1339.109492187694;1346.414309775251;1403.382511694851;17446.47660570185;17449.476515704548;17456.91271543647;17466.47600571972;17467.825321746746;5325.920111198335;5436.184572314184;5503.587230957694;5571.972140139354;5599.452249226592;14126.434942602385;14176.362063706953;14177.929110354382;14215.64460888486;14216.075955062888;6370.235571731422;6373.458256048288;6375.840603984938;6380.298167201604;6380.361963803675;4389.758563279051;5689.374168841424;5819.447152520504;5857.179994800731;5893.116032595145;4413.867583972486;4498.257787465097;4541.341505481687;4545.6136228420955;4573.451185857652;1368.555219553649;1419.396756378535;1438.9136651800925;1443.1196969848384;1459.9927000365142;868.392125512144;895.583553647557;905.5019739143445;914.5975770660888;923.0308176414737;6848.657567121624;6860.279670634612;7012.228654848064;7183.820404489929;7215.639218039077;613.4417679911348;624.978125765596;628.1802248066317;633.6103296472636;635.0727937211723;4164.9583504165175;4165.541790403053;4195.077083041726;4206.978965105155;4208.936865947013;14869.702605948038;15306.08163510193;15336.693266134838;15340.693186136215;15360;15028.624284392978;15149.848501515064;15244;15428.614284642748;15512.534623961299;8929.464232145961;9090.86363704545;9098.772530686785;9104.226140778108;9114.40756350835;6860.382565569123;6983.406410455168;6996.475264355296;7061.329173728487;7095.538789978635;13294.534691285759;13481.865181348061;13753.38109785042;13789.172649641054;13799.86200138026;13678.93160534191;13684.726305474034;13943.372548235557;14092.436302547783;14109.153450792985;8541.615627296662;8816.338774591803;9378.953105234703;9430.339876208875;9556.522173891139;11036.282641628268;11264.66206013821;11278.605248816251;11287.379194144401;11290.209685321948;9040.095990400907;9205.171534561921;9278.257739380699;9320.254379649476;9422.95288523553;8991.730248092306;9005.909940900769;9048.366614337196;9132.908670913206;9204.079592040742;8552.401331906707;8556.614952327285;8567.228949394585;8570.90012946832;8624.353173511887;6063.484603808725;6074.240719910012;6125.418085281891;6178.165947597017;6325.873482530232;5956.344802071855;5960.850978725566;5993.9700301498215;6051.939480605138;6201.689915504297 13:01:56 INFO - PID 25743 | |4;prototype.html;393.18806664238326;407.16531111221985;415.6155556110598;420.88004918598205;421.2270483662478;5763.769449222032;5771.567132465061;5794.39158888317;5807;5818.709064546777;5588.21764952907;5724.284464441945;5736.282964629421;5744.109663002241;5744.79893203738;4355.847545335906;4361.738295702252;4377.321515165155;4377.824887004516;4380.678240532523;4346.15250026245;4372.27857403528;4385.101054283864;4393.824247030115;4418.3372494125815;4230.978845105786;4294.141171765644;4327.6754243431715;4348.717128447116;4361.214981303364;4328.718633288842;4328.783560821947;4331.090471001094;4332.263515202423;4342.848000320006;3774.9622503774885;3788.1287303920253;3792.772433653962;3798.2593394288124;3804.1821008483034;5529.668219906818;5560.388357280696;5577.442255774431;5670.631408958446;5677.432256774331;5074.188129899236;5078.365204349457;5091.745412729349;5092.821751238689;5102.5662818660085;6000.819975400745;6063.120847477136;6105.84735381619;6107.4503294703245;6127.632342059491;4212.705110642256;4231;4240.703150779446;4243.66050715945;4254.553271906436;6075.33171351151;6183.319834818167;6208.6585237811905;6332.556721029529;6417;4263.531011588785;4274.658027357804;4298.183345164409;4309.396684464177;4311.482622085307;4361.520232774392;4362.476502819682;4376.759278239728;4379.233634114017;4380.254882075843;4948.851534453972;5032.220005899091;5077.619178561623;5078.720670363092;5101.336826212569;6087.817365479043;6099.664518451439;6117.541184411187;6126.866529692022;6148.723307451175;1515.181801827023;1523.4439429608112;1525.59571713496;1530.188999830092;1532.823725271608;1010.3331801011298;1020.4234607446917;1028.0850043461326;1031.0926384781344;1041.547041876593;5893.557983151195;5893.911591326134;5914.8817023659285;5936.614120082181;5942.851428714317;6168.19813424252;6265.937340626535;6295.622262664163;6303.653299068504;6321.431071203522;5857.736401861926;5876.647401155944;5910.763569457174;5922.526197904157;5956.344802071769;3267.460868956643;3311.2384151645256;3315.8673653053606;3325.8835940741956;3336.9165770855925;6522.119513865662;6538;6542.182227221598;6605.86788264232;6657.167854018247;6383.776567820104;6402.423781859655;6409.775657851953;6410.775622853271;6445.645489498029;6445.291017988017;6512.967435162794;6533.411992920564;6576.80269591913;6580.63806490638;6235.095911092957;6239.407256310643;6245.5628106032145;6254.8123556293385;6286.717097730521;6081.756729730938;6198.163247961467;6200.286966998853;6200.844978875384;6225.968870155621;6534.607923524603;6560.376764207393;6582.835429114119;6591.242007169237;6609.603423794588;4324.556625506579;4381.298992161239;4382.23310920594;4384.934225986549;4393.7363758174615;6188.257409110935;6280.780172693934;6290.339514351111;6327.96836015817;6354.968225158845;6041.577089603861;6044.123602077762;6090.756369745161;6127.111568822585;6142.692865356625;5895.793647222326;5986.760529578768;6004.219451471456;6016.819495415145;6095.969520152371;6064.696765161636;6081.847953801191;6096.390360963868;6105.511559075175;6109.572329936862;5956.255468066492;6070.757169713339;6121.173641558333;6140.785072522441;6148.938510615016;5940.79207227745;5943;5947.226860508106;5950.732217050157;5951 13:01:56 INFO - PID 25743 | |5;yui.html;805.4522924411398;833.2334252487715;834.2950207075021;838.8783626374176;848.2832006954123;15514.844851551481;15829.208539573005;15901.602459938507;15910.681786364266;15915.453527435613;13635.113717608348;13899.652508687288;14131.081479703813;14217.289135543233;14341.426342946295;938.3384713776788;957.1194501059042;960.2989817433278;962.6245764151986;962.8988956159608;960.7165886063628;962.4465932089042;965.657191696948;965.7247684409945;965.7633879699483;987.6493844685141;987.7678745494838;987.8123156600259;988.0613417253602;988.6094992478003;983.4689267795382;984.202795735453;987.7629368951472;994.1053052252958;995.6714284286168;717.6196615793585;717.7810767715845;720.9819754506127;721.1490441279341;721.6536062689938;15365.231738413035;15695.843041569553;15862.603434914105;15867.52397428079;15996.76004859928;17852.46442606724;18195.909020454812;18471.63056738871;18709.158087886077;18759.718604220812;13439.328033598378;13619.18284902909;13620.659483512893;14082;14270.429182832675;3343.130785995634;3363.6636336366414;3364.1925937775004;3366.5455163553097;3367.276035652322;92168;92682;93688.53155734246;94031;94068.52965735128;14002.859971400156;14398.784018239734;14425.350859211361;14460.132392056299;14514.854851451562;24739;25514.489710205693;26556.203313900613;26602.866985664947;26643.733562664125;7330.157031941395;7550.886736698954;7569.280918312751;7587.544747315179;7594.392448604099;3632.7638703484718;3658.1037645776955;3671.2657468506404;3716.7955762432784;3718.5723641781;4566.908661826811;4721.622270218374;4724.055188962221;4724.692894961817;4730.124926888537;872.3418579823642;905.5653286422554;907.0838453162222;913.397157875812;914.4741773480275;714.5855403865745;722.2091809468624;723.7647764476566;743.4609907816898;758.2000988956704;11053.668389948314;11769.293842369485;11783.469743861548;12112.21270617407;12523.311217882921;696.1194089476816;699.3635791429774;707.1630050454913;710.1300906389735;722.4184531452231;5154.994776018641;5235.502627250406;5390.434004429479;5456.208849716769;5500.642458240201;76396.23603763891;77122.6143869277;78250;80127.59936200282;83887;72250.63874680593;72489.27510724825;72713.63643181857;72956;73686.6315668429;65470.67264663646;67061;67078.32921670818;67286.99999999903;69052;10670.679879603624;11064.114870810477;11166.88833111691;11174.49714762854;11321.71695707614;35192.66532024158;35285.29429411449;35392.646073538934;35825;36510.63489365072;43241;43469;43851.122977539635;44422;45883.770581146884;14220.502282420066;14454.638634034232;14458.783118253445;14460.927695361455;14634.634134146732;16044.117573533102;16077.437289694804;16138.757918630996;16179.11014894145;16336.836631634007;15062.924685376942;15120.168390738614;15339.156346401054;15459.458918937784;15467.226638667797;14102.576922692335;14275.64310892236;14495.927520362331;14668.779968300698;14746.705065898408;15166.31751571204;15187.92406038007;15248;15455.53633391;15726.247906616525;10777.461126943464;11066.170037247077;11093;11150.275232109887;11163.609273675382;11636.12729045308;12153.635390938285;12181.939090304491;12207.511699532275;12358.567450139202 13:01:56 INFO - PID 25743 | __end_tp_report 13:01:56 INFO - PID 25743 | __start_cc_report 13:01:56 INFO - PID 25743 | _x_x_mozilla_cycle_collect,1445 13:01:56 INFO - PID 25743 | __end_cc_report 13:01:56 INFO - PID 25743 | __startTimestamp1494446516266__endTimestamp 13:01:56 INFO - PID 25743 | 13:01:56 INFO - PID 25743 | ------- Summary: start ------- 13:01:56 INFO - PID 25743 | Number of tests: 6 13:01:56 INFO - PID 25743 | 13:01:56 INFO - PID 25743 | [#0] dojo.html Cycles:165 Average:5838.29 Median:6095.79 stddev:712.19 (11.7%) stddev-sans-first:685.76 13:01:56 INFO - PID 25743 | Values: 3290.8 3298.2 3317.4 3326.8 3365.2 5669.0 5800.0 5808.5 5844.3 5857.1 5816.2 5827.5 5905.2 5911.6 5918.8 4823.7 5064.2 5167.1 5195.6 5227.6 5198.8 5202.8 5246.7 5273.5 5281.8 5052.8 5123.0 5134.3 5217.2 5233.1 5165.3 5169.5 5181.9 5191.9 5227.7 5131.4 5170.7 5186.7 5187.4 5216.4 5724.9 5757.0 5790.4 5807.4 5858.9 6352.4 6360.6 6365.9 6366.7 6369.5 6408.0 6428.5 6429.0 6433.3 6437.4 5789.5 5919.7 5955.2 5973.4 5983.3 6273.2 6377.9 6406.9 6406.9 6446.9 6062.0 6127.1 6130.0 6132.6 6146.3 6309.1 6363.2 6373.3 6375.6 6382.2 6319.7 6329.3 6333.0 6337.1 6342.1 6137.7 6220.3 6244.1 6333.9 6336.7 4824.8 4827.8 4859.4 4865.8 4869.2 4285.0 4287.2 4291.9 4324.7 4326.5 5845.2 5933.8 6013.5 6015.2 6026.1 6249.9 6326.9 6361.3 6361.4 6383.0 5894.4 5946.6 5951.6 5967.3 6008.2 5411.3 5499.8 5503.5 5504.1 5504.5 6558.4 6567.8 6689.6 6699.5 6708.2 6355.9 6398.9 6408.3 6410.5 6416.4 6597.5 6599.6 6653.9 6666.3 6676.1 6099.3 6099.5 6116.8 6157.8 6224.2 6365.4 6385.0 6386.4 6387.6 6389.2 6056.1 6071.2 6140.8 6159.4 6167.6 6036.8 6095.8 6174.6 6182.4 6183.6 6175.1 6219.9 6220.6 6237.3 6237.6 6262.6 6273.6 6277.8 6282.8 6285.0 5895.2 5922.0 6024.1 6129.2 6133.7 13:01:56 INFO - PID 25743 | 13:01:56 INFO - PID 25743 | [#1] ext.html Cycles:180 Average:37529.52 Median:33692.08 stddev:55353.60 (164.3%) stddev-sans-first:55440.02 13:01:56 INFO - PID 25743 | Values: 755.8 820.0 837.4 1134.7 1146.9 29174.9 33828.7 36850.0 36895.8 36910.0 38835.4 39262.4 39320.0 39338.4 39362.0 5621.5 7225.7 7336.4 7363.1 7364.1 5686.0 7136.1 7287.7 7294.3 7297.1 7365.0 7407.8 7409.0 7411.6 7415.8 5634.5 7314.8 7355.8 7356.7 7364.8 5724.9 7099.5 7325.8 7334.8 7337.2 35753.3 36083.1 36138.5 36154.8 36155.1 3477.8 3522.0 3523.4 3523.7 3525.5 28180.4 28233.2 28245.7 28290.9 28291.6 3580.4 3581.2 3585.9 3592.5 3593.7 187208.0 187262.0 187378.0 187456.0 187647.0 48165.5 48308.8 48326.3 48332.0 48390.5 50805.5 51169.2 51170.5 51193.7 51209.5 15089.8 15127.1 15130.1 15164.4 15212.3 10980.0 11141.2 12164.3 12170.5 12182.1 15033.4 15132.6 15138.2 15193.1 15248.5 5909.2 6074.6 6076.7 6118.1 6160.4 1075.5 1116.8 1117.3 1120.1 1120.4 27541.3 27564.8 27659.9 27842.4 27856.4 1181.2 1198.9 1208.5 1208.8 1231.5 13956.7 13959.6 14137.8 14197.1 14248.6 247121.0 248032.0 248484.0 249695.0 249738.0 53024.2 53386.7 53542.7 53624.2 53625.0 1480.8 1504.4 1543.3 1547.1 1547.1 24413.5 25635.4 25858.5 25935.2 26111.2 38387.2 38458.4 38458.4 38508.2 38606.4 197676.0 198162.0 198972.0 199028.0 199274.0 30288.0 30509.4 33555.5 34344.1 34574.3 39693.6 41151.6 41235.8 41538.0 41868.3 28592.3 30080.4 30130.2 30255.8 30771.5 30234.4 30257.4 30265.8 30871.7 31012.7 35332.8 35378.8 35835.1 35931.6 36244.8 29091.4 29407.1 29550.4 29600.4 30221.5 23548.5 24668.8 24801.1 24897.9 25204.5 13:01:56 INFO - PID 25743 | 13:01:56 INFO - PID 25743 | [#2] jquery.html Cycles:180 Average:32380.15 Median:11545.08 stddev:87217.01 (755.4%) stddev-sans-first:87428.69 13:01:56 INFO - PID 25743 | Values: 436.7 443.9 454.5 459.3 464.3 17872.5 18827.3 19488.6 19630.1 19635.3 19384.1 20385.2 20987.6 21550.8 21658.9 5468.8 5647.8 5652.4 5653.5 5655.2 5462.7 5537.9 5578.7 5619.3 5624.6 5593.3 5595.0 5597.1 5601.4 5601.7 5391.6 5526.7 5563.6 5587.7 5589.7 5094.0 5099.3 5103.5 5103.8 5106.5 25154.4 26048.7 26234.6 26518.0 26824.7 2133.9 2155.4 2163.7 2168.8 2169.1 16289.0 17247.6 17264.8 17364.2 17368.0 2008.8 2045.9 2061.7 2065.1 2102.6 110033.4 113926.4 116250.0 116493.4 117016.4 12517.3 12529.4 12559.5 12692.7 12693.0 17725.1 17738.2 17740.8 17768.6 17773.2 8864.8 9002.4 9190.4 9230.0 9307.3 8543.9 8543.9 8607.8 8813.8 8843.6 7933.8 7974.3 8079.0 8160.6 8163.3 2202.8 2244.3 2248.3 2263.9 2409.0 1008.9 1037.5 1039.1 1039.3 1053.1 18717.0 19797.2 19966.9 20007.3 20045.6 1047.0 1055.2 1059.5 1067.4 1077.3 12485.4 13427.7 13546.4 13830.6 13885.5 511639.0 523225.0 526902.0 531920.0 532634.0 97564.5 98070.0 100588.0 104482.5 104711.5 1186.8 1238.6 1247.1 1258.4 1264.2 19441.8 19480.9 20060.6 20178.0 20294.6 46548.8 46648.8 47151.0 47409.5 47994.0 60412.7 61490.7 61924.4 61958.0 62560.7 9089.9 9250.3 9498.0 9500.4 9698.5 14132.7 14683.7 14761.6 15142.7 15157.2 12065.6 12772.5 13453.6 13558.5 13582.2 11247.5 11341.3 12701.8 12782.5 13338.3 13425.7 13455.6 13536.9 13682.6 13774.8 9374.3 9467.6 9620.3 9857.4 10016.8 11603.9 12925.8 13243.5 13299.5 13494.7 13:01:56 INFO - PID 25743 | 13:01:56 INFO - PID 25743 | [#3] mootools.html Cycles:180 Average:7186.14 Median:3751.87 stddev:4721.04 (125.8%) stddev-sans-first:4712.94 13:01:56 INFO - PID 25743 | Values: 1211.6 1338.2 1367.8 1369.7 1377.5 9491.5 11141.4 11457.9 11485.2 11494.5 11201.4 11268.8 11316.0 11318.7 11319.4 1998.1 2062.3 2319.0 2352.6 2360.0 2293.0 2357.9 2361.5 2362.8 2364.2 2268.8 2276.9 2286.8 2295.4 2298.1 2268.3 2274.3 2281.6 2287.3 2288.0 2183.4 2189.2 2191.7 2196.2 2196.6 11216.2 11328.0 11337.7 11354.9 11359.2 5905.2 6074.8 6079.5 6083.1 6084.6 3548.9 3706.0 3797.7 3838.5 3850.0 1314.7 1317.7 1339.1 1346.4 1403.4 17446.5 17449.5 17456.9 17466.5 17467.8 5325.9 5436.2 5503.6 5572.0 5599.5 14126.4 14176.4 14177.9 14215.6 14216.1 6370.2 6373.5 6375.8 6380.3 6380.4 4389.8 5689.4 5819.4 5857.2 5893.1 4413.9 4498.3 4541.3 4545.6 4573.5 1368.6 1419.4 1438.9 1443.1 1460.0 868.4 895.6 905.5 914.6 923.0 6848.7 6860.3 7012.2 7183.8 7215.6 613.4 625.0 628.2 633.6 635.1 4165.0 4165.5 4195.1 4207.0 4208.9 14869.7 15306.1 15336.7 15340.7 15360.0 15028.6 15149.8 15244.0 15428.6 15512.5 8929.5 9090.9 9098.8 9104.2 9114.4 6860.4 6983.4 6996.5 7061.3 7095.5 13294.5 13481.9 13753.4 13789.2 13799.9 13678.9 13684.7 13943.4 14092.4 14109.2 8541.6 8816.3 9379.0 9430.3 9556.5 11036.3 11264.7 11278.6 11287.4 11290.2 9040.1 9205.2 9278.3 9320.3 9423.0 8991.7 9005.9 9048.4 9132.9 9204.1 8552.4 8556.6 8567.2 8570.9 8624.4 6063.5 6074.2 6125.4 6178.2 6325.9 5956.3 5960.9 5994.0 6051.9 6201.7 13:01:56 INFO - PID 25743 | 13:01:56 INFO - PID 25743 | [#4] prototype.html Cycles:180 Average:5098.20 Median:5867.19 stddev:1537.33 (26.2%) stddev-sans-first:1500.53 13:01:56 INFO - PID 25743 | Values: 393.2 407.2 415.6 420.9 421.2 5763.8 5771.6 5794.4 5807.0 5818.7 5588.2 5724.3 5736.3 5744.1 5744.8 4355.8 4361.7 4377.3 4377.8 4380.7 4346.2 4372.3 4385.1 4393.8 4418.3 4231.0 4294.1 4327.7 4348.7 4361.2 4328.7 4328.8 4331.1 4332.3 4342.8 3775.0 3788.1 3792.8 3798.3 3804.2 5529.7 5560.4 5577.4 5670.6 5677.4 5074.2 5078.4 5091.7 5092.8 5102.6 6000.8 6063.1 6105.8 6107.5 6127.6 4212.7 4231.0 4240.7 4243.7 4254.6 6075.3 6183.3 6208.7 6332.6 6417.0 4263.5 4274.7 4298.2 4309.4 4311.5 4361.5 4362.5 4376.8 4379.2 4380.3 4948.9 5032.2 5077.6 5078.7 5101.3 6087.8 6099.7 6117.5 6126.9 6148.7 1515.2 1523.4 1525.6 1530.2 1532.8 1010.3 1020.4 1028.1 1031.1 1041.5 5893.6 5893.9 5914.9 5936.6 5942.9 6168.2 6265.9 6295.6 6303.7 6321.4 5857.7 5876.6 5910.8 5922.5 5956.3 3267.5 3311.2 3315.9 3325.9 3336.9 6522.1 6538.0 6542.2 6605.9 6657.2 6383.8 6402.4 6409.8 6410.8 6445.6 6445.3 6513.0 6533.4 6576.8 6580.6 6235.1 6239.4 6245.6 6254.8 6286.7 6081.8 6198.2 6200.3 6200.8 6226.0 6534.6 6560.4 6582.8 6591.2 6609.6 4324.6 4381.3 4382.2 4384.9 4393.7 6188.3 6280.8 6290.3 6328.0 6355.0 6041.6 6044.1 6090.8 6127.1 6142.7 5895.8 5986.8 6004.2 6016.8 6096.0 6064.7 6081.8 6096.4 6105.5 6109.6 5956.3 6070.8 6121.2 6140.8 6148.9 5940.8 5943.0 5947.2 5950.7 5951.0 13:01:56 INFO - PID 25743 | 13:01:56 INFO - PID 25743 | [#5] yui.html Cycles:180 Average:18463.64 Median:20084.37 stddev:23446.44 (116.7%) stddev-sans-first:23474.72 13:01:56 INFO - PID 25743 | Values: 805.5 833.2 834.3 838.9 848.3 15514.8 15829.2 15901.6 15910.7 15915.5 13635.1 13899.7 14131.1 14217.3 14341.4 938.3 957.1 960.3 962.6 962.9 960.7 962.4 965.7 965.7 965.8 987.6 987.8 987.8 988.1 988.6 983.5 984.2 987.8 994.1 995.7 717.6 717.8 721.0 721.1 721.7 15365.2 15695.8 15862.6 15867.5 15996.8 17852.5 18195.9 18471.6 18709.2 18759.7 13439.3 13619.2 13620.7 14082.0 14270.4 3343.1 3363.7 3364.2 3366.5 3367.3 92168.0 92682.0 93688.5 94031.0 94068.5 14002.9 14398.8 14425.4 14460.1 14514.9 24739.0 25514.5 26556.2 26602.9 26643.7 7330.2 7550.9 7569.3 7587.5 7594.4 3632.8 3658.1 3671.3 3716.8 3718.6 4566.9 4721.6 4724.1 4724.7 4730.1 872.3 905.6 907.1 913.4 914.5 714.6 722.2 723.8 743.5 758.2 11053.7 11769.3 11783.5 12112.2 12523.3 696.1 699.4 707.2 710.1 722.4 5155.0 5235.5 5390.4 5456.2 5500.6 76396.2 77122.6 78250.0 80127.6 83887.0 72250.6 72489.3 72713.6 72956.0 73686.6 65470.7 67061.0 67078.3 67287.0 69052.0 10670.7 11064.1 11166.9 11174.5 11321.7 35192.7 35285.3 35392.6 35825.0 36510.6 43241.0 43469.0 43851.1 44422.0 45883.8 14220.5 14454.6 14458.8 14460.9 14634.6 16044.1 16077.4 16138.8 16179.1 16336.8 15062.9 15120.2 15339.2 15459.5 15467.2 14102.6 14275.6 14495.9 14668.8 14746.7 15166.3 15187.9 15248.0 15455.5 15726.2 10777.5 11066.2 11093.0 11150.3 11163.6 11636.1 12153.6 12181.9 12207.5 12358.6 13:01:56 INFO - PID 25743 | -------- Summary: end -------- 13:01:56 INFO - PID 25743 | 13:01:57 INFO - TEST-INFO | 25743: exit 0 13:01:57 INFO - TEST-OK | dromaeo_css | took 1114529ms 13:01:57 INFO - TEST-START | kraken 13:01:57 INFO - operating with platform_type : linux_ 13:01:57 INFO - Initialising browser for kraken test... 13:01:57 INFO - TEST-INFO | started process 26072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvdX1KN/profile http://localhost:53975/getInfo.html) 13:02:00 INFO - PID 26072 | __metrics Screen width/height:1600/1200 13:02:00 INFO - PID 26072 | colorDepth:24 13:02:00 INFO - PID 26072 | Browser inner width/height: 1024/695 13:02:00 INFO - PID 26072 | __metrics 13:02:01 INFO - PID 26072 | 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" 13:02:01 INFO - PID 26072 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:02:02 INFO - TEST-INFO | 26072: exit 0 13:02:02 INFO - Browser initialized. 13:02:02 INFO - Running cycle 1/1 for kraken test... 13:02:02 INFO - TEST-INFO | started process 26166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvdX1KN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:02:14 INFO - PID 26166 | RSS: Main: 144293888 13:02:14 INFO - PID 26166 | 13:02:16 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53975/tests/kraken/driver.html?testName=audio-beat-detection) 13:02:17 INFO - PID 26166 | RSS: Main: 217878528 13:02:17 INFO - PID 26166 | 13:02:20 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53975/tests/kraken/driver.html?testName=audio-dft) 13:02:20 INFO - PID 26166 | RSS: Main: 178581504 13:02:20 INFO - PID 26166 | 13:02:23 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53975/tests/kraken/driver.html?testName=audio-fft) 13:02:24 INFO - PID 26166 | RSS: Main: 259006464 13:02:24 INFO - PID 26166 | 13:02:26 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53975/tests/kraken/driver.html?testName=audio-oscillator) 13:02:27 INFO - PID 26166 | RSS: Main: 170352640 13:02:27 INFO - PID 26166 | 13:02:29 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53975/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:02:29 INFO - PID 26166 | RSS: Main: 173834240 13:02:29 INFO - PID 26166 | 13:02:32 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53975/tests/kraken/driver.html?testName=imaging-darkroom) 13:02:33 INFO - PID 26166 | RSS: Main: 234577920 13:02:33 INFO - PID 26166 | 13:02:36 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53975/tests/kraken/driver.html?testName=imaging-desaturate) 13:02:37 INFO - PID 26166 | RSS: Main: 253198336 13:02:37 INFO - PID 26166 | 13:02:39 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53975/tests/kraken/driver.html?testName=json-parse-financial) 13:02:40 INFO - PID 26166 | RSS: Main: 267362304 13:02:40 INFO - PID 26166 | 13:02:41 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53975/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:02:42 INFO - PID 26166 | RSS: Main: 198361088 13:02:42 INFO - PID 26166 | 13:02:44 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:02:44 INFO - PID 26166 | RSS: Main: 203587584 13:02:44 INFO - PID 26166 | 13:02:46 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:02:47 INFO - PID 26166 | RSS: Main: 212332544 13:02:47 INFO - PID 26166 | 13:02:49 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:02:50 INFO - PID 26166 | RSS: Main: 221065216 13:02:50 INFO - PID 26166 | 13:02:53 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:02:54 INFO - PID 26166 | RSS: Main: 216772608 13:02:54 INFO - PID 26166 | 13:02:55 INFO - PID 26166 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53975/tests/kraken/driver.html?testName=ai-astar) 13:02:56 INFO - PID 26166 | RSS: Main: 266678272 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | __start_tp_report 13:02:56 INFO - PID 26166 | _x_x_mozilla_page_load 13:02:56 INFO - PID 26166 | _x_x_mozilla_page_load_details 13:02:56 INFO - PID 26166 | |i|pagename|runs| 13:02:56 INFO - PID 26166 | |0;ai-astar;109;110;109;110;112;108;108;109;110;109 13:02:56 INFO - PID 26166 | |1;audio-beat-detection;152;116;126;173;118;118;116;117;150;119 13:02:56 INFO - PID 26166 | |2;audio-dft;163;162;163;163;161;160;161;160;161;162 13:02:56 INFO - PID 26166 | |3;audio-fft;74;74;74;106;74;74;74;74;99;75 13:02:56 INFO - PID 26166 | |4;audio-oscillator;82;82;111;83;83;83;95;82;83;107 13:02:56 INFO - PID 26166 | |5;imaging-gaussian-blur;113;113;113;113;113;114;113;113;114;113 13:02:56 INFO - PID 26166 | |6;imaging-darkroom;147;146;147;147;147;147;146;147;147;145 13:02:56 INFO - PID 26166 | |7;imaging-desaturate;93;94;93;93;94;93;93;93;94;94 13:02:56 INFO - PID 26166 | |8;json-parse-financial;44;45;44;46;46;47;46;45;46;46 13:02:56 INFO - PID 26166 | |9;json-stringify-tinderbox;56;55;55;56;55;55;56;55;55;56 13:02:56 INFO - PID 26166 | |10;stanford-crypto-aes;79;79;79;81;79;78;79;79;78;79 13:02:56 INFO - PID 26166 | |11;stanford-crypto-ccm;130;126;133;132;134;123;126;124;174;124 13:02:56 INFO - PID 26166 | |12;stanford-crypto-pbkdf2;183;179;179;179;181;179;180;179;179;179 13:02:56 INFO - PID 26166 | |13;stanford-crypto-sha256-iterative;67;67;68;65;67;72;66;65;65;65 13:02:56 INFO - PID 26166 | __end_tp_report 13:02:56 INFO - PID 26166 | __start_cc_report 13:02:56 INFO - PID 26166 | _x_x_mozilla_cycle_collect,1664 13:02:56 INFO - PID 26166 | __end_cc_report 13:02:56 INFO - PID 26166 | __startTimestamp1494446576121__endTimestamp 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | ------- Summary: start ------- 13:02:56 INFO - PID 26166 | Number of tests: 14 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#0] ai-astar Cycles:10 Average:109.40 Median:109.50 stddev:1.17 (1.1%) stddev-sans-first:1.24 13:02:56 INFO - PID 26166 | Values: 109.0 110.0 109.0 110.0 112.0 108.0 108.0 109.0 110.0 109.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:122.50 stddev:20.32 (16.6%) stddev-sans-first:20.01 13:02:56 INFO - PID 26166 | Values: 152.0 116.0 126.0 173.0 118.0 118.0 116.0 117.0 150.0 119.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.13 13:02:56 INFO - PID 26166 | Values: 163.0 162.0 163.0 163.0 161.0 160.0 161.0 160.0 161.0 162.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.00 stddev:12.08 (16.3%) stddev-sans-first:12.63 13:02:56 INFO - PID 26166 | Values: 74.0 74.0 74.0 106.0 74.0 74.0 74.0 74.0 99.0 75.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:83.00 stddev:11.23 (13.5%) stddev-sans-first:11.61 13:02:56 INFO - PID 26166 | Values: 82.0 82.0 111.0 83.0 83.0 83.0 95.0 82.0 83.0 107.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:02:56 INFO - PID 26166 | Values: 113.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 114.0 113.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 13:02:56 INFO - PID 26166 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 145.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#7] imaging-desaturate Cycles:10 Average:93.40 Median:93.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 13:02:56 INFO - PID 26166 | Values: 93.0 94.0 93.0 93.0 94.0 93.0 93.0 93.0 94.0 94.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#8] json-parse-financial Cycles:10 Average:45.50 Median:46.00 stddev:0.97 (2.1%) stddev-sans-first:0.87 13:02:56 INFO - PID 26166 | Values: 44.0 45.0 44.0 46.0 46.0 47.0 46.0 45.0 46.0 46.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 13:02:56 INFO - PID 26166 | Values: 56.0 55.0 55.0 56.0 55.0 55.0 56.0 55.0 55.0 56.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 13:02:56 INFO - PID 26166 | Values: 79.0 79.0 79.0 81.0 79.0 78.0 79.0 79.0 78.0 79.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:131.00 stddev:15.09 (11.5%) stddev-sans-first:15.98 13:02:56 INFO - PID 26166 | Values: 130.0 126.0 133.0 132.0 134.0 123.0 126.0 124.0 174.0 124.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:179.00 stddev:1.34 (0.7%) stddev-sans-first:0.71 13:02:56 INFO - PID 26166 | Values: 183.0 179.0 179.0 179.0 181.0 179.0 180.0 179.0 179.0 179.0 13:02:56 INFO - PID 26166 | 13:02:56 INFO - PID 26166 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:2.16 (3.2%) stddev-sans-first:2.29 13:02:56 INFO - PID 26166 | Values: 67.0 67.0 68.0 65.0 67.0 72.0 66.0 65.0 65.0 65.0 13:02:56 INFO - PID 26166 | -------- Summary: end -------- 13:02:56 INFO - PID 26166 | 13:02:57 INFO - TEST-INFO | 26166: exit 0 13:02:57 INFO - TEST-OK | kraken | took 60070ms 13:02:57 INFO - SUITE-END | took 1174s 13:02:57 INFO - Completed test suite (00:19:34) 13:02:57 INFO - javascript benchmark 13:02:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7604.19268720835, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3290.786098903571, 3298.1754561359658, 3317.3696997570473, 3326.8170250636213, 3365.192353835079, 5669.0, 5800.0, 5808.506276966463, 5844.26946631671, 5857.092150716635, 5816.156657284691, 5827.533797296217, 5905.173275741389, 5911.556633252501, 5918.822435326936, 4823.710577365369, 5064.215046667754, 5167.121589329823, 5195.610329225323, 5227.581793456515, 5198.818041368553, 5202.8179013734525, 5246.737663116848, 5273.472652734734, 5281.762320695559, 5052.823151189709, 5123.026624941249, 5134.255532947702, 5217.191335343028, 5233.084210263189, 5165.328507294028, 5169.53474187325, 5181.896362072775, 5191.9480805192225, 5227.738613069331, 5131.358580177478, 5170.663906846043, 5186.740662966874, 5187.429382767892, 5216.374035115772, 5724.856878578027, 5757.0, 5790.420957904218, 5807.448292412214, 5858.912116318259, 6352.428281454645, 6360.586561873463, 6365.936340636627, 6366.681665916685, 6369.4585960193435, 6408.0, 6428.453581445583, 6428.967855160741, 6433.324500927382, 6437.388448097423, 5789.507891829242, 5919.733611987471, 5955.166276721263, 5973.432523910178, 5983.252093488314, 6273.153124328157, 6377.904331435032, 6406.903896441557, 6406.935930640727, 6446.935530644727, 6061.969690151521, 6127.080937859357, 6130.019196928559, 6132.569672417391, 6146.323904370515, 6309.053641953744, 6363.236411630634, 6373.267074286517, 6375.585586936834, 6382.234131904202, 6319.684015799192, 6329.2721337045905, 6333.0, 6337.112804207414, 6342.112104305401, 6137.7447333336595, 6220.315765265817, 6244.094606282064, 6333.904991425133, 6336.651484168415, 4824.782884770194, 4827.758612069382, 4859.392575928009, 4865.829695960695, 4869.245266983623, 4284.978575107105, 4287.164003019381, 4291.871243862689, 4324.675649326313, 4326.459192600925, 5845.152452894306, 5933.821985340447, 6013.45878870895, 6015.218021657157, 6026.0659597762415, 6249.9062514062325, 6326.936730632727, 6361.268454127835, 6361.427471527492, 6382.968085159545, 5894.351621321651, 5946.643201407843, 5951.642901425928, 5967.254093238345, 6008.188894499274, 5411.269478620415, 5499.807506737245, 5503.504684578407, 5504.091824848855, 5504.4770746778995, 6558.409743123142, 6567.835804104936, 6689.565178263398, 6699.464042876461, 6708.19501659804, 6355.87288254223, 6398.90401643985, 6408.327125651739, 6410.45511131559, 6416.422521973045, 6597.50518711089, 6599.60402375859, 6653.933460665331, 6666.300038495888, 6676.098726672031, 6099.329073801967, 6099.521645064459, 6116.792316687851, 6157.784477543264, 6224.221972253468, 6365.427111559982, 6385.0, 6386.393292637192, 6387.584806987531, 6389.233292004989, 6056.06131049688, 6071.241094863142, 6140.846478838065, 6159.4456498915315, 6167.5682702210415, 6036.849078773066, 6095.786647467317, 6174.598651087845, 6182.381761823782, 6183.598066125687, 6175.135481032748, 6219.937800621936, 6220.626762394271, 6237.345078766845, 6237.5633705641985, 6262.561620686508, 6273.560850740404, 6277.843053923689, 6282.811515654537, 6285.0, 5895.233619629421, 5921.970390148022, 6024.1265016573225, 6129.233845769279, 6133.723982420891], "value": 5787.024440358627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.8186035351517, 819.9549024803636, 837.3594200436667, 1134.6709454258266, 1146.8623765148184, 29174.85412572937, 33828.66171338286, 36850.0, 36895.81552092239, 36910.0, 38835.41746873792, 39262.41106383399, 39320.0, 39338.4099238511, 39362.0, 5621.522170615503, 7225.674844631978, 7336.449766267525, 7363.116426028884, 7364.079490063742, 5685.971570142144, 7136.072310599615, 7287.672054757549, 7294.343509084181, 7297.051383320161, 7364.963175184143, 7407.777766667009, 7408.962955185217, 7411.629418529079, 7415.777526674181, 5634.521065709419, 7314.768995456384, 7355.779326620156, 7356.705731770723, 7364.815879602999, 5724.942750572524, 7099.467539934474, 7325.816854578625, 7334.789759689645, 7337.156227033906, 35753.28493430143, 36083.09792255188, 36138.45792313117, 36154.8192259037, 36155.096122596886, 3477.826108694555, 3521.9647803521893, 3523.4362501999813, 3523.6652518010746, 3525.5240542526685, 28180.436391272266, 28233.15300540987, 28245.71754282472, 28290.858545707346, 28291.575626365622, 3580.3913334733156, 3581.212133330689, 3585.94621080684, 3592.4611308303965, 3593.6765691087667, 187208.0, 187262.0, 187378.0, 187456.0, 187647.0, 48165.518344816104, 48308.75845620749, 48326.27510587344, 48332.0, 48390.5160948393, 50805.491945080816, 51169.23246151311, 51170.48829511732, 51193.7440312796, 51209.48790512122, 15089.849101508844, 15127.092374457568, 15130.092194468147, 15164.393424262906, 15212.315445804745, 10980.0, 11141.2201145919, 12164.2701437914, 12170.513179472722, 12182.147249692614, 15033.398664053315, 15132.621684457756, 15138.243087845563, 15193.088414695154, 15248.542543723484, 5909.231799866076, 6074.635521868702, 6076.688204928325, 6118.082287656798, 6160.383961603804, 1075.4568942683895, 1116.843641890136, 1117.3240189685287, 1120.0927248928394, 1120.4173829608558, 27541.31146721348, 27564.76374127385, 27659.86170069177, 27842.443151136864, 27856.44287114287, 1181.228157763355, 1198.856137263534, 1208.468273959455, 1208.812634041725, 1231.5073970411727, 13956.651083722989, 13959.581212563638, 14137.787933180805, 14197.077189982825, 14248.572542823731, 247121.0, 248032.0, 248484.0, 249695.0, 249738.0, 53024.20463693047, 53386.73306633442, 53542.732286339095, 53624.19563706547, 53625.0, 1480.7852861335261, 1504.3606467251375, 1543.2977995012243, 1547.0562956596468, 1547.0717569458236, 24413.460048293255, 25635.35911602225, 25858.482830342913, 25935.221943340974, 26111.216663500127, 38387.232255354174, 38458.42312365261, 38458.42312365373, 38508.2298354037, 38606.42090368703, 197676.0, 198162.0, 198972.0, 199028.0, 199274.0, 30288.0, 30509.389812204077, 33555.496667549516, 34344.14139646529, 34574.25801968592, 39693.60306396899, 41151.58848411597, 41235.793821030704, 41538.0, 41868.3252669902, 28592.285192870346, 30080.3983920316, 30130.24674383158, 30255.848720756254, 30771.53842692406, 30234.395312094075, 30257.394852103276, 30265.848670757387, 30871.69128308778, 31012.68987310188, 35332.82333588418, 35378.823105885334, 35835.10412239715, 35931.64068359283, 36244.81877590595, 29091.418171636025, 29407.11778646644, 29550.408991820474, 29600.407991840475, 30221.546676799426, 23548.529029418973, 24668.753312466644, 24801.1319603813, 24897.875510622333, 25204.495910082063], "value": 16851.32039877202, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.6506794564348, 443.89346556826354, 454.5341025448914, 459.30874034577937, 464.26877667673415, 17872.463826085204, 18827.341043063494, 19488.610227795434, 19630.116644750986, 19635.312764053262, 19384.127714252856, 20385.184592616315, 20987.580248395025, 21550.784492155075, 21658.89170554145, 5468.808591699291, 5647.774089036454, 5652.406497317784, 5653.547716182696, 5655.236543066674, 5462.7268636568215, 5537.889242215153, 5578.665280083188, 5619.297587801525, 5624.606277560572, 5593.272874526306, 5595.0, 5597.104463285855, 5601.411851755568, 5601.747921343549, 5391.649542779726, 5526.723663816793, 5563.582731295169, 5587.664740115586, 5589.74846131925, 5093.974530127326, 5099.286099946011, 5103.4896510349035, 5103.795848166069, 5106.489351064901, 25154.371140721447, 26048.73951260482, 26234.606480902803, 26518.0, 26824.73175268242, 2133.8506304558687, 2155.385715071197, 2163.697082408464, 2168.8264938805014, 2169.099823573231, 16289.0, 17247.568810779707, 17264.827351726573, 17364.218610162574, 17368.0, 2008.768991565974, 2045.928392506255, 2061.690746388039, 2065.0500769645982, 2102.5794841031857, 110033.40651900109, 113926.43036784846, 116250.0, 116493.41753291264, 117016.41491792486, 12517.311547864772, 12529.373531323397, 12559.497620095277, 12692.746145077046, 12693.0, 17725.113744312734, 17738.201780919633, 17740.822591774177, 17768.55578610545, 17773.200205990503, 8864.778380540538, 9002.369834111549, 9190.448573085636, 9229.984701682944, 9307.348485605942, 8543.871841922377, 8543.871841922377, 8607.78480537979, 8813.779655508535, 8843.557822108869, 7933.761987140395, 7974.322182614426, 8079.0, 8160.591970401456, 8163.346932245406, 2202.768709285534, 2244.304265677645, 2248.3479790860465, 2263.875486848206, 2408.963865542018, 1008.8940661230612, 1037.4916291017348, 1039.0752230514697, 1039.2777019971047, 1053.073295499955, 18717.0, 19797.208111675372, 19966.90016549908, 20007.299744508873, 20045.599088018156, 1046.9528871200814, 1055.208593554834, 1059.4914441068331, 1067.423591260726, 1077.2943721862193, 12485.438155283035, 13427.731445371039, 13546.390412431465, 13830.585082447542, 13885.514007009706, 511639.0, 523225.0, 526902.0, 531920.0, 532634.0, 97564.51217743866, 98070.0, 100587.97648093995, 104482.47758761157, 104711.47644261882, 1186.7626474705094, 1238.646985609097, 1247.108317552954, 1258.370814592722, 1264.1846009323936, 19441.805581944565, 19480.9025954875, 20060.59878802445, 20178.0, 20294.59410811805, 46548.767256163504, 46648.766756166006, 47151.0, 47409.52590474189, 47994.0, 60412.697936510034, 61490.69254653698, 61924.38075619366, 61958.0, 62560.687196563726, 9089.863652045357, 9250.259979201783, 9497.952510237405, 9500.382475139093, 9698.515074246401, 14132.717345652823, 14683.706325873636, 14761.630959226106, 15142.697146056797, 15157.166355850093, 12065.638030859089, 12772.489100435878, 13453.596392108253, 13558.457661693421, 13582.185068895898, 11247.493862776031, 11341.26281791681, 12701.8094728581, 12782.48870045225, 13338.26639534835, 13425.731485370434, 13455.596332110052, 13536.932315338361, 13682.589522314347, 13774.793378099135, 9374.296927730311, 9467.573959171716, 9620.278479114235, 9857.35927164732, 10016.849747253651, 11603.88396116028, 12925.806112908502, 13243.536476223286, 13299.468021279428, 13494.73010539764], "value": 10285.510308754132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.5759484180533, 1338.1703343926763, 1367.7538043152229, 1369.7192075624496, 1377.4903285784262, 9491.477968711719, 11141.442927853604, 11457.942710286457, 11485.196036277464, 11494.540218391254, 11201.383923884183, 11268.830967535494, 11316.038136758365, 11318.717032074182, 11319.434028298594, 1998.1108406759, 2062.267894897305, 2318.988405057972, 2352.6000579901374, 2359.9646005309933, 2292.9541409171807, 2357.9410514737183, 2361.527694461106, 2362.7755363240462, 2364.1843563970488, 2268.7958083772455, 2276.931692049241, 2286.7941885230325, 2295.449092217864, 2298.080767692928, 2268.296827983314, 2274.260865218794, 2281.566502364554, 2287.3252390544744, 2287.954240915181, 2183.3559100065518, 2189.157174487818, 2191.747948985871, 2196.1874106580667, 2196.648536234211, 11216.214864959456, 11328.037116845078, 11337.659870203906, 11354.886451135548, 11359.204855660108, 5905.173275741399, 6074.787382441594, 6079.544034197409, 6083.057126145454, 6084.60450070744, 3548.946765798489, 3706.0, 3797.7341586088983, 3838.500994870649, 3849.9807500962597, 1314.66476048607, 1317.7298653775954, 1339.109492187694, 1346.414309775251, 1403.382511694851, 17446.47660570185, 17449.476515704548, 17456.91271543647, 17466.47600571972, 17467.825321746746, 5325.920111198335, 5436.184572314184, 5503.587230957694, 5571.972140139354, 5599.452249226592, 14126.434942602385, 14176.362063706953, 14177.929110354382, 14215.64460888486, 14216.075955062888, 6370.235571731422, 6373.458256048288, 6375.840603984938, 6380.298167201604, 6380.361963803675, 4389.758563279051, 5689.374168841424, 5819.447152520504, 5857.179994800731, 5893.116032595145, 4413.867583972486, 4498.257787465097, 4541.341505481687, 4545.6136228420955, 4573.451185857652, 1368.555219553649, 1419.396756378535, 1438.9136651800925, 1443.1196969848384, 1459.9927000365142, 868.392125512144, 895.583553647557, 905.5019739143445, 914.5975770660888, 923.0308176414737, 6848.657567121624, 6860.279670634612, 7012.228654848064, 7183.820404489929, 7215.639218039077, 613.4417679911348, 624.978125765596, 628.1802248066317, 633.6103296472636, 635.0727937211723, 4164.9583504165175, 4165.541790403053, 4195.077083041726, 4206.978965105155, 4208.936865947013, 14869.702605948038, 15306.08163510193, 15336.693266134838, 15340.693186136215, 15360.0, 15028.624284392978, 15149.848501515064, 15244.0, 15428.614284642748, 15512.534623961299, 8929.464232145961, 9090.86363704545, 9098.772530686785, 9104.226140778108, 9114.40756350835, 6860.382565569123, 6983.406410455168, 6996.475264355296, 7061.329173728487, 7095.538789978635, 13294.534691285759, 13481.865181348061, 13753.38109785042, 13789.172649641054, 13799.86200138026, 13678.93160534191, 13684.726305474034, 13943.372548235557, 14092.436302547783, 14109.153450792985, 8541.615627296662, 8816.338774591803, 9378.953105234703, 9430.339876208875, 9556.522173891139, 11036.282641628268, 11264.66206013821, 11278.605248816251, 11287.379194144401, 11290.209685321948, 9040.095990400907, 9205.171534561921, 9278.257739380699, 9320.254379649476, 9422.95288523553, 8991.730248092306, 9005.909940900769, 9048.366614337196, 9132.908670913206, 9204.079592040742, 8552.401331906707, 8556.614952327285, 8567.228949394585, 8570.90012946832, 8624.353173511887, 6063.484603808725, 6074.240719910012, 6125.418085281891, 6178.165947597017, 6325.873482530232, 5956.344802071855, 5960.850978725566, 5993.9700301498215, 6051.939480605138, 6201.689915504297], "value": 5318.43123346653, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.18806664238326, 407.16531111221985, 415.6155556110598, 420.88004918598205, 421.2270483662478, 5763.769449222032, 5771.567132465061, 5794.39158888317, 5807.0, 5818.709064546777, 5588.21764952907, 5724.284464441945, 5736.282964629421, 5744.109663002241, 5744.79893203738, 4355.847545335906, 4361.738295702252, 4377.321515165155, 4377.824887004516, 4380.678240532523, 4346.15250026245, 4372.27857403528, 4385.101054283864, 4393.824247030115, 4418.3372494125815, 4230.978845105786, 4294.141171765644, 4327.6754243431715, 4348.717128447116, 4361.214981303364, 4328.718633288842, 4328.783560821947, 4331.090471001094, 4332.263515202423, 4342.848000320006, 3774.9622503774885, 3788.1287303920253, 3792.772433653962, 3798.2593394288124, 3804.1821008483034, 5529.668219906818, 5560.388357280696, 5577.442255774431, 5670.631408958446, 5677.432256774331, 5074.188129899236, 5078.365204349457, 5091.745412729349, 5092.821751238689, 5102.5662818660085, 6000.819975400745, 6063.120847477136, 6105.84735381619, 6107.4503294703245, 6127.632342059491, 4212.705110642256, 4231.0, 4240.703150779446, 4243.66050715945, 4254.553271906436, 6075.33171351151, 6183.319834818167, 6208.6585237811905, 6332.556721029529, 6417.0, 4263.531011588785, 4274.658027357804, 4298.183345164409, 4309.396684464177, 4311.482622085307, 4361.520232774392, 4362.476502819682, 4376.759278239728, 4379.233634114017, 4380.254882075843, 4948.851534453972, 5032.220005899091, 5077.619178561623, 5078.720670363092, 5101.336826212569, 6087.817365479043, 6099.664518451439, 6117.541184411187, 6126.866529692022, 6148.723307451175, 1515.181801827023, 1523.4439429608112, 1525.59571713496, 1530.188999830092, 1532.823725271608, 1010.3331801011298, 1020.4234607446917, 1028.0850043461326, 1031.0926384781344, 1041.547041876593, 5893.557983151195, 5893.911591326134, 5914.8817023659285, 5936.614120082181, 5942.851428714317, 6168.19813424252, 6265.937340626535, 6295.622262664163, 6303.653299068504, 6321.431071203522, 5857.736401861926, 5876.647401155944, 5910.763569457174, 5922.526197904157, 5956.344802071769, 3267.460868956643, 3311.2384151645256, 3315.8673653053606, 3325.8835940741956, 3336.9165770855925, 6522.119513865662, 6538.0, 6542.182227221598, 6605.86788264232, 6657.167854018247, 6383.776567820104, 6402.423781859655, 6409.775657851953, 6410.775622853271, 6445.645489498029, 6445.291017988017, 6512.967435162794, 6533.411992920564, 6576.80269591913, 6580.63806490638, 6235.095911092957, 6239.407256310643, 6245.5628106032145, 6254.8123556293385, 6286.717097730521, 6081.756729730938, 6198.163247961467, 6200.286966998853, 6200.844978875384, 6225.968870155621, 6534.607923524603, 6560.376764207393, 6582.835429114119, 6591.242007169237, 6609.603423794588, 4324.556625506579, 4381.298992161239, 4382.23310920594, 4384.934225986549, 4393.7363758174615, 6188.257409110935, 6280.780172693934, 6290.339514351111, 6327.96836015817, 6354.968225158845, 6041.577089603861, 6044.123602077762, 6090.756369745161, 6127.111568822585, 6142.692865356625, 5895.793647222326, 5986.760529578768, 6004.219451471456, 6016.819495415145, 6095.969520152371, 6064.696765161636, 6081.847953801191, 6096.390360963868, 6105.511559075175, 6109.572329936862, 5956.255468066492, 6070.757169713339, 6121.173641558333, 6140.785072522441, 6148.938510615016, 5940.79207227745, 5943.0, 5947.226860508106, 5950.732217050157, 5951.0], "value": 4622.956948700355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.4522924411398, 833.2334252487715, 834.2950207075021, 838.8783626374176, 848.2832006954123, 15514.844851551481, 15829.208539573005, 15901.602459938507, 15910.681786364266, 15915.453527435613, 13635.113717608348, 13899.652508687288, 14131.081479703813, 14217.289135543233, 14341.426342946295, 938.3384713776788, 957.1194501059042, 960.2989817433278, 962.6245764151986, 962.8988956159608, 960.7165886063628, 962.4465932089042, 965.657191696948, 965.7247684409945, 965.7633879699483, 987.6493844685141, 987.7678745494838, 987.8123156600259, 988.0613417253602, 988.6094992478003, 983.4689267795382, 984.202795735453, 987.7629368951472, 994.1053052252958, 995.6714284286168, 717.6196615793585, 717.7810767715845, 720.9819754506127, 721.1490441279341, 721.6536062689938, 15365.231738413035, 15695.843041569553, 15862.603434914105, 15867.52397428079, 15996.76004859928, 17852.46442606724, 18195.909020454812, 18471.63056738871, 18709.158087886077, 18759.718604220812, 13439.328033598378, 13619.18284902909, 13620.659483512893, 14082.0, 14270.429182832675, 3343.130785995634, 3363.6636336366414, 3364.1925937775004, 3366.5455163553097, 3367.276035652322, 92168.0, 92682.0, 93688.53155734246, 94031.0, 94068.52965735128, 14002.859971400156, 14398.784018239734, 14425.350859211361, 14460.132392056299, 14514.854851451562, 24739.0, 25514.489710205693, 26556.203313900613, 26602.866985664947, 26643.733562664125, 7330.157031941395, 7550.886736698954, 7569.280918312751, 7587.544747315179, 7594.392448604099, 3632.7638703484718, 3658.1037645776955, 3671.2657468506404, 3716.7955762432784, 3718.5723641781, 4566.908661826811, 4721.622270218374, 4724.055188962221, 4724.692894961817, 4730.124926888537, 872.3418579823642, 905.5653286422554, 907.0838453162222, 913.397157875812, 914.4741773480275, 714.5855403865745, 722.2091809468624, 723.7647764476566, 743.4609907816898, 758.2000988956704, 11053.668389948314, 11769.293842369485, 11783.469743861548, 12112.21270617407, 12523.311217882921, 696.1194089476816, 699.3635791429774, 707.1630050454913, 710.1300906389735, 722.4184531452231, 5154.994776018641, 5235.502627250406, 5390.434004429479, 5456.208849716769, 5500.642458240201, 76396.23603763891, 77122.6143869277, 78250.0, 80127.59936200282, 83887.0, 72250.63874680593, 72489.27510724825, 72713.63643181857, 72956.0, 73686.6315668429, 65470.67264663646, 67061.0, 67078.32921670818, 67286.99999999903, 69052.0, 10670.679879603624, 11064.114870810477, 11166.88833111691, 11174.49714762854, 11321.71695707614, 35192.66532024158, 35285.29429411449, 35392.646073538934, 35825.0, 36510.63489365072, 43241.0, 43469.0, 43851.122977539635, 44422.0, 45883.770581146884, 14220.502282420066, 14454.638634034232, 14458.783118253445, 14460.927695361455, 14634.634134146732, 16044.117573533102, 16077.437289694804, 16138.757918630996, 16179.11014894145, 16336.836631634007, 15062.924685376942, 15120.168390738614, 15339.156346401054, 15459.458918937784, 15467.226638667797, 14102.576922692335, 14275.64310892236, 14495.927520362331, 14668.779968300698, 14746.705065898408, 15166.31751571204, 15187.92406038007, 15248.0, 15455.53633391, 15726.247906616525, 10777.461126943464, 11066.170037247077, 11093.0, 11150.275232109887, 11163.609273675382, 11636.12729045308, 12153.635390938285, 12181.939090304491, 12207.511699532275, 12358.567450139202], "value": 7839.147283586762, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 109.0, 110.0, 112.0, 108.0, 108.0, 109.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 126.0, 173.0, 118.0, 118.0, 116.0, 117.0, 150.0, 119.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 106.0, 74.0, 74.0, 74.0, 74.0, 99.0, 75.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 111.0, 83.0, 83.0, 83.0, 95.0, 82.0, 83.0, 107.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0], "value": 93.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 44.0, 46.0, 46.0, 47.0, 46.0, 45.0, 46.0, 46.0], "value": 45.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 81.0, 79.0, 78.0, 79.0, 79.0, 78.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 133.0, 132.0, 134.0, 123.0, 126.0, 124.0, 174.0, 124.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 179.0, 179.0, 179.0, 181.0, 179.0, 180.0, 179.0, 179.0, 179.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 65.0, 67.0, 72.0, 66.0, 65.0, 65.0, 65.0], "value": 66.7, "unit": "score"}]}]} 13:02:57 INFO - Return code: 0 13:02:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:02:57 INFO - # TBPL SUCCESS # 13:02:57 INFO - Running post-action listener: _resource_record_post_action 13:02:57 INFO - [mozharness: 2017-05-10 20:02:57.425103Z] Finished run-tests step (success) 13:02:57 INFO - Running post-run listener: _resource_record_post_run 13:02:57 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 390443008; Read time: 56; Write time: 299060 13:02:57 INFO - TinderboxPrint: CPU usage
12.9% 13:02:57 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 56 13:02:57 INFO - TinderboxPrint: I/O write bytes / time
390,443,008 / 299,060 13:02:57 INFO - TinderboxPrint: CPU idle
8,287.1 (87.1%) 13:02:57 INFO - TinderboxPrint: CPU user
1,183.5 (12.4%) 13:02:57 INFO - TinderboxPrint: Swap in / out
0 / 0 13:02:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120606720; Read time: 0; Write time: 118652 13:02:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269836288; Read time: 44; Write time: 180408 13:02:58 INFO - Running post-run listener: _upload_blobber_files 13:02:58 INFO - Blob upload gear active. 13:02:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:02:58 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 13:02:58 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'] 13:02:58 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 13:02:58 INFO - (blobuploader) - INFO - Open directory for files ... 13:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:03:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:01 INFO - (blobuploader) - INFO - Done attempting. 13:03:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:03:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:03:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:02 INFO - (blobuploader) - INFO - Done attempting. 13:03:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:03:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:03:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:03 INFO - (blobuploader) - INFO - Done attempting. 13:03:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:03:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:03:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:04 INFO - (blobuploader) - INFO - Done attempting. 13:03:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:03:04 INFO - Return code: 0 13:03:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:03:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:03:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70e8cf7e69186424f968b14615df1670d706e2ba4b575716285ba2e051418169d2a8b4f85521be5d8fc8f5aee9cd7fadc166bfa1443c01dc7326c0b19738a1b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7180e84744150934f9b94ae24331850f8f48522c8d792bd140b82dd1723202ec976f411999a39e4fc197546b5b3337c51b291992abe49f80de8728611491edf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4bcd2d7deaa3b529310e62711d7bf54e97a76e0f424de306334fdba23e04308d41063f9df8b426f690857cf0adeff3aa9a7a597f75e0a368643354962336b8d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d7e2ef2698b14d58b6b6d32e6d00e26676007394b3ad1d5796c6a85c1daa52c292d7b94054c37307072846d6ad20c3a98a54d1cd32f9167e1495fff3785f29a"} 13:03:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:03:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:03:04 INFO - Contents: 13:03:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70e8cf7e69186424f968b14615df1670d706e2ba4b575716285ba2e051418169d2a8b4f85521be5d8fc8f5aee9cd7fadc166bfa1443c01dc7326c0b19738a1b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7180e84744150934f9b94ae24331850f8f48522c8d792bd140b82dd1723202ec976f411999a39e4fc197546b5b3337c51b291992abe49f80de8728611491edf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4bcd2d7deaa3b529310e62711d7bf54e97a76e0f424de306334fdba23e04308d41063f9df8b426f690857cf0adeff3aa9a7a597f75e0a368643354962336b8d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d7e2ef2698b14d58b6b6d32e6d00e26676007394b3ad1d5796c6a85c1daa52c292d7b94054c37307072846d6ad20c3a98a54d1cd32f9167e1495fff3785f29a"} 13:03:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:03:04 INFO - Copying logs to upload dir... 13:03:04 INFO - mkdir: /builds/slave/test/build/upload/logs 13:03:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.917629 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-05-10 13:03:04.573169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 13:03:04.576812) ========= 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=3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616 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/70e8cf7e69186424f968b14615df1670d706e2ba4b575716285ba2e051418169d2a8b4f85521be5d8fc8f5aee9cd7fadc166bfa1443c01dc7326c0b19738a1b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7180e84744150934f9b94ae24331850f8f48522c8d792bd140b82dd1723202ec976f411999a39e4fc197546b5b3337c51b291992abe49f80de8728611491edf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4bcd2d7deaa3b529310e62711d7bf54e97a76e0f424de306334fdba23e04308d41063f9df8b426f690857cf0adeff3aa9a7a597f75e0a368643354962336b8d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d7e2ef2698b14d58b6b6d32e6d00e26676007394b3ad1d5796c6a85c1daa52c292d7b94054c37307072846d6ad20c3a98a54d1cd32f9167e1495fff3785f29a"} build_url:https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/Us9qSO6lSYez3cEwes--pw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70e8cf7e69186424f968b14615df1670d706e2ba4b575716285ba2e051418169d2a8b4f85521be5d8fc8f5aee9cd7fadc166bfa1443c01dc7326c0b19738a1b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7180e84744150934f9b94ae24331850f8f48522c8d792bd140b82dd1723202ec976f411999a39e4fc197546b5b3337c51b291992abe49f80de8728611491edf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4bcd2d7deaa3b529310e62711d7bf54e97a76e0f424de306334fdba23e04308d41063f9df8b426f690857cf0adeff3aa9a7a597f75e0a368643354962336b8d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d7e2ef2698b14d58b6b6d32e6d00e26676007394b3ad1d5796c6a85c1daa52c292d7b94054c37307072846d6ad20c3a98a54d1cd32f9167e1495fff3785f29a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 13:03:04.602919) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 13:03:04.603284) ========= 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=3836458cccd887f2d2de3cf1000001de-1494445336.86091-1189271616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 13:03:04.688851) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 13:03:04.689187) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 13:03:04.689691) ========= ========= Total master_lag: 0.18 =========