builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-074 starttime: 1494596263.66 results: success (0) revision: 030c0a7c878192d8dc1b04c182575c2f7858cdd0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:43.662554) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:43.663045) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:43.663335) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:43.678225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:43.678635) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 06:37:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.5M=0s 2017-05-12 06:37:43 (69.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108660 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:43.801207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:43.801522) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020536 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:43.857769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 06:37:43.858164) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 030c0a7c878192d8dc1b04c182575c2f7858cdd0 --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 030c0a7c878192d8dc1b04c182575c2f7858cdd0 --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=23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 06:37:44,090 truncating revision to first 12 chars 2017-05-12 06:37:44,090 Setting DEBUG logging. 2017-05-12 06:37:44,090 attempt 1/10 2017-05-12 06:37:44,090 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/030c0a7c8781?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 06:37:45,103 unpacking tar archive at: mozilla-central-030c0a7c8781/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322101 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 06:37:45.238088) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:45.238445) ========= script_repo_revision: 030c0a7c878192d8dc1b04c182575c2f7858cdd0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:45.238899) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:45.239200) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:37:45.253380) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-12 06:37:45.253837) ========= /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=23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:37:45 INFO - MultiFileLogger online at 20170512 06:37:45 in /builds/slave/test 06:37:45 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 06:37:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:37:45 INFO - {'append_to_log': False, 06:37:45 INFO - 'base_work_dir': '/builds/slave/test', 06:37:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:37:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:37:45 INFO - 'branch': 'Firefox-Non-PGO', 06:37:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:37:45 INFO - 'config_files': ('talos/linux_config.py',), 06:37:45 INFO - 'default_actions': ('clobber', 06:37:45 INFO - 'read-buildbot-config', 06:37:45 INFO - 'download-and-extract', 06:37:45 INFO - 'populate-webroot', 06:37:45 INFO - 'create-virtualenv', 06:37:45 INFO - 'install', 06:37:45 INFO - 'run-tests'), 06:37:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:37:45 INFO - 'download_minidump_stackwalk': True, 06:37:45 INFO - 'download_symbols': 'ondemand', 06:37:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:37:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:37:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:37:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:37:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:37:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:37:45 INFO - 'gecko_profile': False, 06:37:45 INFO - 'gecko_profile_interval': 0, 06:37:45 INFO - 'installer_path': 'installer.exe', 06:37:45 INFO - 'log_level': 'info', 06:37:45 INFO - 'log_name': 'talos', 06:37:45 INFO - 'log_to_console': True, 06:37:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:37:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:37:45 INFO - 'opt_config_files': (), 06:37:45 INFO - 'pip_index': False, 06:37:45 INFO - 'suite': 'dromaeojs', 06:37:45 INFO - 'system_bits': '32', 06:37:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:37:45 INFO - 'title': 'talos-linux64-ix-074', 06:37:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:37:45 INFO - 'use_talos_json': True, 06:37:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:37:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:37:45 INFO - 'work_dir': 'build'} 06:37:45 INFO - [mozharness: 2017-05-12 13:37:45.594374Z] Running clobber step. 06:37:45 INFO - Running pre-action listener: _resource_record_pre_action 06:37:45 INFO - Running main action method: clobber 06:37:45 INFO - rmtree: /builds/slave/test/build 06:37:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:37:46 INFO - Running post-action listener: _resource_record_post_action 06:37:46 INFO - [mozharness: 2017-05-12 13:37:46.590287Z] Finished clobber step (success) 06:37:46 INFO - [mozharness: 2017-05-12 13:37:46.590388Z] Running read-buildbot-config step. 06:37:46 INFO - Running pre-action listener: _resource_record_pre_action 06:37:46 INFO - Running main action method: read_buildbot_config 06:37:46 INFO - Using buildbot properties: 06:37:46 INFO - { 06:37:46 INFO - "project": "", 06:37:46 INFO - "product": "firefox", 06:37:46 INFO - "who": "cbook@mozilla.com", 06:37:46 INFO - "installer_path": "public/build/target.tar.bz2", 06:37:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:37:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:37:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:37:46 INFO - "stage_platform": "linux64", 06:37:46 INFO - "basedir": "/builds/slave/test", 06:37:46 INFO - "buildnumber": 990, 06:37:46 INFO - "platform": "ubuntu64_hw", 06:37:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:37:46 INFO - "slavebuilddir": "test", 06:37:46 INFO - "taskId": "A_S8SSzUQkCFyYO9rWA7dQ", 06:37:46 INFO - "branch": "mozilla-central", 06:37:46 INFO - "script_repo_revision": "production", 06:37:46 INFO - "revision": "030c0a7c878192d8dc1b04c182575c2f7858cdd0", 06:37:46 INFO - "slavename": "talos-linux64-ix-074", 06:37:46 INFO - "repo_path": "mozilla-central" 06:37:46 INFO - } 06:37:46 INFO - Finding installer, test and symbols from parent task. 06:37:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A_S8SSzUQkCFyYO9rWA7dQ'}, attempt #1 06:37:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A_S8SSzUQkCFyYO9rWA7dQ'}, attempt #1 06:37:47 INFO - Task dependencies: A4OXc7j_SrifIR5xeHyHBQ 06:37:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ'}, attempt #1 06:37:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 06:37:47 INFO - Set test_url: https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/test_packages.json 06:37:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.crashreporter-symbols.zip 06:37:47 INFO - Running post-action listener: _resource_record_post_action 06:37:47 INFO - [mozharness: 2017-05-12 13:37:47.966574Z] Finished read-buildbot-config step (success) 06:37:47 INFO - [mozharness: 2017-05-12 13:37:47.966792Z] Running download-and-extract step. 06:37:47 INFO - Running pre-action listener: _resource_record_pre_action 06:37:47 INFO - Running main action method: download_and_extract 06:37:47 INFO - mkdir: /builds/slave/test/build/tests 06:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:37:47 INFO - trying https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.test_packages.json 06:37:47 INFO - Downloading https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:37:48 INFO - Downloaded 986 bytes. 06:37:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:37:48 INFO - Using the following test package requirements: 06:37:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:37:48 INFO - u'common': [u'target.common.tests.zip'], 06:37:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:37:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:37:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:37:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:37:48 INFO - u'mozbase': [u'target.common.tests.zip'], 06:37:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:37:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:37:48 INFO - u'web-platform': [u'target.common.tests.zip', 06:37:48 INFO - u'target.web-platform.tests.zip'], 06:37:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:37:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:37:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip 06:37:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:37:48 INFO - Fetch https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip into memory 06:37:49 INFO - Content-Length response header: 62447477 06:37:49 INFO - Bytes received: 62447477 06:38:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:38:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip 06:38:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:38:00 INFO - Fetch https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip into memory 06:38:02 INFO - Content-Length response header: 62447477 06:38:02 INFO - Bytes received: 62447477 06:38:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.talos.tests.zip 06:38:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:38:13 INFO - Fetch https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.talos.tests.zip into memory 06:38:14 INFO - Content-Length response header: 14409411 06:38:14 INFO - Bytes received: 14409411 06:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:14 INFO - trying https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 06:38:14 INFO - Downloading https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:38:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:38:16 INFO - Downloaded 63465738 bytes. 06:38:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 06:38:16 INFO - mkdir: /builds/slave/test/properties 06:38:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:38:16 INFO - Writing to file /builds/slave/test/properties/build_url 06:38:16 INFO - Contents: 06:38:16 INFO - build_url:https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 06:38:16 INFO - Running post-action listener: _resource_record_post_action 06:38:16 INFO - Running post-action listener: set_extra_try_arguments 06:38:16 INFO - [mozharness: 2017-05-12 13:38:16.394456Z] Finished download-and-extract step (success) 06:38:16 INFO - [mozharness: 2017-05-12 13:38:16.394685Z] Running populate-webroot step. 06:38:16 INFO - Running pre-action listener: _resource_record_pre_action 06:38:16 INFO - Running main action method: populate_webroot 06:38:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:38:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:38:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:38:16 INFO - '--tppagecycles', 06:38:16 INFO - '7'], 06:38:16 INFO - 'tests': ['tsvgm']}}, 06:38:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:38:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:38:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:38:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:38:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:38:16 INFO - 'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:38:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:38:16 INFO - 'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['damp', 'tps']}, 06:38:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:38:16 INFO - 'tests': ['damp', 'tps']}, 06:38:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['dromaeo_dom']}, 06:38:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:38:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:38:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:38:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['a11yr', 06:38:16 INFO - 'ts_paint', 06:38:16 INFO - 'tpaint', 06:38:16 INFO - 'sessionrestore', 06:38:16 INFO - 'sessionrestore_no_auto_restore', 06:38:16 INFO - 'tabpaint']}, 06:38:16 INFO - 'other-e10s': {'tests': ['a11yr', 06:38:16 INFO - 'ts_paint', 06:38:16 INFO - 'tpaint', 06:38:16 INFO - 'sessionrestore', 06:38:16 INFO - 'sessionrestore_no_auto_restore', 06:38:16 INFO - 'tabpaint']}, 06:38:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:38:16 INFO - 'ts_paint', 06:38:16 INFO - 'tpaint', 06:38:16 INFO - 'sessionrestore', 06:38:16 INFO - 'sessionrestore_no_auto_restore', 06:38:16 INFO - 'tabpaint']}, 06:38:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:38:16 INFO - 'ts_paint', 06:38:16 INFO - 'tpaint', 06:38:16 INFO - 'sessionrestore', 06:38:16 INFO - 'sessionrestore_no_auto_restore', 06:38:16 INFO - 'tabpaint']}, 06:38:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['a11yr', 06:38:16 INFO - 'ts_paint', 06:38:16 INFO - 'tpaint', 06:38:16 INFO - 'sessionrestore', 06:38:16 INFO - 'sessionrestore_no_auto_restore', 06:38:16 INFO - 'tabpaint']}, 06:38:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['a11yr', 06:38:16 INFO - 'ts_paint', 06:38:16 INFO - 'tpaint', 06:38:16 INFO - 'sessionrestore', 06:38:16 INFO - 'sessionrestore_no_auto_restore', 06:38:16 INFO - 'tabpaint']}, 06:38:16 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:38:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:38:16 INFO - 'bloom_basic_ref']}, 06:38:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['tsvgx', 06:38:16 INFO - 'tsvgr_opacity', 06:38:16 INFO - 'tart', 06:38:16 INFO - 'tscrollx', 06:38:16 INFO - 'cart', 06:38:16 INFO - 'tsvg_static']}, 06:38:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:38:16 INFO - 'tsvgr_opacity', 06:38:16 INFO - 'tart', 06:38:16 INFO - 'tscrollx', 06:38:16 INFO - 'cart', 06:38:16 INFO - 'tsvg_static']}, 06:38:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:38:16 INFO - 'talos_options': ['--disable-e10s'], 06:38:16 INFO - 'tests': ['tp5o']}, 06:38:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:38:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:38:16 INFO - 'talos_options': ['--disable-e10s', 06:38:16 INFO - '--xperf_path', 06:38:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:16 INFO - 'tests': ['tp5n']}, 06:38:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:38:16 INFO - 'talos_options': ['--xperf_path', 06:38:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:16 INFO - 'tests': ['tp5n']}}, 06:38:16 INFO - 'talos.zip': {'path': '', 06:38:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:38:16 INFO - Running post-action listener: _resource_record_post_action 06:38:16 INFO - [mozharness: 2017-05-12 13:38:16.412740Z] Finished populate-webroot step (success) 06:38:16 INFO - [mozharness: 2017-05-12 13:38:16.412830Z] Running create-virtualenv step. 06:38:16 INFO - Running pre-action listener: _resource_record_pre_action 06:38:16 INFO - Running main action method: create_virtualenv 06:38:16 INFO - Creating virtualenv /builds/slave/test/build/venv 06:38:16 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 06:38:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:38:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:38:16 INFO - Using real prefix '/usr' 06:38:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:38:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:38:18 INFO - Installing pip.................done. 06:38:18 INFO - Return code: 0 06:38:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:38:19 INFO - Reading from file tmpfile_stdout 06:38:19 INFO - Output received: 06:38:19 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) 06:38:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1d821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', '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 06:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 06:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:38:19 INFO - Using env: {'DISPLAY': ':0', 06:38:19 INFO - 'HOME': '/home/cltbld', 06:38:19 INFO - 'LANG': 'en_US.UTF-8', 06:38:19 INFO - 'LANGUAGE': 'en_US:en', 06:38:19 INFO - 'LOGNAME': 'cltbld', 06:38:19 INFO - 'MAIL': '/var/mail/cltbld', 06:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:19 INFO - 'MOZ_NO_REMOTE': '1', 06:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:19 INFO - 'NO_EM_RESTART': '1', 06:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:19 INFO - 'PWD': '/builds/slave/test', 06:38:19 INFO - 'SHELL': '/bin/bash', 06:38:19 INFO - 'SHLVL': '1', 06:38:19 INFO - 'TERM': 'linux', 06:38:19 INFO - 'TMOUT': '86400', 06:38:19 INFO - 'USER': 'cltbld', 06:38:19 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:19 INFO - '_': '/tools/buildbot/bin/python'} 06:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:19 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 06:38:19 INFO - Cleaning up... 06:38:19 INFO - Return code: 0 06:38:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1d821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', '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 06:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 06:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:38:19 INFO - Using env: {'DISPLAY': ':0', 06:38:19 INFO - 'HOME': '/home/cltbld', 06:38:19 INFO - 'LANG': 'en_US.UTF-8', 06:38:19 INFO - 'LANGUAGE': 'en_US:en', 06:38:19 INFO - 'LOGNAME': 'cltbld', 06:38:19 INFO - 'MAIL': '/var/mail/cltbld', 06:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:19 INFO - 'MOZ_NO_REMOTE': '1', 06:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:19 INFO - 'NO_EM_RESTART': '1', 06:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:19 INFO - 'PWD': '/builds/slave/test', 06:38:19 INFO - 'SHELL': '/bin/bash', 06:38:19 INFO - 'SHLVL': '1', 06:38:19 INFO - 'TERM': 'linux', 06:38:19 INFO - 'TMOUT': '86400', 06:38:19 INFO - 'USER': 'cltbld', 06:38:19 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:19 INFO - '_': '/tools/buildbot/bin/python'} 06:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:19 INFO - Downloading/unpacking psutil>=3.1.1 06:38:19 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 06:38:19 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 06:38:19 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 06:38:19 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 06:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:38:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:20 INFO - Installing collected packages: psutil 06:38:20 INFO - Running setup.py install for psutil 06:38:20 INFO - building 'psutil._psutil_linux' extension 06:38:20 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 06:38:21 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 06:38:21 INFO - building 'psutil._psutil_posix' extension 06:38:21 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 06:38:21 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 06:38:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:21 INFO - Successfully installed psutil 06:38:21 INFO - Cleaning up... 06:38:21 INFO - Return code: 0 06:38:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1d821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', '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 06:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 06:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:38:21 INFO - Using env: {'DISPLAY': ':0', 06:38:21 INFO - 'HOME': '/home/cltbld', 06:38:21 INFO - 'LANG': 'en_US.UTF-8', 06:38:21 INFO - 'LANGUAGE': 'en_US:en', 06:38:21 INFO - 'LOGNAME': 'cltbld', 06:38:21 INFO - 'MAIL': '/var/mail/cltbld', 06:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:21 INFO - 'MOZ_NO_REMOTE': '1', 06:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:21 INFO - 'NO_EM_RESTART': '1', 06:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:21 INFO - 'PWD': '/builds/slave/test', 06:38:21 INFO - 'SHELL': '/bin/bash', 06:38:21 INFO - 'SHLVL': '1', 06:38:21 INFO - 'TERM': 'linux', 06:38:21 INFO - 'TMOUT': '86400', 06:38:21 INFO - 'USER': 'cltbld', 06:38:21 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:21 INFO - '_': '/tools/buildbot/bin/python'} 06:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:38:22 INFO - Installing collected packages: mozsystemmonitor 06:38:22 INFO - Running setup.py install for mozsystemmonitor 06:38:22 INFO - Successfully installed mozsystemmonitor 06:38:22 INFO - Cleaning up... 06:38:22 INFO - Return code: 0 06:38:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:22 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/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 0x1d821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', '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 06:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 06:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:38:22 INFO - Using env: {'DISPLAY': ':0', 06:38:22 INFO - 'HOME': '/home/cltbld', 06:38:22 INFO - 'LANG': 'en_US.UTF-8', 06:38:22 INFO - 'LANGUAGE': 'en_US:en', 06:38:22 INFO - 'LOGNAME': 'cltbld', 06:38:22 INFO - 'MAIL': '/var/mail/cltbld', 06:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:22 INFO - 'MOZ_NO_REMOTE': '1', 06:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:22 INFO - 'NO_EM_RESTART': '1', 06:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:22 INFO - 'PWD': '/builds/slave/test', 06:38:22 INFO - 'SHELL': '/bin/bash', 06:38:22 INFO - 'SHLVL': '1', 06:38:22 INFO - 'TERM': 'linux', 06:38:22 INFO - 'TMOUT': '86400', 06:38:22 INFO - 'USER': 'cltbld', 06:38:22 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:22 INFO - '_': '/tools/buildbot/bin/python'} 06:38:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:23 INFO - Downloading/unpacking jsonschema==2.5.1 06:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:24 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:38:24 INFO - warning: no files found matching '*.txt' 06:38:24 INFO - no previously-included directories found matching 'build' 06:38:24 INFO - no previously-included directories found matching 'dist' 06:38:24 INFO - no previously-included directories found matching '.git*' 06:38:24 INFO - Installing collected packages: jsonschema, functools32 06:38:24 INFO - Running setup.py install for functools32 06:38:24 INFO - warning: no files found matching '*.txt' 06:38:24 INFO - no previously-included directories found matching 'build' 06:38:24 INFO - no previously-included directories found matching 'dist' 06:38:24 INFO - no previously-included directories found matching '.git*' 06:38:24 INFO - Successfully installed jsonschema functools32 06:38:24 INFO - Cleaning up... 06:38:24 INFO - Return code: 0 06:38:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:24 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/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 0x1d821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', '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 06:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 06:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:38:24 INFO - Using env: {'DISPLAY': ':0', 06:38:24 INFO - 'HOME': '/home/cltbld', 06:38:24 INFO - 'LANG': 'en_US.UTF-8', 06:38:24 INFO - 'LANGUAGE': 'en_US:en', 06:38:24 INFO - 'LOGNAME': 'cltbld', 06:38:24 INFO - 'MAIL': '/var/mail/cltbld', 06:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:24 INFO - 'MOZ_NO_REMOTE': '1', 06:38:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:24 INFO - 'NO_EM_RESTART': '1', 06:38:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:24 INFO - 'PWD': '/builds/slave/test', 06:38:24 INFO - 'SHELL': '/bin/bash', 06:38:24 INFO - 'SHLVL': '1', 06:38:24 INFO - 'TERM': 'linux', 06:38:24 INFO - 'TMOUT': '86400', 06:38:24 INFO - 'USER': 'cltbld', 06:38:24 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:24 INFO - '_': '/tools/buildbot/bin/python'} 06:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:38:24 INFO - Cleaning up... 06:38:24 INFO - Return code: 0 06:38:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:24 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/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 0x1d821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', '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 06:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 06:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:38:24 INFO - Using env: {'DISPLAY': ':0', 06:38:24 INFO - 'HOME': '/home/cltbld', 06:38:24 INFO - 'LANG': 'en_US.UTF-8', 06:38:24 INFO - 'LANGUAGE': 'en_US:en', 06:38:24 INFO - 'LOGNAME': 'cltbld', 06:38:24 INFO - 'MAIL': '/var/mail/cltbld', 06:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:24 INFO - 'MOZ_NO_REMOTE': '1', 06:38:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:24 INFO - 'NO_EM_RESTART': '1', 06:38:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:24 INFO - 'PWD': '/builds/slave/test', 06:38:24 INFO - 'SHELL': '/bin/bash', 06:38:24 INFO - 'SHLVL': '1', 06:38:24 INFO - 'TERM': 'linux', 06:38:24 INFO - 'TMOUT': '86400', 06:38:24 INFO - 'USER': 'cltbld', 06:38:24 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:24 INFO - '_': '/tools/buildbot/bin/python'} 06:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:24 INFO - Downloading/unpacking blobuploader==1.2.4 06:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:26 INFO - Downloading blobuploader-1.2.4.tar.gz 06:38:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:38:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:38:26 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 06:38:26 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 06:38:26 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 06:38:26 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 06:38:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:38:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:38:26 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 06:38:26 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 06:38:26 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 06:38:26 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 06:38:26 INFO - Downloading docopt-0.6.1.tar.gz 06:38:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:38:26 INFO - Installing collected packages: blobuploader, requests, docopt 06:38:26 INFO - Running setup.py install for blobuploader 06:38:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:38:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:38:26 INFO - Running setup.py install for requests 06:38:27 INFO - Running setup.py install for docopt 06:38:27 INFO - Successfully installed blobuploader requests docopt 06:38:27 INFO - Cleaning up... 06:38:27 INFO - Return code: 0 06:38:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:27 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/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 0x1d821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', '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 06:38:27 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:38:27 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:38:27 INFO - Using env: {'DISPLAY': ':0', 06:38:27 INFO - 'HOME': '/home/cltbld', 06:38:27 INFO - 'LANG': 'en_US.UTF-8', 06:38:27 INFO - 'LANGUAGE': 'en_US:en', 06:38:27 INFO - 'LOGNAME': 'cltbld', 06:38:27 INFO - 'MAIL': '/var/mail/cltbld', 06:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:27 INFO - 'MOZ_NO_REMOTE': '1', 06:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:27 INFO - 'NO_EM_RESTART': '1', 06:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:27 INFO - 'PWD': '/builds/slave/test', 06:38:27 INFO - 'SHELL': '/bin/bash', 06:38:27 INFO - 'SHLVL': '1', 06:38:27 INFO - 'TERM': 'linux', 06:38:27 INFO - 'TMOUT': '86400', 06:38:27 INFO - 'USER': 'cltbld', 06:38:27 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:27 INFO - '_': '/tools/buildbot/bin/python'} 06:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:27 INFO - Running setup.py (path:/tmp/pip-JfEPbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:27 INFO - Running setup.py (path:/tmp/pip-oZTY9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:27 INFO - Running setup.py (path:/tmp/pip-CKW6Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:27 INFO - Running setup.py (path:/tmp/pip-uDt8bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:27 INFO - Running setup.py (path:/tmp/pip-HqwyJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:27 INFO - Running setup.py (path:/tmp/pip-Lr3iMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:27 INFO - Running setup.py (path:/tmp/pip-Bw4UZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:27 INFO - Running setup.py (path:/tmp/pip-uVeDgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:28 INFO - Running setup.py (path:/tmp/pip-qnfZB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:28 INFO - Running setup.py (path:/tmp/pip-LiOc1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:28 INFO - Running setup.py (path:/tmp/pip-wVFID8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:28 INFO - Running setup.py (path:/tmp/pip-vTZx9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:28 INFO - Running setup.py (path:/tmp/pip-HMKq6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:28 INFO - Running setup.py (path:/tmp/pip-vCQ0lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:28 INFO - Running setup.py (path:/tmp/pip-MsXctm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:28 INFO - Running setup.py (path:/tmp/pip-L2x5d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:28 INFO - Running setup.py (path:/tmp/pip-1kfN_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:38:28 INFO - Running setup.py install for manifestparser 06:38:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:38:28 INFO - Running setup.py install for mozcrash 06:38:28 INFO - Running setup.py install for mozdebug 06:38:28 INFO - Running setup.py install for mozdevice 06:38:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Running setup.py install for mozfile 06:38:29 INFO - Running setup.py install for mozhttpd 06:38:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Running setup.py install for mozinfo 06:38:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Running setup.py install for mozInstall 06:38:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Running setup.py install for mozleak 06:38:29 INFO - Running setup.py install for mozlog 06:38:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Running setup.py install for moznetwork 06:38:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Running setup.py install for mozprocess 06:38:29 INFO - Running setup.py install for mozprofile 06:38:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:38:29 INFO - Running setup.py install for mozrunner 06:38:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:38:30 INFO - Running setup.py install for mozscreenshot 06:38:30 INFO - Running setup.py install for moztest 06:38:30 INFO - Running setup.py install for mozversion 06:38:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:38:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:38:30 INFO - Cleaning up... 06:38:30 INFO - Return code: 0 06:38:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:30 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/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 0x1d821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', '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 06:38:30 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:38:30 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:38:30 INFO - Using env: {'DISPLAY': ':0', 06:38:30 INFO - 'HOME': '/home/cltbld', 06:38:30 INFO - 'LANG': 'en_US.UTF-8', 06:38:30 INFO - 'LANGUAGE': 'en_US:en', 06:38:30 INFO - 'LOGNAME': 'cltbld', 06:38:30 INFO - 'MAIL': '/var/mail/cltbld', 06:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:30 INFO - 'MOZ_NO_REMOTE': '1', 06:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:30 INFO - 'NO_EM_RESTART': '1', 06:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:30 INFO - 'PWD': '/builds/slave/test', 06:38:30 INFO - 'SHELL': '/bin/bash', 06:38:30 INFO - 'SHLVL': '1', 06:38:30 INFO - 'TERM': 'linux', 06:38:30 INFO - 'TMOUT': '86400', 06:38:30 INFO - 'USER': 'cltbld', 06:38:30 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:30 INFO - '_': '/tools/buildbot/bin/python'} 06:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:30 INFO - Running setup.py (path:/tmp/pip-qcLbfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:30 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)) 06:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:30 INFO - Running setup.py (path:/tmp/pip-dB7408-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:30 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)) 06:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:30 INFO - Running setup.py (path:/tmp/pip-CthCLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:30 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)) 06:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:30 INFO - Running setup.py (path:/tmp/pip-SbTb29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:30 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)) 06:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:30 INFO - Running setup.py (path:/tmp/pip-4vYfFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:31 INFO - Running setup.py (path:/tmp/pip-DOltmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:31 INFO - Running setup.py (path:/tmp/pip-h1kt9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:31 INFO - Running setup.py (path:/tmp/pip-ehtlgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:31 INFO - Running setup.py (path:/tmp/pip-WoD0O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:31 INFO - Running setup.py (path:/tmp/pip-OVfVR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:31 INFO - Running setup.py (path:/tmp/pip-VpeU92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:31 INFO - Running setup.py (path:/tmp/pip-1DRg71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:31 INFO - Running setup.py (path:/tmp/pip-CN4myt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:31 INFO - Running setup.py (path:/tmp/pip-O8GFmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:31 INFO - Running setup.py (path:/tmp/pip-_ySBNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:31 INFO - Running setup.py (path:/tmp/pip-O0JxiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:31 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)) 06:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:31 INFO - Running setup.py (path:/tmp/pip-hqJqbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:31 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)) 06:38:31 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)) 06:38:31 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)) 06:38:31 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)) 06:38:31 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)) 06:38:31 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)) 06:38:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:32 INFO - Downloading blessings-1.6.tar.gz 06:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:38:33 INFO - Installing collected packages: blessings 06:38:33 INFO - Running setup.py install for blessings 06:38:33 INFO - Successfully installed blessings 06:38:33 INFO - Cleaning up... 06:38:33 INFO - Return code: 0 06:38:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:38:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:33 INFO - Reading from file tmpfile_stdout 06:38:33 INFO - Current package versions: 06:38:33 INFO - argparse == 1.2.1 06:38:33 INFO - blessings == 1.6 06:38:33 INFO - blobuploader == 1.2.4 06:38:33 INFO - docopt == 0.6.1 06:38:33 INFO - functools32 == 3.2.3-2 06:38:33 INFO - jsonschema == 2.5.1 06:38:33 INFO - manifestparser == 1.1 06:38:33 INFO - mozInstall == 1.12 06:38:33 INFO - mozcrash == 1.0 06:38:33 INFO - mozdebug == 0.1 06:38:33 INFO - mozdevice == 0.50 06:38:33 INFO - mozfile == 1.2 06:38:33 INFO - mozhttpd == 0.7 06:38:33 INFO - mozinfo == 0.9 06:38:33 INFO - mozleak == 0.1 06:38:33 INFO - mozlog == 3.4 06:38:33 INFO - moznetwork == 0.27 06:38:33 INFO - mozprocess == 0.25 06:38:33 INFO - mozprofile == 0.28 06:38:33 INFO - mozrunner == 6.13 06:38:33 INFO - mozscreenshot == 0.1 06:38:33 INFO - mozsystemmonitor == 0.3 06:38:33 INFO - moztest == 0.8 06:38:33 INFO - mozversion == 1.4 06:38:33 INFO - psutil == 3.1.1 06:38:33 INFO - requests == 1.2.3 06:38:33 INFO - wsgiref == 0.1.2 06:38:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:33 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/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 0x1d821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', '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 06:38:33 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:38:33 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:38:33 INFO - Using env: {'DISPLAY': ':0', 06:38:33 INFO - 'HOME': '/home/cltbld', 06:38:33 INFO - 'LANG': 'en_US.UTF-8', 06:38:33 INFO - 'LANGUAGE': 'en_US:en', 06:38:33 INFO - 'LOGNAME': 'cltbld', 06:38:33 INFO - 'MAIL': '/var/mail/cltbld', 06:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:33 INFO - 'MOZ_NO_REMOTE': '1', 06:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:33 INFO - 'NO_EM_RESTART': '1', 06:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:33 INFO - 'PWD': '/builds/slave/test', 06:38:33 INFO - 'SHELL': '/bin/bash', 06:38:33 INFO - 'SHLVL': '1', 06:38:33 INFO - 'TERM': 'linux', 06:38:33 INFO - 'TMOUT': '86400', 06:38:33 INFO - 'USER': 'cltbld', 06:38:33 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:33 INFO - '_': '/tools/buildbot/bin/python'} 06:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:33 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)) 06:38:33 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)) 06:38:33 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)) 06:38:33 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)) 06:38:33 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)) 06:38:33 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)) 06:38:33 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)) 06:38:33 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)) 06:38:33 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)) 06:38:33 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)) 06:38:33 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)) 06:38:33 INFO - Cleaning up... 06:38:33 INFO - Return code: 0 06:38:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1d821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', '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 06:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:38:33 INFO - Using env: {'DISPLAY': ':0', 06:38:33 INFO - 'HOME': '/home/cltbld', 06:38:33 INFO - 'LANG': 'en_US.UTF-8', 06:38:33 INFO - 'LANGUAGE': 'en_US:en', 06:38:33 INFO - 'LOGNAME': 'cltbld', 06:38:33 INFO - 'MAIL': '/var/mail/cltbld', 06:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:33 INFO - 'MOZ_NO_REMOTE': '1', 06:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:33 INFO - 'NO_EM_RESTART': '1', 06:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:33 INFO - 'PWD': '/builds/slave/test', 06:38:33 INFO - 'SHELL': '/bin/bash', 06:38:33 INFO - 'SHLVL': '1', 06:38:33 INFO - 'TERM': 'linux', 06:38:33 INFO - 'TMOUT': '86400', 06:38:33 INFO - 'USER': 'cltbld', 06:38:33 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:33 INFO - '_': '/tools/buildbot/bin/python'} 06:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:38:33 INFO - Cleaning up... 06:38:33 INFO - Return code: 0 06:38:33 INFO - Running post-action listener: _resource_record_post_action 06:38:33 INFO - Running post-action listener: _start_resource_monitoring 06:38:33 INFO - Starting resource monitoring. 06:38:33 INFO - [mozharness: 2017-05-12 13:38:33.894131Z] Finished create-virtualenv step (success) 06:38:33 INFO - [mozharness: 2017-05-12 13:38:33.894637Z] Running install step. 06:38:33 INFO - Running pre-action listener: _resource_record_pre_action 06:38:33 INFO - Running main action method: install 06:38:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:34 INFO - Reading from file tmpfile_stdout 06:38:34 INFO - Detecting whether we're running mozinstall >=1.0... 06:38:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:38:34 INFO - Reading from file tmpfile_stdout 06:38:34 INFO - Output received: 06:38:34 INFO - Usage: mozinstall [options] installer 06:38:34 INFO - Options: 06:38:34 INFO - -h, --help show this help message and exit 06:38:34 INFO - -d DEST, --destination=DEST 06:38:34 INFO - Directory to install application into. [default: 06:38:34 INFO - "/builds/slave/test"] 06:38:34 INFO - --app=APP Application being installed. [default: firefox] 06:38:34 INFO - mkdir: /builds/slave/test/build/application 06:38:34 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'] 06:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:38:50 INFO - Reading from file tmpfile_stdout 06:38:50 INFO - Output received: 06:38:50 INFO - /builds/slave/test/build/application/firefox/firefox 06:38:50 INFO - Running post-action listener: _resource_record_post_action 06:38:50 INFO - [mozharness: 2017-05-12 13:38:50.124416Z] Finished install step (success) 06:38:50 INFO - [mozharness: 2017-05-12 13:38:50.124559Z] Running run-tests step. 06:38:50 INFO - Running pre-action listener: _resource_record_pre_action 06:38:50 INFO - Running main action method: run_tests 06:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:38:50 INFO - Python 2.7.3 06:38:50 INFO - Return code: 0 06:38:50 INFO - grabbing minidump binary from tooltool 06:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 06:38:50 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 0x20f1a30>, '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 0x20f27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f2ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:38:50 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 06:38:50 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 06:38:50 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 06:38:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:38:50 INFO - Return code: 0 06:38:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:38:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:38:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:38:50 INFO - ENV: RUST_BACKTRACE is now 1 06:38:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:38:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:38:50 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/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 06:38:50 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/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-074 --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 06:38:50 INFO - Using env: {'DISPLAY': ':0', 06:38:50 INFO - 'HOME': '/home/cltbld', 06:38:50 INFO - 'LANG': 'en_US.UTF-8', 06:38:50 INFO - 'LANGUAGE': 'en_US:en', 06:38:50 INFO - 'LOGNAME': 'cltbld', 06:38:50 INFO - 'MAIL': '/var/mail/cltbld', 06:38:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:38:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:50 INFO - 'MOZ_NO_REMOTE': '1', 06:38:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:50 INFO - 'NO_EM_RESTART': '1', 06:38:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:50 INFO - 'PWD': '/builds/slave/test', 06:38:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:38:50 INFO - 'RUST_BACKTRACE': '1', 06:38:50 INFO - 'SHELL': '/bin/bash', 06:38:50 INFO - 'SHLVL': '1', 06:38:50 INFO - 'TERM': 'linux', 06:38:50 INFO - 'TMOUT': '86400', 06:38:50 INFO - 'USER': 'cltbld', 06:38:50 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560', 06:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:50 INFO - '_': '/tools/buildbot/bin/python'} 06:38:50 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/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 06:38:50 INFO - mozversion application_buildid: 20170512123749 06:38:50 INFO - mozversion application_changeset: 030c0a7c878192d8dc1b04c182575c2f7858cdd0 06:38:50 INFO - mozversion application_display_name: Nightly 06:38:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:38:50 INFO - mozversion application_name: Firefox 06:38:50 INFO - mozversion application_remotingname: firefox 06:38:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:38:50 INFO - mozversion application_vendor: Mozilla 06:38:50 INFO - mozversion application_version: 55.0a1 06:38:50 INFO - mozversion platform_buildid: 20170512123749 06:38:50 INFO - mozversion platform_changeset: 030c0a7c878192d8dc1b04c182575c2f7858cdd0 06:38:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:38:50 INFO - mozversion platform_version: 55.0a1 06:38:50 INFO - using testdate: 1494596330 06:38:50 INFO - actual date: 1494596330 06:38:50 INFO - starting webserver on 'localhost:37813' 06:38:50 INFO - SUITE-START | Running 2 tests 06:38:50 INFO - TEST-START | dromaeo_css 06:38:50 INFO - operating with platform_type : linux_ 06:38:50 INFO - Initialising browser for dromaeo_css test... 06:38:50 INFO - TEST-INFO | started process 8352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnXXKHf/profile http://localhost:37813/getInfo.html) 06:38:55 INFO - PID 8352 | __metrics Screen width/height:1600/1200 06:38:55 INFO - PID 8352 | colorDepth:24 06:38:55 INFO - PID 8352 | Browser inner width/height: 1024/695 06:38:55 INFO - PID 8352 | __metrics 06:38:56 INFO - PID 8352 | 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" 06:38:56 INFO - PID 8352 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:38:57 INFO - TEST-INFO | 8352: exit 0 06:38:57 INFO - Browser initialized. 06:38:57 INFO - Running cycle 1/1 for dromaeo_css test... 06:38:57 INFO - TEST-INFO | started process 8448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnXXKHf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:09 INFO - PID 8448 | RSS: Main: 148750336 06:39:09 INFO - PID 8448 | 06:42:16 INFO - PID 8448 | Cycle 1(1): loaded http://localhost:37813/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37813/tests/dromaeo/cssquery-ext.html) 06:42:17 INFO - PID 8448 | RSS: Main: 250740736 06:42:17 INFO - PID 8448 | 06:45:19 INFO - PID 8448 | Cycle 1(1): loaded http://localhost:37813/tests/dromaeo/cssquery-ext.html (next: http://localhost:37813/tests/dromaeo/cssquery-jquery.html) 06:45:20 INFO - PID 8448 | RSS: Main: 234070016 06:45:20 INFO - PID 8448 | 06:48:22 INFO - PID 8448 | Cycle 1(1): loaded http://localhost:37813/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37813/tests/dromaeo/cssquery-mootools.html) 06:48:22 INFO - PID 8448 | RSS: Main: 178532352 06:48:22 INFO - PID 8448 | 06:51:24 INFO - PID 8448 | Cycle 1(1): loaded http://localhost:37813/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37813/tests/dromaeo/cssquery-prototype.html) 06:51:25 INFO - PID 8448 | RSS: Main: 203685888 06:51:25 INFO - PID 8448 | 06:54:28 INFO - PID 8448 | Cycle 1(1): loaded http://localhost:37813/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37813/tests/dromaeo/cssquery-yui.html) 06:54:29 INFO - PID 8448 | RSS: Main: 179785728 06:54:29 INFO - PID 8448 | 06:57:31 INFO - PID 8448 | Cycle 1(1): loaded http://localhost:37813/tests/dromaeo/cssquery-yui.html (next: http://localhost:37813/tests/dromaeo/cssquery-dojo.html) 06:57:31 INFO - PID 8448 | RSS: Main: 275988480 06:57:31 INFO - PID 8448 | 06:57:31 INFO - PID 8448 | __start_tp_report 06:57:31 INFO - PID 8448 | _x_x_mozilla_page_load 06:57:31 INFO - PID 8448 | _x_x_mozilla_page_load_details 06:57:31 INFO - PID 8448 | |i|pagename|runs| 06:57:31 INFO - PID 8448 | |0;dojo.html;2692;2701.0546308791936;2736.644236249287;2743.05364649196;2743.3827388837503;5045.243213517974;5186.222066689998;5190.429052804188;5205.228044939364;5243.397009343927;5165.199394093921;5167.48325167484;5179.19722443022;5205.193195054772;5217.087009773293;4285.871423857289;4514.503404625505;4584.679072464929;4672.322513235579;4682.367880336162;4618.584327410533;4633.189191891405;4678.532146785311;4691.929621055687;4706.247000479924;4566.748828814414;4581.748003859786;4615.861524154281;4627.606653434428;4642.280446530793;4628.629709623222;4638.721676699375;4638.907221855544;4640.211164102111;4649.744264065475;4590.311453282001;4606.193916064675;4608.884777880547;4614.238650622643;4614.3770590970125;5152.562032227265;5167.379914410257;5185.455527169668;5207.765650545734;5223.347081614798;5616.606837521375;5653.349864765563;5660.490555849952;5669.0646043402785;5676.035074037423;5597.216389705444;5642.633228840113;5655.208270842086;5659.462351076641;5665.065264231397;5150.716710580954;5203.5576975957465;5249.921251181236;5251.711155886386;5294.788208471695;5697.658140511582;5699.971500142473;5705.087186050295;5708.457696518824;5715.114157305624;5461.781528738806;5477.534409575151;5482.753276102585;5582.8325150245555;5582.972085139549;5625.296837895263;5625.493705566519;5627.127795191752;5630.74661640219;5671.347795003545;5573.916391254134;5581.74882130297;5581.916271255935;5582.91625625616;5587.189857470644;5411.702356370437;5459.50864422196;5473.890522189534;5516.724163791794;5526.088195447786;4706.317583950308;4762.78567464465;4768.47546769855;4770.212914869077;4772.737499437564;4036.0313524753847;4042.110735638155;4073.4704488416314;4080.163566468867;4092.877213683594;4725.149473094807;4750.168720473903;4760.500147484464;4774.546418090275;4814.566688998007;5533.557315414757;5574.637648552831;5577.330720313588;5624.29696287964;5632.831015069554;4799.66402351832;4802.375691160197;4805.27920811881;4823;4843.757812109451;5036.143855544567;5045.798168073309;5048.16705243638;5050.04049230645;5092.083424983539;5080.872978175576;5162.793488260428;5189.844304670866;5200.2199670048285;5209.114450543341;5536.91694624589;5576.386597474194;5703.372629010889;5705.572082093942;5715.39988301239;5187.533122019036;5201.557867581298;5222.399424066281;5227.89544209106;5230.921536176884;5501.229827824028;5551.056320425457;5554.50009499147;5562.16567514876;5615.831525054255;5527.2538207341495;5596.1605759136455;5617.859553511195;5707.086866101404;5722.113072473773;5495;5495.890082198413;5496.395396506461;5498.862528436821;5536.944630553643;5486.807961721321;5487.259220005249;5488.780448782004;5491.972540137273;5493.752781124779;5246.606504512253;5280.1815718563685;5310.070737620978;5348.7593058311695;5369.489898459797;5482.451754824486;5527.198556209408;5527.50252477279;5555.944440555542;5570.749316280858;5311.123664595299;5312.415634280149;5312.787488500417;5316.0696878046965;5359.732013399393 06:57:31 INFO - PID 8448 | |1;ext.html;628.7956414165398;663.7909058646526;678.894771310447;1017.8880323164456;1021.3922715983987;24604.630930536034;31812.36375272493;32292.19269518263;32317.353652926955;32388.838055809687;34330.82834585824;34637.30725385491;34662;34708.82645586768;34743.13142171447;5137.845864624067;6841;6980;6983.406410455092;6986.441084713236;5125.846224613268;5292.259083728281;5295.841124766263;6185.41238582334;6845.418139458127;6916.481263905227;6944.72221111155;6961.373476387124;6966.686499107527;6973.965130174342;6878.27778083299;6924.272951340087;6929.099217101795;6929.237783843773;6942.305769423067;5121;5239.449857764918;5242.7640756166065;6814.080099186596;6877.58734475933;22763.430914227112;28376.858115709496;28797.424051518854;28834.711652883623;28841.42317153645;2964.9851750741323;2989.970100298991;2992.1621945855195;2993.835339056351;2994.116735563014;23714.525709485886;23719.881400593058;23778.16776412817;23827.76172238273;23865;3113.486274764661;3134.9686503134903;3154.810711357326;3158.8894388696517;3159.763017773676;139413.30293348568;139523;139587;140057.29971350078;140065.299673502;39242.80378598089;39337.803310983836;39376;39516.40725389064;39598.80200598978;41189;41315;41323;41330.1733965319;41333.1733365331;12917;13028.47886084546;13045;13047.478100875858;13049.739005219843;10676.359418434919;10686.51910664022;10688.94655526733;10689.89310106889;10692;9866.112049915542;10056.748581285527;11383.861613838715;11676.182667213214;12007.159498835172;4918.262260660929;4929.926051109236;4965.453800081988;5033.421156566968;5056;855.7047818502731;861.7156338408311;875.369733791669;879.969201077972;881.9294456443597;19283;20816.687749683766;20845;20998.790012099682;21041.368758937257;947.9194268487256;961.711486554031;982.7346616413671;984.2814745236018;988;10247.180225581935;10262.538185781508;10320.587176512856;11142.944285278683;11204.887951120547;160071;160718.1964090172;161517;161568;161607;38111.42832857509;38225;38237;38266;38268.61731382706;1193.0992100963717;1216.397883047897;1216.7140721930516;1222.394914517302;1224.7795396828656;19467.8053219466;19758.110885010497;19800.306989255307;20564.485887852923;20909.89545052265;29706.28671416073;29717.108486745434;29719.325260726637;29721.554176686936;29771.85114074416;146124;146466.26766866096;146936.26531867273;147003.2649836744;147222;27732;28393.858030709715;28521.714782851905;28535.143945681662;29032.419351613273;30409.847950760104;31367.529487057254;33522.32955340928;34710.305793883475;35191.47212791861;26346.604800927616;27074;27089.72910270872;27091.322716932234;27894.16317510478;26575.335616608965;26645.733542664326;27028.162042985205;27847.16458506248;27863.582046269727;29860.701392986663;29919.55120673235;29980.500974951603;30040.24899377533;30049;24969.87515062413;26679.7332026685;26741.866290668422;26910.86544567343;27429.45141097207;21180.78819211788;22065.835640813002;22256.221032263795;22306.665400019338;22313.219037333616 06:57:31 INFO - PID 8448 | |2;jquery.html;411.76117851646046;416.3026929892429;416.52308107217254;434.18373457899145;436.8973291276549;17042;17255.827441725578;17643.206055727493;17742.82257177428;17764.37824676135;17873.97835487015;18191.363302284422;18575.814241857577;18583.814161858376;18753.906230468827;5289.920651190216;5305.522502974741;5478;5522.061249587579;5525.668459892419;5362.544183744387;5476.397596264408;5489.34127904652;5491.039068163055;5492.231087647732;5268.868278293035;5421.972890135564;5459.12653975364;5467.398586155519;5471.972640136793;5507.862303442406;5542.473465020857;5544.77820887164;5546.389897111315;5546.77812887486;4799.352087468182;4932.457429682732;4973.055119527278;4975.427825800043;5026.84919452417;22429.43926401853;22562.210322638628;22635;22701.77298227013;22705.318840434815;1610.2834238763755;1653.84288492593;1659.0792110378857;1683.6296014876707;1683.8400351966543;14630.780538291934;14950.252487375588;15018.849811501854;15191.392344306214;15208.543743687707;1983.9603207935904;2043.1010355443557;2085.2805782005335;2086.95826083479;2092.937211883646;68575.65712171407;86321.56839215827;87893.56053219757;87910;95145.52427237888;10154.278260608853;10738.302010369302;11032.227744057838;11262.436878156059;11371.906113799027;15772;15779.526614201592;15784.92107539455;15785.605359865865;15796.447124350823;7435.591042492715;7669.118051424158;7681.116671582839;7740.148583655793;7794.2985131338455;6894.724211031503;6896.655167241618;6979.1973922999505;7091.858162836817;7135.821604459827;6879.965600171967;6965.477589180831;6978.232394436608;6981.685824137926;7068.5758854468895;1993.900304984745;2001.1795163982697;2016.4152395805345;2042.9080691368924;2114.915403383878;841.7011960753966;863.0980625246632;882.3470631732472;889.6085722282176;908.7637214324324;16701.58246043834;16892.746608800877;16966.830331696772;16983;17820;860.3117505995178;869.8260347930312;877.4910551879894;881.9647214111363;895.901450840407;9063.184313411824;9219.815603687888;9464.195543378752;9632.711018669452;9636.180924621485;353640;360883;363772;371046;371473;71870.28129718636;72797;74285;75383.24616753763;76649;1011.630754774502;1043.6816770884802;1063.2716589136467;1072.7103682005816;1072.7425417899804;14608.415663373346;14645;14654.85345146535;14711.852881471477;15574.922125389301;37923.431148533346;38977.2204555913;40108.58534097859;40221.396679049256;40691.7965410171;47014.29478557756;47347.52652473431;47512.52487475081;47627;47820.2826957589;7864.4888082274465;8073.14317706919;8491.830163396575;8498.53258070812;8535.10381409943;12780.360981951051;12825.743485130059;13129.868701312864;13436;13828.654283642989;10495;10681.305715128492;10707.625233116803;10929.617463388744;11109.555617775199;10261.2304077196;10499.580016799242;10574.89425105739;10715.464226788785;10969.396683182502;10750.24748267645;10873.945630271797;10987.066099381642;11655.24240924371;11760.235584686969;8507.787305317417;8509.234168924826;8661.8700719488;8690.087540808125;8747.16901894319;10496.580136794748;10620.89379106199;10639.680809575726;10695.839562406725;10888.183386245904 06:57:31 INFO - PID 8448 | |3;mootools.html;1260.4769020856345;1309.1163464661352;1320.702841860581;1321.7422602592496;1323.8014297855314;9643.662471813479;10140.49297535122;10142.543585538668;10153.746156346086;10158.898411015887;10272.435016074112;10580.523876425561;10581;10591.947040264808;10599.0990765785;2244.86530808152;2266.2634643740766;2266.7733226677365;2285.4743409015937;2290.564792689392;1882.5199574108583;1960.7745109312398;2209.558088382322;2261.344210179046;2268.217464974581;2121.7666056733747;2216.5345277491747;2216.8448208625405;2218.367765186922;2228.6545585434283;2204.1844517528457;2214.3689048621145;2219.3563866478703;2225.265662331427;2229.2754854672135;2199.450137465634;2202.394341556069;2203.493196564783;2219.1123550579737;2228.19784877444;9405.670801521914;9466.668666596704;9509.191718703918;9510.90489095114;9511.286653501014;5537.335519737617;5723.027085395493;5725.141228815669;5726.942730572724;5729.598928075036;3157.36852629475;3233.175540237248;3378.9493157602656;3390.2033022239752;3404.438267685829;1096.3860238266595;1102.5369344875091;1141.4806263150247;1152.2798251093068;1183.2308999150534;14787.556373308818;14948;14948.62628434287;14952.102873827605;14958.62603434912;4605.930911036337;4781.282807578821;5001.649884508122;5036.84889453317;5080.161773307437;11009.119270458345;11015.504302306255;11023;11030.558777648965;11035.337879727242;5597.356304025007;5622.409646987007;5628.296462942132;5629.155626656035;5632.183333416631;5142.922856157161;5218.765155568009;5266.131088370453;5297.496737809902;5332.786688532493;3817.9236415272094;3923.4894565592454;3970.861019864291;4033.596640335943;4035.6771458283265;995.0944640377222;1125.8254970479588;1130.1636788776245;1138.2544433396138;1158.212415557429;622.6202016769766;693.7918624412656;714.8212946763309;725.2131437390491;729.824842037907;5781.797637082682;5803.303603567599;5817.418258174149;5834.066549352084;6043.667598282049;808.454293351985;826.4957776846082;833.8915940927762;839.3159574946399;852.7825404521807;3337.8664853406076;3413.6974610625075;3415.7438192135687;3426.623071462187;3497.0557949354043;13274.402651880688;13301.26843023643;13712.17726936387;13724.45102195901;13725.313734313244;12837.229766214057;13151.934240328928;13241.337933103307;13262.53581124656;13586.796198057036;7222.133343998754;7469.850602988018;7730.188330225358;7892.881606775788;7898.289153976055;5911.91132133027;5916.142159386779;6107.297660769068;6131.233595800525;6200.875982480416;11474.196806223485;11749.530018799152;12201.877981220074;12368;12410.441530131346;11488.19582629208;12019.75960480803;12025.158238923192;12036.939815300868;12059.457324420247;7641.312281894656;7758.340541054074;7766.922330776846;7778.261065198797;7824.139344672195;9177.357584968988;9255;9307.162355388047;9320.347575669639;9451.196648284973;6367.586106903036;7692.884606730791;8506.574671266288;8657.264132548804;8899.466032038099;8310.459820111673;8461.619227134917;8526;8682.869756953525;8743.868841967504;7082;7252.637368131678;7259.9274007259255;7263.309985551364;7265.273472652692;5072.492750724898;5119.104156772475;5136.691798492103;5151.6908985461;5183.274341592256;4905.828296009622;4996.950030499648;5195.844124676266;5229.058769421541;5272.68363898152 06:57:31 INFO - PID 8448 | |4;prototype.html;377.5789994156515;390.38904115059927;392.4505692031156;394.4458036458773;395.56487863350316;5132.743362831862;5304.49607287308;5380.166074258486;5404.648697834638;5449.836504904854;5117.130087885059;5237.319148510698;5279.891222843207;5291.656042357244;5320.654157479771;4239.046214601705;4259.148170365924;4259.87220383389;4260.786960651971;4262.531121576624;4074.3073677474754;4243.72415792974;4253.1706317268145;4268.573142685737;4275.486941567016;4222.311075569766;4229.534751177368;4238.067625122468;4245.766482843443;4257.595528424795;4222.451081359403;4224.408582798411;4240.787960601958;4243.045314804175;4249.51130619978;3833.8083095845377;3879.670228030621;3895.5325360956585;3906.7655940643654;3910.335243008695;5222.3472065991755;5228.79084836606;5291.814786482493;5292.338457692788;5306.399864066618;5027.421846487628;5033.672811267293;5033.7348193313155;5042.546170844642;5047.772850221749;5533.280673512418;5695.45893140151;5699.287589051369;5702.572307076985;5702.65784052954;4380.78096095194;4390.736555806662;4398.868033958986;4400.229959757062;4410.580994805488;5991.16123742672;6065.363136870609;6069;6073.267029836591;6086.60437071589;4382.561743825592;4500.572445617661;4527.84152554659;4533.795979180944;4541.5231400703115;4572.428446444194;4593.28804035375;4603.447586289667;4604;4616.1229366420275;5049.26785616091;5051.419086804991;5058.317127187856;5062.443131255559;5068.771905264272;5432.864178395493;5675.120356344773;5682.460166284279;5733.770649173986;5746.5977381583725;1489.8882583806258;1526.244508968068;1544.5598004568644;1592.697387496372;1598.664280501108;1133.4446121400454;1154.2628344341713;1155.0759392485977;1173.8826117388194;1178.0634395655475;4901.705897646153;4903.166461701519;4926.778294976734;4938.827141050046;4942.308076869242;5837.6497410155525;5839.708014599253;5849;5852.180694702745;5860.970695146497;4774.40319960005;4922.950770492321;4924.089043526959;4925.359703238628;4933.309336692866;3058.587090742721;3058.7153395573914;3070.6161729783776;3072.324088700482;3089.1504836170234;5384.542313903284;5396.379416367089;5401.648892821954;5408.459154084639;5418.187271909245;5717.514011309086;5981.880362392815;6001.2498437695285;6016.398360163948;6033.336333003366;5382.569394448435;5405.405405405324;5427.267318911896;5431.755570999315;5452.427495113036;5751.626144300607;5843.7370318336625;5880.794172203952;5884.969240841056;5894;5771.0378471319955;5781.566382521243;5786.247787787561;5799.739011744397;5803.593748437737;5351.812686555952;5368.275282836923;5392.649477783932;5416.104363472753;5431.85930954504;3904.1801221743754;4057.634812866856;4070.1452694934396;4086.060206152661;4095.1400205957084;5603.523700485342;5726.284214473191;5870.354261031198;5891.675957822361;5922.082077278029;5505.421930697219;5656.858578535405;5667.3765885753355;5674.829755107354;5675.716214189357;5654.660720356792;5658;5668.376478587435;5672.7730890763905;5680;5456.236126942311;5538.556915446674;5547.55619550443;5567.47109024642;5569.44305569456;5708.600397972102;5720.141978703228;5722.685252311163;5724.255846740064;5727.599068065196;5388.326459192601;5462.235287059894;5534.782347883459;5536.307961504812;5536.363318218296 06:57:31 INFO - PID 8448 | |5;yui.html;714.4391652552746;745.9067616547932;749.235779504905;750.7635094945092;756.3646536908996;13136.605901822937;14007.509737159215;14045.648858778535;14073.437062517512;14110.435582576698;13531.661708457294;14654.48709295175;14982.550523484286;15029.849701502982;15044.623884402896;838.8490071787076;856.0326830681353;857.9227869491745;857.9313654907593;859.4671303791627;915.281504019345;918.1231923513029;918.2103391083663;918.6692790595414;920.3695468604028;946.5787724462617;948.2414068745011;952.2286947572454;953.1993125774349;953.3183773601874;932.7947851472666;937.4890684576922;944.707140786355;945.0407836046419;945.9479728614923;681.6796105830252;686.8488932434856;691.408845437154;691.4502970138752;695.0651373902093;14499;14686.779698304534;14959.252037398086;14970.62573435662;14986.850131498655;14789.260536973215;15112.168830714307;15185.392584296615;15200.695986080327;15215.771763423558;11044.116470682326;11500.194986350958;11502.07983361329;11504;11534.077273818075;2706.688730795944;2964.066319109495;2977.3152174999655;2983.4928062229474;2984.089852594958;63871.68064159696;65505.672471637336;66322.33677663258;72085.63957180233;73384.26615733828;12465.376731163587;12779.23324600527;12805.743885122245;12812.039097067756;12836.358182090858;22209.333719988426;22518.887405562866;22941.346720027024;23080.7691923082;23089.307320780405;5956.344802071769;6033.5474839387225;6046.183765191643;6055.757769689163;6089.817305480843;2987.074007057819;3005.1585556044342;3006.4888968875343;3009.4432529982023;3011.021418039146;3543.4861945018342;3592.993961690731;3661.9816900915325;3667.9266414671556;3681.650243226889;688.9242183359827;689.0766373060123;692.7990882644077;694.9305069493112;697.3828162076599;581.9243498345188;603.1314906534576;606.6572386601645;606.8937935861295;610.4993904997948;9016.278697704169;9187.494687792101;9409.764755881159;9838;9840.704778856645;578.6383510306059;580.5442727458925;584.392232078642;588.1178232651024;603.1495591216451;4300.311950087971;4341.978290108529;4348.695591308578;4376.6498680105515;4390.62679672225;62846.685766570874;63472.68263658652;63730.362696372445;64622;65130.34869651338;56443.71778141165;57019.71490142523;57069.714651427304;57535.13697294544;57924.131138032964;50887.7455612727;52297.95404091897;54189.45810542002;54279.72860135674;54493;8922.955385223033;8955.641774329215;9022.864657030019;9274.44353338802;9300.627974880928;26574.33564160834;27343.72656273412;27685.30786730348;27824;28449.715502844705;32406.83796581002;32858.34283314273;32995.34009319752;33080.50379244265;33547.161320966195;10787.892121079003;10853.131749460183;10939.835902461311;10983.286086404358;10992.17558683086;12170.939145304572;12248.816267756169;12415.193012454161;12517.499300028261;12529.122961392615;11052.115830733683;11329.773404532029;11602.303861768321;11622.593209237637;11763.176577639482;11530.538778448768;11553.30680159193;11723.941380293043;11826.586069487526;11929.28424294545;10677.733056673645;10824.296420732628;10905.291156075147;10977;11051.502682379152;8283.792905177419;8384.41309108381;8445.366597505088;8578.356623253156;8828.249598784176;8720.78198045054;9112.362134650512;9112.407693499901;9355.766105847408;9369.437833729999 06:57:31 INFO - PID 8448 | __end_tp_report 06:57:31 INFO - PID 8448 | __start_cc_report 06:57:31 INFO - PID 8448 | _x_x_mozilla_cycle_collect,1126 06:57:31 INFO - PID 8448 | __end_cc_report 06:57:31 INFO - PID 8448 | __startTimestamp1494597451375__endTimestamp 06:57:31 INFO - PID 8448 | 06:57:31 INFO - PID 8448 | ------- Summary: start ------- 06:57:31 INFO - PID 8448 | Number of tests: 6 06:57:31 INFO - PID 8448 | 06:57:31 INFO - PID 8448 | [#0] dojo.html Cycles:165 Average:5127.60 Median:5246.61 stddev:598.58 (11.4%) stddev-sans-first:569.11 06:57:31 INFO - PID 8448 | Values: 2692.0 2701.1 2736.6 2743.1 2743.4 5045.2 5186.2 5190.4 5205.2 5243.4 5165.2 5167.5 5179.2 5205.2 5217.1 4285.9 4514.5 4584.7 4672.3 4682.4 4618.6 4633.2 4678.5 4691.9 4706.2 4566.7 4581.7 4615.9 4627.6 4642.3 4628.6 4638.7 4638.9 4640.2 4649.7 4590.3 4606.2 4608.9 4614.2 4614.4 5152.6 5167.4 5185.5 5207.8 5223.3 5616.6 5653.3 5660.5 5669.1 5676.0 5597.2 5642.6 5655.2 5659.5 5665.1 5150.7 5203.6 5249.9 5251.7 5294.8 5697.7 5700.0 5705.1 5708.5 5715.1 5461.8 5477.5 5482.8 5582.8 5583.0 5625.3 5625.5 5627.1 5630.7 5671.3 5573.9 5581.7 5581.9 5582.9 5587.2 5411.7 5459.5 5473.9 5516.7 5526.1 4706.3 4762.8 4768.5 4770.2 4772.7 4036.0 4042.1 4073.5 4080.2 4092.9 4725.1 4750.2 4760.5 4774.5 4814.6 5533.6 5574.6 5577.3 5624.3 5632.8 4799.7 4802.4 4805.3 4823.0 4843.8 5036.1 5045.8 5048.2 5050.0 5092.1 5080.9 5162.8 5189.8 5200.2 5209.1 5536.9 5576.4 5703.4 5705.6 5715.4 5187.5 5201.6 5222.4 5227.9 5230.9 5501.2 5551.1 5554.5 5562.2 5615.8 5527.3 5596.2 5617.9 5707.1 5722.1 5495.0 5495.9 5496.4 5498.9 5536.9 5486.8 5487.3 5488.8 5492.0 5493.8 5246.6 5280.2 5310.1 5348.8 5369.5 5482.5 5527.2 5527.5 5555.9 5570.7 5311.1 5312.4 5312.8 5316.1 5359.7 06:57:31 INFO - PID 8448 | 06:57:31 INFO - PID 8448 | [#1] ext.html Cycles:180 Average:28895.29 Median:29720.44 stddev:38515.56 (129.6%) stddev-sans-first:38565.12 06:57:31 INFO - PID 8448 | Values: 628.8 663.8 678.9 1017.9 1021.4 24604.6 31812.4 32292.2 32317.4 32388.8 34330.8 34637.3 34662.0 34708.8 34743.1 5137.8 6841.0 6980.0 6983.4 6986.4 5125.8 5292.3 5295.8 6185.4 6845.4 6916.5 6944.7 6961.4 6966.7 6974.0 6878.3 6924.3 6929.1 6929.2 6942.3 5121.0 5239.4 5242.8 6814.1 6877.6 22763.4 28376.9 28797.4 28834.7 28841.4 2965.0 2990.0 2992.2 2993.8 2994.1 23714.5 23719.9 23778.2 23827.8 23865.0 3113.5 3135.0 3154.8 3158.9 3159.8 139413.3 139523.0 139587.0 140057.3 140065.3 39242.8 39337.8 39376.0 39516.4 39598.8 41189.0 41315.0 41323.0 41330.2 41333.2 12917.0 13028.5 13045.0 13047.5 13049.7 10676.4 10686.5 10688.9 10689.9 10692.0 9866.1 10056.7 11383.9 11676.2 12007.2 4918.3 4929.9 4965.5 5033.4 5056.0 855.7 861.7 875.4 880.0 881.9 19283.0 20816.7 20845.0 20998.8 21041.4 947.9 961.7 982.7 984.3 988.0 10247.2 10262.5 10320.6 11142.9 11204.9 160071.0 160718.2 161517.0 161568.0 161607.0 38111.4 38225.0 38237.0 38266.0 38268.6 1193.1 1216.4 1216.7 1222.4 1224.8 19467.8 19758.1 19800.3 20564.5 20909.9 29706.3 29717.1 29719.3 29721.6 29771.9 146124.0 146466.3 146936.3 147003.3 147222.0 27732.0 28393.9 28521.7 28535.1 29032.4 30409.8 31367.5 33522.3 34710.3 35191.5 26346.6 27074.0 27089.7 27091.3 27894.2 26575.3 26645.7 27028.2 27847.2 27863.6 29860.7 29919.6 29980.5 30040.2 30049.0 24969.9 26679.7 26741.9 26910.9 27429.5 21180.8 22065.8 22256.2 22306.7 22313.2 06:57:31 INFO - PID 8448 | 06:57:31 INFO - PID 8448 | [#2] jquery.html Cycles:180 Average:24523.93 Median:38450.33 stddev:60518.80 (157.4%) stddev-sans-first:60661.49 06:57:31 INFO - PID 8448 | Values: 411.8 416.3 416.5 434.2 436.9 17042.0 17255.8 17643.2 17742.8 17764.4 17874.0 18191.4 18575.8 18583.8 18753.9 5289.9 5305.5 5478.0 5522.1 5525.7 5362.5 5476.4 5489.3 5491.0 5492.2 5268.9 5422.0 5459.1 5467.4 5472.0 5507.9 5542.5 5544.8 5546.4 5546.8 4799.4 4932.5 4973.1 4975.4 5026.8 22429.4 22562.2 22635.0 22701.8 22705.3 1610.3 1653.8 1659.1 1683.6 1683.8 14630.8 14950.3 15018.8 15191.4 15208.5 1984.0 2043.1 2085.3 2087.0 2092.9 68575.7 86321.6 87893.6 87910.0 95145.5 10154.3 10738.3 11032.2 11262.4 11371.9 15772.0 15779.5 15784.9 15785.6 15796.4 7435.6 7669.1 7681.1 7740.1 7794.3 6894.7 6896.7 6979.2 7091.9 7135.8 6880.0 6965.5 6978.2 6981.7 7068.6 1993.9 2001.2 2016.4 2042.9 2114.9 841.7 863.1 882.3 889.6 908.8 16701.6 16892.7 16966.8 16983.0 17820.0 860.3 869.8 877.5 882.0 895.9 9063.2 9219.8 9464.2 9632.7 9636.2 353640.0 360883.0 363772.0 371046.0 371473.0 71870.3 72797.0 74285.0 75383.2 76649.0 1011.6 1043.7 1063.3 1072.7 1072.7 14608.4 14645.0 14654.9 14711.9 15574.9 37923.4 38977.2 40108.6 40221.4 40691.8 47014.3 47347.5 47512.5 47627.0 47820.3 7864.5 8073.1 8491.8 8498.5 8535.1 12780.4 12825.7 13129.9 13436.0 13828.7 10495.0 10681.3 10707.6 10929.6 11109.6 10261.2 10499.6 10574.9 10715.5 10969.4 10750.2 10873.9 10987.1 11655.2 11760.2 8507.8 8509.2 8661.9 8690.1 8747.2 10496.6 10620.9 10639.7 10695.8 10888.2 06:57:31 INFO - PID 8448 | 06:57:31 INFO - PID 8448 | [#3] mootools.html Cycles:180 Average:6267.48 Median:4002.23 stddev:4025.63 (100.6%) stddev-sans-first:4019.34 06:57:31 INFO - PID 8448 | Values: 1260.5 1309.1 1320.7 1321.7 1323.8 9643.7 10140.5 10142.5 10153.7 10158.9 10272.4 10580.5 10581.0 10591.9 10599.1 2244.9 2266.3 2266.8 2285.5 2290.6 1882.5 1960.8 2209.6 2261.3 2268.2 2121.8 2216.5 2216.8 2218.4 2228.7 2204.2 2214.4 2219.4 2225.3 2229.3 2199.5 2202.4 2203.5 2219.1 2228.2 9405.7 9466.7 9509.2 9510.9 9511.3 5537.3 5723.0 5725.1 5726.9 5729.6 3157.4 3233.2 3378.9 3390.2 3404.4 1096.4 1102.5 1141.5 1152.3 1183.2 14787.6 14948.0 14948.6 14952.1 14958.6 4605.9 4781.3 5001.6 5036.8 5080.2 11009.1 11015.5 11023.0 11030.6 11035.3 5597.4 5622.4 5628.3 5629.2 5632.2 5142.9 5218.8 5266.1 5297.5 5332.8 3817.9 3923.5 3970.9 4033.6 4035.7 995.1 1125.8 1130.2 1138.3 1158.2 622.6 693.8 714.8 725.2 729.8 5781.8 5803.3 5817.4 5834.1 6043.7 808.5 826.5 833.9 839.3 852.8 3337.9 3413.7 3415.7 3426.6 3497.1 13274.4 13301.3 13712.2 13724.5 13725.3 12837.2 13151.9 13241.3 13262.5 13586.8 7222.1 7469.9 7730.2 7892.9 7898.3 5911.9 5916.1 6107.3 6131.2 6200.9 11474.2 11749.5 12201.9 12368.0 12410.4 11488.2 12019.8 12025.2 12036.9 12059.5 7641.3 7758.3 7766.9 7778.3 7824.1 9177.4 9255.0 9307.2 9320.3 9451.2 6367.6 7692.9 8506.6 8657.3 8899.5 8310.5 8461.6 8526.0 8682.9 8743.9 7082.0 7252.6 7259.9 7263.3 7265.3 5072.5 5119.1 5136.7 5151.7 5183.3 4905.8 4997.0 5195.8 5229.1 5272.7 06:57:31 INFO - PID 8448 | 06:57:31 INFO - PID 8448 | [#4] prototype.html Cycles:180 Average:4755.31 Median:5285.77 stddev:1327.54 (25.1%) stddev-sans-first:1289.96 06:57:31 INFO - PID 8448 | Values: 377.6 390.4 392.5 394.4 395.6 5132.7 5304.5 5380.2 5404.6 5449.8 5117.1 5237.3 5279.9 5291.7 5320.7 4239.0 4259.1 4259.9 4260.8 4262.5 4074.3 4243.7 4253.2 4268.6 4275.5 4222.3 4229.5 4238.1 4245.8 4257.6 4222.5 4224.4 4240.8 4243.0 4249.5 3833.8 3879.7 3895.5 3906.8 3910.3 5222.3 5228.8 5291.8 5292.3 5306.4 5027.4 5033.7 5033.7 5042.5 5047.8 5533.3 5695.5 5699.3 5702.6 5702.7 4380.8 4390.7 4398.9 4400.2 4410.6 5991.2 6065.4 6069.0 6073.3 6086.6 4382.6 4500.6 4527.8 4533.8 4541.5 4572.4 4593.3 4603.4 4604.0 4616.1 5049.3 5051.4 5058.3 5062.4 5068.8 5432.9 5675.1 5682.5 5733.8 5746.6 1489.9 1526.2 1544.6 1592.7 1598.7 1133.4 1154.3 1155.1 1173.9 1178.1 4901.7 4903.2 4926.8 4938.8 4942.3 5837.6 5839.7 5849.0 5852.2 5861.0 4774.4 4923.0 4924.1 4925.4 4933.3 3058.6 3058.7 3070.6 3072.3 3089.2 5384.5 5396.4 5401.6 5408.5 5418.2 5717.5 5981.9 6001.2 6016.4 6033.3 5382.6 5405.4 5427.3 5431.8 5452.4 5751.6 5843.7 5880.8 5885.0 5894.0 5771.0 5781.6 5786.2 5799.7 5803.6 5351.8 5368.3 5392.6 5416.1 5431.9 3904.2 4057.6 4070.1 4086.1 4095.1 5603.5 5726.3 5870.4 5891.7 5922.1 5505.4 5656.9 5667.4 5674.8 5675.7 5654.7 5658.0 5668.4 5672.8 5680.0 5456.2 5538.6 5547.6 5567.5 5569.4 5708.6 5720.1 5722.7 5724.3 5727.6 5388.3 5462.2 5534.8 5536.3 5536.4 06:57:31 INFO - PID 8448 | 06:57:31 INFO - PID 8448 | [#5] yui.html Cycles:180 Average:14695.02 Median:51592.85 stddev:18070.05 (35.0%) stddev-sans-first:18090.24 06:57:31 INFO - PID 8448 | Values: 714.4 745.9 749.2 750.8 756.4 13136.6 14007.5 14045.6 14073.4 14110.4 13531.7 14654.5 14982.6 15029.8 15044.6 838.8 856.0 857.9 857.9 859.5 915.3 918.1 918.2 918.7 920.4 946.6 948.2 952.2 953.2 953.3 932.8 937.5 944.7 945.0 945.9 681.7 686.8 691.4 691.5 695.1 14499.0 14686.8 14959.3 14970.6 14986.9 14789.3 15112.2 15185.4 15200.7 15215.8 11044.1 11500.2 11502.1 11504.0 11534.1 2706.7 2964.1 2977.3 2983.5 2984.1 63871.7 65505.7 66322.3 72085.6 73384.3 12465.4 12779.2 12805.7 12812.0 12836.4 22209.3 22518.9 22941.3 23080.8 23089.3 5956.3 6033.5 6046.2 6055.8 6089.8 2987.1 3005.2 3006.5 3009.4 3011.0 3543.5 3593.0 3662.0 3667.9 3681.7 688.9 689.1 692.8 694.9 697.4 581.9 603.1 606.7 606.9 610.5 9016.3 9187.5 9409.8 9838.0 9840.7 578.6 580.5 584.4 588.1 603.1 4300.3 4342.0 4348.7 4376.6 4390.6 62846.7 63472.7 63730.4 64622.0 65130.3 56443.7 57019.7 57069.7 57535.1 57924.1 50887.7 52298.0 54189.5 54279.7 54493.0 8923.0 8955.6 9022.9 9274.4 9300.6 26574.3 27343.7 27685.3 27824.0 28449.7 32406.8 32858.3 32995.3 33080.5 33547.2 10787.9 10853.1 10939.8 10983.3 10992.2 12170.9 12248.8 12415.2 12517.5 12529.1 11052.1 11329.8 11602.3 11622.6 11763.2 11530.5 11553.3 11723.9 11826.6 11929.3 10677.7 10824.3 10905.3 10977.0 11051.5 8283.8 8384.4 8445.4 8578.4 8828.2 8720.8 9112.4 9112.4 9355.8 9369.4 06:57:31 INFO - PID 8448 | -------- Summary: end -------- 06:57:31 INFO - PID 8448 | 06:57:32 INFO - TEST-INFO | 8448: exit 0 06:57:32 INFO - TEST-OK | dromaeo_css | took 1121935ms 06:57:32 INFO - TEST-START | kraken 06:57:32 INFO - operating with platform_type : linux_ 06:57:32 INFO - Initialising browser for kraken test... 06:57:32 INFO - TEST-INFO | started process 8771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0AmOT/profile http://localhost:37813/getInfo.html) 06:57:36 INFO - PID 8771 | __metrics Screen width/height:1600/1200 06:57:36 INFO - PID 8771 | colorDepth:24 06:57:36 INFO - PID 8771 | Browser inner width/height: 1024/695 06:57:36 INFO - PID 8771 | __metrics 06:57:37 INFO - PID 8771 | 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" 06:57:37 INFO - PID 8771 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:57:38 INFO - TEST-INFO | 8771: exit 0 06:57:38 INFO - Browser initialized. 06:57:38 INFO - Running cycle 1/1 for kraken test... 06:57:38 INFO - TEST-INFO | started process 8869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0AmOT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:50 INFO - PID 8869 | RSS: Main: 148668416 06:57:50 INFO - PID 8869 | 06:57:53 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37813/tests/kraken/driver.html?testName=audio-beat-detection) 06:57:54 INFO - PID 8869 | RSS: Main: 222183424 06:57:54 INFO - PID 8869 | 06:57:56 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37813/tests/kraken/driver.html?testName=audio-dft) 06:57:57 INFO - PID 8869 | RSS: Main: 182906880 06:57:57 INFO - PID 8869 | 06:58:00 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37813/tests/kraken/driver.html?testName=audio-fft) 06:58:01 INFO - PID 8869 | RSS: Main: 265060352 06:58:01 INFO - PID 8869 | 06:58:03 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37813/tests/kraken/driver.html?testName=audio-oscillator) 06:58:03 INFO - PID 8869 | RSS: Main: 177889280 06:58:03 INFO - PID 8869 | 06:58:06 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37813/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:58:06 INFO - PID 8869 | RSS: Main: 179675136 06:58:06 INFO - PID 8869 | 06:58:09 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37813/tests/kraken/driver.html?testName=imaging-darkroom) 06:58:10 INFO - PID 8869 | RSS: Main: 240029696 06:58:10 INFO - PID 8869 | 06:58:13 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37813/tests/kraken/driver.html?testName=imaging-desaturate) 06:58:14 INFO - PID 8869 | RSS: Main: 239718400 06:58:14 INFO - PID 8869 | 06:58:17 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37813/tests/kraken/driver.html?testName=json-parse-financial) 06:58:18 INFO - PID 8869 | RSS: Main: 236843008 06:58:18 INFO - PID 8869 | 06:58:19 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37813/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:58:20 INFO - PID 8869 | RSS: Main: 201609216 06:58:20 INFO - PID 8869 | 06:58:22 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37813/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:58:22 INFO - PID 8869 | RSS: Main: 206610432 06:58:22 INFO - PID 8869 | 06:58:24 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37813/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:58:25 INFO - PID 8869 | RSS: Main: 215904256 06:58:25 INFO - PID 8869 | 06:58:28 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:58:28 INFO - PID 8869 | RSS: Main: 225804288 06:58:28 INFO - PID 8869 | 06:58:32 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:58:32 INFO - PID 8869 | RSS: Main: 203366400 06:58:32 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | Cycle 1(1): loaded http://localhost:37813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37813/tests/kraken/driver.html?testName=ai-astar) 06:58:34 INFO - PID 8869 | RSS: Main: 271073280 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | __start_tp_report 06:58:34 INFO - PID 8869 | _x_x_mozilla_page_load 06:58:34 INFO - PID 8869 | _x_x_mozilla_page_load_details 06:58:34 INFO - PID 8869 | |i|pagename|runs| 06:58:34 INFO - PID 8869 | |0;ai-astar;111;112;111;111;112;112;112;110;111;111 06:58:34 INFO - PID 8869 | |1;audio-beat-detection;148;122;121;183;125;124;123;124;145;122 06:58:34 INFO - PID 8869 | |2;audio-dft;163;160;162;161;162;163;162;163;162;162 06:58:34 INFO - PID 8869 | |3;audio-fft;74;75;74;109;75;75;75;75;96;77 06:58:34 INFO - PID 8869 | |4;audio-oscillator;84;83;106;83;83;83;96;83;83;114 06:58:34 INFO - PID 8869 | |5;imaging-gaussian-blur;113;114;114;113;113;113;114;114;113;113 06:58:34 INFO - PID 8869 | |6;imaging-darkroom;148;148;148;149;149;149;150;149;149;148 06:58:34 INFO - PID 8869 | |7;imaging-desaturate;94;94;94;94;94;93;94;94;95;93 06:58:34 INFO - PID 8869 | |8;json-parse-financial;54;54;53;53;54;54;55;54;54;55 06:58:34 INFO - PID 8869 | |9;json-stringify-tinderbox;56;56;56;56;56;55;55;56;56;56 06:58:34 INFO - PID 8869 | |10;stanford-crypto-aes;81;80;80;81;81;81;80;80;81;80 06:58:34 INFO - PID 8869 | |11;stanford-crypto-ccm;136;135;139;137;133;130;130;130;180;134 06:58:34 INFO - PID 8869 | |12;stanford-crypto-pbkdf2;184;193;194;191;184;192;191;197;193;193 06:58:34 INFO - PID 8869 | |13;stanford-crypto-sha256-iterative;74;72;71;74;72;72;72;72;74;72 06:58:34 INFO - PID 8869 | __end_tp_report 06:58:34 INFO - PID 8869 | __start_cc_report 06:58:34 INFO - PID 8869 | _x_x_mozilla_cycle_collect,2081 06:58:34 INFO - PID 8869 | __end_cc_report 06:58:34 INFO - PID 8869 | __startTimestamp1494597514749__endTimestamp 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | ------- Summary: start ------- 06:58:34 INFO - PID 8869 | Number of tests: 14 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 06:58:34 INFO - PID 8869 | Values: 111.0 112.0 111.0 111.0 112.0 112.0 112.0 110.0 111.0 111.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:124.50 stddev:19.93 (16.0%) stddev-sans-first:20.46 06:58:34 INFO - PID 8869 | Values: 148.0 122.0 121.0 183.0 125.0 124.0 123.0 124.0 145.0 122.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 06:58:34 INFO - PID 8869 | Values: 163.0 160.0 162.0 161.0 162.0 163.0 162.0 163.0 162.0 162.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:12.02 (16.0%) stddev-sans-first:12.52 06:58:34 INFO - PID 8869 | Values: 74.0 75.0 74.0 109.0 75.0 75.0 75.0 75.0 96.0 77.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:83.00 stddev:11.54 (13.9%) stddev-sans-first:12.04 06:58:34 INFO - PID 8869 | Values: 84.0 83.0 106.0 83.0 83.0 83.0 96.0 83.0 83.0 114.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:58:34 INFO - PID 8869 | Values: 113.0 114.0 114.0 113.0 113.0 113.0 114.0 114.0 113.0 113.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 06:58:34 INFO - PID 8869 | Values: 148.0 148.0 148.0 149.0 149.0 149.0 150.0 149.0 149.0 148.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:58:34 INFO - PID 8869 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 95.0 93.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 06:58:34 INFO - PID 8869 | Values: 54.0 54.0 53.0 53.0 54.0 54.0 55.0 54.0 54.0 55.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 06:58:34 INFO - PID 8869 | Values: 56.0 56.0 56.0 56.0 56.0 55.0 55.0 56.0 56.0 56.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 06:58:34 INFO - PID 8869 | Values: 81.0 80.0 80.0 81.0 81.0 81.0 80.0 80.0 81.0 80.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:135.50 stddev:14.95 (11.0%) stddev-sans-first:15.83 06:58:34 INFO - PID 8869 | Values: 136.0 135.0 139.0 137.0 133.0 130.0 130.0 130.0 180.0 134.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.20 Median:193.00 stddev:4.16 (2.2%) stddev-sans-first:3.50 06:58:34 INFO - PID 8869 | Values: 184.0 193.0 194.0 191.0 184.0 192.0 191.0 197.0 193.0 193.0 06:58:34 INFO - PID 8869 | 06:58:34 INFO - PID 8869 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.00 stddev:1.08 (1.5%) stddev-sans-first:1.00 06:58:34 INFO - PID 8869 | Values: 74.0 72.0 71.0 74.0 72.0 72.0 72.0 72.0 74.0 72.0 06:58:34 INFO - PID 8869 | -------- Summary: end -------- 06:58:34 INFO - PID 8869 | 06:58:35 INFO - TEST-INFO | 8869: exit 0 06:58:35 INFO - TEST-OK | kraken | took 63632ms 06:58:35 INFO - SUITE-END | took 1185s 06:58:36 INFO - Completed test suite (00:19:45) 06:58:36 INFO - javascript benchmark 06:58:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6608.630795960439, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2692.0, 2701.0546308791936, 2736.644236249287, 2743.05364649196, 2743.3827388837503, 5045.243213517974, 5186.222066689998, 5190.429052804188, 5205.228044939364, 5243.397009343927, 5165.199394093921, 5167.48325167484, 5179.19722443022, 5205.193195054772, 5217.087009773293, 4285.871423857289, 4514.503404625505, 4584.679072464929, 4672.322513235579, 4682.367880336162, 4618.584327410533, 4633.189191891405, 4678.532146785311, 4691.929621055687, 4706.247000479924, 4566.748828814414, 4581.748003859786, 4615.861524154281, 4627.606653434428, 4642.280446530793, 4628.629709623222, 4638.721676699375, 4638.907221855544, 4640.211164102111, 4649.744264065475, 4590.311453282001, 4606.193916064675, 4608.884777880547, 4614.238650622643, 4614.3770590970125, 5152.562032227265, 5167.379914410257, 5185.455527169668, 5207.765650545734, 5223.347081614798, 5616.606837521375, 5653.349864765563, 5660.490555849952, 5669.0646043402785, 5676.035074037423, 5597.216389705444, 5642.633228840113, 5655.208270842086, 5659.462351076641, 5665.065264231397, 5150.716710580954, 5203.5576975957465, 5249.921251181236, 5251.711155886386, 5294.788208471695, 5697.658140511582, 5699.971500142473, 5705.087186050295, 5708.457696518824, 5715.114157305624, 5461.781528738806, 5477.534409575151, 5482.753276102585, 5582.8325150245555, 5582.972085139549, 5625.296837895263, 5625.493705566519, 5627.127795191752, 5630.74661640219, 5671.347795003545, 5573.916391254134, 5581.74882130297, 5581.916271255935, 5582.91625625616, 5587.189857470644, 5411.702356370437, 5459.50864422196, 5473.890522189534, 5516.724163791794, 5526.088195447786, 4706.317583950308, 4762.78567464465, 4768.47546769855, 4770.212914869077, 4772.737499437564, 4036.0313524753847, 4042.110735638155, 4073.4704488416314, 4080.163566468867, 4092.877213683594, 4725.149473094807, 4750.168720473903, 4760.500147484464, 4774.546418090275, 4814.566688998007, 5533.557315414757, 5574.637648552831, 5577.330720313588, 5624.29696287964, 5632.831015069554, 4799.66402351832, 4802.375691160197, 4805.27920811881, 4823.0, 4843.757812109451, 5036.143855544567, 5045.798168073309, 5048.16705243638, 5050.04049230645, 5092.083424983539, 5080.872978175576, 5162.793488260428, 5189.844304670866, 5200.2199670048285, 5209.114450543341, 5536.91694624589, 5576.386597474194, 5703.372629010889, 5705.572082093942, 5715.39988301239, 5187.533122019036, 5201.557867581298, 5222.399424066281, 5227.89544209106, 5230.921536176884, 5501.229827824028, 5551.056320425457, 5554.50009499147, 5562.16567514876, 5615.831525054255, 5527.2538207341495, 5596.1605759136455, 5617.859553511195, 5707.086866101404, 5722.113072473773, 5495.0, 5495.890082198413, 5496.395396506461, 5498.862528436821, 5536.944630553643, 5486.807961721321, 5487.259220005249, 5488.780448782004, 5491.972540137273, 5493.752781124779, 5246.606504512253, 5280.1815718563685, 5310.070737620978, 5348.7593058311695, 5369.489898459797, 5482.451754824486, 5527.198556209408, 5527.50252477279, 5555.944440555542, 5570.749316280858, 5311.123664595299, 5312.415634280149, 5312.787488500417, 5316.0696878046965, 5359.732013399393], "value": 5084.481208608981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.7956414165398, 663.7909058646526, 678.894771310447, 1017.8880323164456, 1021.3922715983987, 24604.630930536034, 31812.36375272493, 32292.19269518263, 32317.353652926955, 32388.838055809687, 34330.82834585824, 34637.30725385491, 34662.0, 34708.82645586768, 34743.13142171447, 5137.845864624067, 6841.0, 6980.0, 6983.406410455092, 6986.441084713236, 5125.846224613268, 5292.259083728281, 5295.841124766263, 6185.41238582334, 6845.418139458127, 6916.481263905227, 6944.72221111155, 6961.373476387124, 6966.686499107527, 6973.965130174342, 6878.27778083299, 6924.272951340087, 6929.099217101795, 6929.237783843773, 6942.305769423067, 5121.0, 5239.449857764918, 5242.7640756166065, 6814.080099186596, 6877.58734475933, 22763.430914227112, 28376.858115709496, 28797.424051518854, 28834.711652883623, 28841.42317153645, 2964.9851750741323, 2989.970100298991, 2992.1621945855195, 2993.835339056351, 2994.116735563014, 23714.525709485886, 23719.881400593058, 23778.16776412817, 23827.76172238273, 23865.0, 3113.486274764661, 3134.9686503134903, 3154.810711357326, 3158.8894388696517, 3159.763017773676, 139413.30293348568, 139523.0, 139587.0, 140057.29971350078, 140065.299673502, 39242.80378598089, 39337.803310983836, 39376.0, 39516.40725389064, 39598.80200598978, 41189.0, 41315.0, 41323.0, 41330.1733965319, 41333.1733365331, 12917.0, 13028.47886084546, 13045.0, 13047.478100875858, 13049.739005219843, 10676.359418434919, 10686.51910664022, 10688.94655526733, 10689.89310106889, 10692.0, 9866.112049915542, 10056.748581285527, 11383.861613838715, 11676.182667213214, 12007.159498835172, 4918.262260660929, 4929.926051109236, 4965.453800081988, 5033.421156566968, 5056.0, 855.7047818502731, 861.7156338408311, 875.369733791669, 879.969201077972, 881.9294456443597, 19283.0, 20816.687749683766, 20845.0, 20998.790012099682, 21041.368758937257, 947.9194268487256, 961.711486554031, 982.7346616413671, 984.2814745236018, 988.0, 10247.180225581935, 10262.538185781508, 10320.587176512856, 11142.944285278683, 11204.887951120547, 160071.0, 160718.1964090172, 161517.0, 161568.0, 161607.0, 38111.42832857509, 38225.0, 38237.0, 38266.0, 38268.61731382706, 1193.0992100963717, 1216.397883047897, 1216.7140721930516, 1222.394914517302, 1224.7795396828656, 19467.8053219466, 19758.110885010497, 19800.306989255307, 20564.485887852923, 20909.89545052265, 29706.28671416073, 29717.108486745434, 29719.325260726637, 29721.554176686936, 29771.85114074416, 146124.0, 146466.26766866096, 146936.26531867273, 147003.2649836744, 147222.0, 27732.0, 28393.858030709715, 28521.714782851905, 28535.143945681662, 29032.419351613273, 30409.847950760104, 31367.529487057254, 33522.32955340928, 34710.305793883475, 35191.47212791861, 26346.604800927616, 27074.0, 27089.72910270872, 27091.322716932234, 27894.16317510478, 26575.335616608965, 26645.733542664326, 27028.162042985205, 27847.16458506248, 27863.582046269727, 29860.701392986663, 29919.55120673235, 29980.500974951603, 30040.24899377533, 30049.0, 24969.87515062413, 26679.7332026685, 26741.866290668422, 26910.86544567343, 27429.45141097207, 21180.78819211788, 22065.835640813002, 22256.221032263795, 22306.665400019338, 22313.219037333616], "value": 13908.046909050345, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.76117851646046, 416.3026929892429, 416.52308107217254, 434.18373457899145, 436.8973291276549, 17042.0, 17255.827441725578, 17643.206055727493, 17742.82257177428, 17764.37824676135, 17873.97835487015, 18191.363302284422, 18575.814241857577, 18583.814161858376, 18753.906230468827, 5289.920651190216, 5305.522502974741, 5478.0, 5522.061249587579, 5525.668459892419, 5362.544183744387, 5476.397596264408, 5489.34127904652, 5491.039068163055, 5492.231087647732, 5268.868278293035, 5421.972890135564, 5459.12653975364, 5467.398586155519, 5471.972640136793, 5507.862303442406, 5542.473465020857, 5544.77820887164, 5546.389897111315, 5546.77812887486, 4799.352087468182, 4932.457429682732, 4973.055119527278, 4975.427825800043, 5026.84919452417, 22429.43926401853, 22562.210322638628, 22635.0, 22701.77298227013, 22705.318840434815, 1610.2834238763755, 1653.84288492593, 1659.0792110378857, 1683.6296014876707, 1683.8400351966543, 14630.780538291934, 14950.252487375588, 15018.849811501854, 15191.392344306214, 15208.543743687707, 1983.9603207935904, 2043.1010355443557, 2085.2805782005335, 2086.95826083479, 2092.937211883646, 68575.65712171407, 86321.56839215827, 87893.56053219757, 87910.0, 95145.52427237888, 10154.278260608853, 10738.302010369302, 11032.227744057838, 11262.436878156059, 11371.906113799027, 15772.0, 15779.526614201592, 15784.92107539455, 15785.605359865865, 15796.447124350823, 7435.591042492715, 7669.118051424158, 7681.116671582839, 7740.148583655793, 7794.2985131338455, 6894.724211031503, 6896.655167241618, 6979.1973922999505, 7091.858162836817, 7135.821604459827, 6879.965600171967, 6965.477589180831, 6978.232394436608, 6981.685824137926, 7068.5758854468895, 1993.900304984745, 2001.1795163982697, 2016.4152395805345, 2042.9080691368924, 2114.915403383878, 841.7011960753966, 863.0980625246632, 882.3470631732472, 889.6085722282176, 908.7637214324324, 16701.58246043834, 16892.746608800877, 16966.830331696772, 16983.0, 17820.0, 860.3117505995178, 869.8260347930312, 877.4910551879894, 881.9647214111363, 895.901450840407, 9063.184313411824, 9219.815603687888, 9464.195543378752, 9632.711018669452, 9636.180924621485, 353640.0, 360883.0, 363772.0, 371046.0, 371473.0, 71870.28129718636, 72797.0, 74285.0, 75383.24616753763, 76649.0, 1011.630754774502, 1043.6816770884802, 1063.2716589136467, 1072.7103682005816, 1072.7425417899804, 14608.415663373346, 14645.0, 14654.85345146535, 14711.852881471477, 15574.922125389301, 37923.431148533346, 38977.2204555913, 40108.58534097859, 40221.396679049256, 40691.7965410171, 47014.29478557756, 47347.52652473431, 47512.52487475081, 47627.0, 47820.2826957589, 7864.4888082274465, 8073.14317706919, 8491.830163396575, 8498.53258070812, 8535.10381409943, 12780.360981951051, 12825.743485130059, 13129.868701312864, 13436.0, 13828.654283642989, 10495.0, 10681.305715128492, 10707.625233116803, 10929.617463388744, 11109.555617775199, 10261.2304077196, 10499.580016799242, 10574.89425105739, 10715.464226788785, 10969.396683182502, 10750.24748267645, 10873.945630271797, 10987.066099381642, 11655.24240924371, 11760.235584686969, 8507.787305317417, 8509.234168924826, 8661.8700719488, 8690.087540808125, 8747.16901894319, 10496.580136794748, 10620.89379106199, 10639.680809575726, 10695.839562406725, 10888.183386245904], "value": 8794.851168143221, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.4769020856345, 1309.1163464661352, 1320.702841860581, 1321.7422602592496, 1323.8014297855314, 9643.662471813479, 10140.49297535122, 10142.543585538668, 10153.746156346086, 10158.898411015887, 10272.435016074112, 10580.523876425561, 10581.0, 10591.947040264808, 10599.0990765785, 2244.86530808152, 2266.2634643740766, 2266.7733226677365, 2285.4743409015937, 2290.564792689392, 1882.5199574108583, 1960.7745109312398, 2209.558088382322, 2261.344210179046, 2268.217464974581, 2121.7666056733747, 2216.5345277491747, 2216.8448208625405, 2218.367765186922, 2228.6545585434283, 2204.1844517528457, 2214.3689048621145, 2219.3563866478703, 2225.265662331427, 2229.2754854672135, 2199.450137465634, 2202.394341556069, 2203.493196564783, 2219.1123550579737, 2228.19784877444, 9405.670801521914, 9466.668666596704, 9509.191718703918, 9510.90489095114, 9511.286653501014, 5537.335519737617, 5723.027085395493, 5725.141228815669, 5726.942730572724, 5729.598928075036, 3157.36852629475, 3233.175540237248, 3378.9493157602656, 3390.2033022239752, 3404.438267685829, 1096.3860238266595, 1102.5369344875091, 1141.4806263150247, 1152.2798251093068, 1183.2308999150534, 14787.556373308818, 14948.0, 14948.62628434287, 14952.102873827605, 14958.62603434912, 4605.930911036337, 4781.282807578821, 5001.649884508122, 5036.84889453317, 5080.161773307437, 11009.119270458345, 11015.504302306255, 11023.0, 11030.558777648965, 11035.337879727242, 5597.356304025007, 5622.409646987007, 5628.296462942132, 5629.155626656035, 5632.183333416631, 5142.922856157161, 5218.765155568009, 5266.131088370453, 5297.496737809902, 5332.786688532493, 3817.9236415272094, 3923.4894565592454, 3970.861019864291, 4033.596640335943, 4035.6771458283265, 995.0944640377222, 1125.8254970479588, 1130.1636788776245, 1138.2544433396138, 1158.212415557429, 622.6202016769766, 693.7918624412656, 714.8212946763309, 725.2131437390491, 729.824842037907, 5781.797637082682, 5803.303603567599, 5817.418258174149, 5834.066549352084, 6043.667598282049, 808.454293351985, 826.4957776846082, 833.8915940927762, 839.3159574946399, 852.7825404521807, 3337.8664853406076, 3413.6974610625075, 3415.7438192135687, 3426.623071462187, 3497.0557949354043, 13274.402651880688, 13301.26843023643, 13712.17726936387, 13724.45102195901, 13725.313734313244, 12837.229766214057, 13151.934240328928, 13241.337933103307, 13262.53581124656, 13586.796198057036, 7222.133343998754, 7469.850602988018, 7730.188330225358, 7892.881606775788, 7898.289153976055, 5911.91132133027, 5916.142159386779, 6107.297660769068, 6131.233595800525, 6200.875982480416, 11474.196806223485, 11749.530018799152, 12201.877981220074, 12368.0, 12410.441530131346, 11488.19582629208, 12019.75960480803, 12025.158238923192, 12036.939815300868, 12059.457324420247, 7641.312281894656, 7758.340541054074, 7766.922330776846, 7778.261065198797, 7824.139344672195, 9177.357584968988, 9255.0, 9307.162355388047, 9320.347575669639, 9451.196648284973, 6367.586106903036, 7692.884606730791, 8506.574671266288, 8657.264132548804, 8899.466032038099, 8310.459820111673, 8461.619227134917, 8526.0, 8682.869756953525, 8743.868841967504, 7082.0, 7252.637368131678, 7259.9274007259255, 7263.309985551364, 7265.273472652692, 5072.492750724898, 5119.104156772475, 5136.691798492103, 5151.6908985461, 5183.274341592256, 4905.828296009622, 4996.950030499648, 5195.844124676266, 5229.058769421541, 5272.68363898152], "value": 4730.347549432828, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.5789994156515, 390.38904115059927, 392.4505692031156, 394.4458036458773, 395.56487863350316, 5132.743362831862, 5304.49607287308, 5380.166074258486, 5404.648697834638, 5449.836504904854, 5117.130087885059, 5237.319148510698, 5279.891222843207, 5291.656042357244, 5320.654157479771, 4239.046214601705, 4259.148170365924, 4259.87220383389, 4260.786960651971, 4262.531121576624, 4074.3073677474754, 4243.72415792974, 4253.1706317268145, 4268.573142685737, 4275.486941567016, 4222.311075569766, 4229.534751177368, 4238.067625122468, 4245.766482843443, 4257.595528424795, 4222.451081359403, 4224.408582798411, 4240.787960601958, 4243.045314804175, 4249.51130619978, 3833.8083095845377, 3879.670228030621, 3895.5325360956585, 3906.7655940643654, 3910.335243008695, 5222.3472065991755, 5228.79084836606, 5291.814786482493, 5292.338457692788, 5306.399864066618, 5027.421846487628, 5033.672811267293, 5033.7348193313155, 5042.546170844642, 5047.772850221749, 5533.280673512418, 5695.45893140151, 5699.287589051369, 5702.572307076985, 5702.65784052954, 4380.78096095194, 4390.736555806662, 4398.868033958986, 4400.229959757062, 4410.580994805488, 5991.16123742672, 6065.363136870609, 6069.0, 6073.267029836591, 6086.60437071589, 4382.561743825592, 4500.572445617661, 4527.84152554659, 4533.795979180944, 4541.5231400703115, 4572.428446444194, 4593.28804035375, 4603.447586289667, 4604.0, 4616.1229366420275, 5049.26785616091, 5051.419086804991, 5058.317127187856, 5062.443131255559, 5068.771905264272, 5432.864178395493, 5675.120356344773, 5682.460166284279, 5733.770649173986, 5746.5977381583725, 1489.8882583806258, 1526.244508968068, 1544.5598004568644, 1592.697387496372, 1598.664280501108, 1133.4446121400454, 1154.2628344341713, 1155.0759392485977, 1173.8826117388194, 1178.0634395655475, 4901.705897646153, 4903.166461701519, 4926.778294976734, 4938.827141050046, 4942.308076869242, 5837.6497410155525, 5839.708014599253, 5849.0, 5852.180694702745, 5860.970695146497, 4774.40319960005, 4922.950770492321, 4924.089043526959, 4925.359703238628, 4933.309336692866, 3058.587090742721, 3058.7153395573914, 3070.6161729783776, 3072.324088700482, 3089.1504836170234, 5384.542313903284, 5396.379416367089, 5401.648892821954, 5408.459154084639, 5418.187271909245, 5717.514011309086, 5981.880362392815, 6001.2498437695285, 6016.398360163948, 6033.336333003366, 5382.569394448435, 5405.405405405324, 5427.267318911896, 5431.755570999315, 5452.427495113036, 5751.626144300607, 5843.7370318336625, 5880.794172203952, 5884.969240841056, 5894.0, 5771.0378471319955, 5781.566382521243, 5786.247787787561, 5799.739011744397, 5803.593748437737, 5351.812686555952, 5368.275282836923, 5392.649477783932, 5416.104363472753, 5431.85930954504, 3904.1801221743754, 4057.634812866856, 4070.1452694934396, 4086.060206152661, 4095.1400205957084, 5603.523700485342, 5726.284214473191, 5870.354261031198, 5891.675957822361, 5922.082077278029, 5505.421930697219, 5656.858578535405, 5667.3765885753355, 5674.829755107354, 5675.716214189357, 5654.660720356792, 5658.0, 5668.376478587435, 5672.7730890763905, 5680.0, 5456.236126942311, 5538.556915446674, 5547.55619550443, 5567.47109024642, 5569.44305569456, 5708.600397972102, 5720.141978703228, 5722.685252311163, 5724.255846740064, 5727.599068065196, 5388.326459192601, 5462.235287059894, 5534.782347883459, 5536.307961504812, 5536.363318218296], "value": 4359.649475199804, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.4391652552746, 745.9067616547932, 749.235779504905, 750.7635094945092, 756.3646536908996, 13136.605901822937, 14007.509737159215, 14045.648858778535, 14073.437062517512, 14110.435582576698, 13531.661708457294, 14654.48709295175, 14982.550523484286, 15029.849701502982, 15044.623884402896, 838.8490071787076, 856.0326830681353, 857.9227869491745, 857.9313654907593, 859.4671303791627, 915.281504019345, 918.1231923513029, 918.2103391083663, 918.6692790595414, 920.3695468604028, 946.5787724462617, 948.2414068745011, 952.2286947572454, 953.1993125774349, 953.3183773601874, 932.7947851472666, 937.4890684576922, 944.707140786355, 945.0407836046419, 945.9479728614923, 681.6796105830252, 686.8488932434856, 691.408845437154, 691.4502970138752, 695.0651373902093, 14499.0, 14686.779698304534, 14959.252037398086, 14970.62573435662, 14986.850131498655, 14789.260536973215, 15112.168830714307, 15185.392584296615, 15200.695986080327, 15215.771763423558, 11044.116470682326, 11500.194986350958, 11502.07983361329, 11504.0, 11534.077273818075, 2706.688730795944, 2964.066319109495, 2977.3152174999655, 2983.4928062229474, 2984.089852594958, 63871.68064159696, 65505.672471637336, 66322.33677663258, 72085.63957180233, 73384.26615733828, 12465.376731163587, 12779.23324600527, 12805.743885122245, 12812.039097067756, 12836.358182090858, 22209.333719988426, 22518.887405562866, 22941.346720027024, 23080.7691923082, 23089.307320780405, 5956.344802071769, 6033.5474839387225, 6046.183765191643, 6055.757769689163, 6089.817305480843, 2987.074007057819, 3005.1585556044342, 3006.4888968875343, 3009.4432529982023, 3011.021418039146, 3543.4861945018342, 3592.993961690731, 3661.9816900915325, 3667.9266414671556, 3681.650243226889, 688.9242183359827, 689.0766373060123, 692.7990882644077, 694.9305069493112, 697.3828162076599, 581.9243498345188, 603.1314906534576, 606.6572386601645, 606.8937935861295, 610.4993904997948, 9016.278697704169, 9187.494687792101, 9409.764755881159, 9838.0, 9840.704778856645, 578.6383510306059, 580.5442727458925, 584.392232078642, 588.1178232651024, 603.1495591216451, 4300.311950087971, 4341.978290108529, 4348.695591308578, 4376.6498680105515, 4390.62679672225, 62846.685766570874, 63472.68263658652, 63730.362696372445, 64622.0, 65130.34869651338, 56443.71778141165, 57019.71490142523, 57069.714651427304, 57535.13697294544, 57924.131138032964, 50887.7455612727, 52297.95404091897, 54189.45810542002, 54279.72860135674, 54493.0, 8922.955385223033, 8955.641774329215, 9022.864657030019, 9274.44353338802, 9300.627974880928, 26574.33564160834, 27343.72656273412, 27685.30786730348, 27824.0, 28449.715502844705, 32406.83796581002, 32858.34283314273, 32995.34009319752, 33080.50379244265, 33547.161320966195, 10787.892121079003, 10853.131749460183, 10939.835902461311, 10983.286086404358, 10992.17558683086, 12170.939145304572, 12248.816267756169, 12415.193012454161, 12517.499300028261, 12529.122961392615, 11052.115830733683, 11329.773404532029, 11602.303861768321, 11622.593209237637, 11763.176577639482, 11530.538778448768, 11553.30680159193, 11723.941380293043, 11826.586069487526, 11929.28424294545, 10677.733056673645, 10824.296420732628, 10905.291156075147, 10977.0, 11051.502682379152, 8283.792905177419, 8384.41309108381, 8445.366597505088, 8578.356623253156, 8828.249598784176, 8720.78198045054, 9112.362134650512, 9112.407693499901, 9355.766105847408, 9369.437833729999], "value": 6494.609074774213, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 111.0, 112.0, 112.0, 112.0, 110.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 121.0, 183.0, 125.0, 124.0, 123.0, 124.0, 145.0, 122.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 161.0, 162.0, 163.0, 162.0, 163.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 109.0, 75.0, 75.0, 75.0, 75.0, 96.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 106.0, 83.0, 83.0, 83.0, 96.0, 83.0, 83.0, 114.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 149.0, 149.0, 150.0, 149.0, 149.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 55.0, 55.0, 56.0, 56.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 81.0, 81.0, 81.0, 80.0, 80.0, 81.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 139.0, 137.0, 133.0, 130.0, 130.0, 130.0, 180.0, 134.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 193.0, 194.0, 191.0, 184.0, 192.0, 191.0, 197.0, 193.0, 193.0], "value": 191.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 71.0, 74.0, 72.0, 72.0, 72.0, 72.0, 74.0, 72.0], "value": 72.5, "unit": "score"}]}]} 06:58:36 INFO - Return code: 0 06:58:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:58:36 INFO - # TBPL SUCCESS # 06:58:36 INFO - Running post-action listener: _resource_record_post_action 06:58:36 INFO - [mozharness: 2017-05-12 13:58:36.569290Z] Finished run-tests step (success) 06:58:36 INFO - Running post-run listener: _resource_record_post_run 06:58:36 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 495616; Write bytes: 363245568; Read time: 44; Write time: 257044 06:58:36 INFO - TinderboxPrint: CPU usage
12.9% 06:58:36 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 44 06:58:36 INFO - TinderboxPrint: I/O write bytes / time
363,245,568 / 257,044 06:58:36 INFO - TinderboxPrint: CPU idle
8,354.7 (87.1%) 06:58:36 INFO - TinderboxPrint: CPU user
1,196.1 (12.5%) 06:58:36 INFO - TinderboxPrint: Swap in / out
0 / 0 06:58:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 94269440; Read time: 0; Write time: 75424 06:58:36 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 491520; Write bytes: 268976128; Read time: 28; Write time: 181620 06:58:37 INFO - Running post-run listener: _upload_blobber_files 06:58:37 INFO - Blob upload gear active. 06:58:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:58:37 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 06:58:37 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'] 06:58:37 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 06:58:37 INFO - (blobuploader) - INFO - Open directory for files ... 06:58:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:58:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:58:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:42 INFO - (blobuploader) - INFO - Done attempting. 06:58:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:58:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:58:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:43 INFO - (blobuploader) - INFO - Done attempting. 06:58:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:58:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:44 INFO - (blobuploader) - INFO - Done attempting. 06:58:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:58:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:58:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:45 INFO - (blobuploader) - INFO - Done attempting. 06:58:45 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:45 INFO - Return code: 0 06:58:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:58:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:58:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53c9af55d2b61863890bbc05a172b5865702866c9734844210c3f008064593f99a9d7bf2a846241fa158fca015e9bf02fa0c450a1f4472065839613d4b82a0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/617c74ffa41e13ee0f04828f0fc85c98c6355cc74bdaefc9adb5f1e21ecb5f0dd642998cbaaa1ad8fc368ab14bbeff0810dcf76df65e8a1090ada2c53bedba11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b242ff15ac6eab9823e0c09e188f70724cb9b77fe8a63009a0e2a6c617d2984554aa5fb281a9c9d2a2cea44c49e3c94b8ae235c4f2ee7e7e0edeff107aa4aa3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bbf2ee53d7970d777ab584c1ef20f668bec255eef4736932dbda6f8df1224232052c8e05faf080f8c9dec387f1447f25eaacf1e8acb0a125daee4fd1c2ab831"} 06:58:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:58:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:58:45 INFO - Contents: 06:58:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53c9af55d2b61863890bbc05a172b5865702866c9734844210c3f008064593f99a9d7bf2a846241fa158fca015e9bf02fa0c450a1f4472065839613d4b82a0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/617c74ffa41e13ee0f04828f0fc85c98c6355cc74bdaefc9adb5f1e21ecb5f0dd642998cbaaa1ad8fc368ab14bbeff0810dcf76df65e8a1090ada2c53bedba11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b242ff15ac6eab9823e0c09e188f70724cb9b77fe8a63009a0e2a6c617d2984554aa5fb281a9c9d2a2cea44c49e3c94b8ae235c4f2ee7e7e0edeff107aa4aa3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bbf2ee53d7970d777ab584c1ef20f668bec255eef4736932dbda6f8df1224232052c8e05faf080f8c9dec387f1447f25eaacf1e8acb0a125daee4fd1c2ab831"} 06:58:45 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:45 INFO - Copying logs to upload dir... 06:58:45 INFO - mkdir: /builds/slave/test/build/upload/logs 06:58:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.969582 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-12 06:58:45.200262) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 06:58:45.207893) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560 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/53c9af55d2b61863890bbc05a172b5865702866c9734844210c3f008064593f99a9d7bf2a846241fa158fca015e9bf02fa0c450a1f4472065839613d4b82a0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/617c74ffa41e13ee0f04828f0fc85c98c6355cc74bdaefc9adb5f1e21ecb5f0dd642998cbaaa1ad8fc368ab14bbeff0810dcf76df65e8a1090ada2c53bedba11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b242ff15ac6eab9823e0c09e188f70724cb9b77fe8a63009a0e2a6c617d2984554aa5fb281a9c9d2a2cea44c49e3c94b8ae235c4f2ee7e7e0edeff107aa4aa3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bbf2ee53d7970d777ab584c1ef20f668bec255eef4736932dbda6f8df1224232052c8e05faf080f8c9dec387f1447f25eaacf1e8acb0a125daee4fd1c2ab831"} build_url:https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011135 build_url: 'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53c9af55d2b61863890bbc05a172b5865702866c9734844210c3f008064593f99a9d7bf2a846241fa158fca015e9bf02fa0c450a1f4472065839613d4b82a0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/617c74ffa41e13ee0f04828f0fc85c98c6355cc74bdaefc9adb5f1e21ecb5f0dd642998cbaaa1ad8fc368ab14bbeff0810dcf76df65e8a1090ada2c53bedba11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b242ff15ac6eab9823e0c09e188f70724cb9b77fe8a63009a0e2a6c617d2984554aa5fb281a9c9d2a2cea44c49e3c94b8ae235c4f2ee7e7e0edeff107aa4aa3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bbf2ee53d7970d777ab584c1ef20f668bec255eef4736932dbda6f8df1224232052c8e05faf080f8c9dec387f1447f25eaacf1e8acb0a125daee4fd1c2ab831"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 06:58:45.232489) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:58:45.235790) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1494596263.44397-1601557560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:58:45.317962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 06:58:45.318247) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 06:58:45.321538) ========= ========= Total master_lag: 0.18 =========