builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-084 starttime: 1495114174.4 results: success (0) revision: 5a67d411498982aec919e3c4d3e045ce3c250d75 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:34.398685) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:34.399085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:34.402381) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:34.442923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:34.443181) ========= 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=ea65d483da93c827905c2090000001f5-1495113641.332403-813516333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-18 06:29:35-- 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% 87.0M=0s 2017-05-18 06:29:35 (87.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:34.548361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:34.548662) ========= 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=ea65d483da93c827905c2090000001f5-1495113641.332403-813516333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015215 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:34.600974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-18 06:29:34.601316) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5a67d411498982aec919e3c4d3e045ce3c250d75 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5a67d411498982aec919e3c4d3e045ce3c250d75 --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=ea65d483da93c827905c2090000001f5-1495113641.332403-813516333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-18 06:29:35,932 truncating revision to first 12 chars 2017-05-18 06:29:35,932 Setting DEBUG logging. 2017-05-18 06:29:35,932 attempt 1/10 2017-05-18 06:29:35,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5a67d4114989?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-18 06:29:36,828 unpacking tar archive at: mozilla-beta-5a67d4114989/testing/mozharness/ program finished with exit code 0 elapsedTime=1.247408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-18 06:29:35.864019) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:35.867345) ========= script_repo_revision: 5a67d411498982aec919e3c4d3e045ce3c250d75 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:35.867749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:35.868296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 06:29:35.877389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-05-18 06:29:35.877694) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=ea65d483da93c827905c2090000001f5-1495113641.332403-813516333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:29:37 INFO - MultiFileLogger online at 20170518 06:29:37 in /builds/slave/test 06:29:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 06:29:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:29:37 INFO - {'append_to_log': False, 06:29:37 INFO - 'base_work_dir': '/builds/slave/test', 06:29:37 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 06:29:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:29:37 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 06:29:37 INFO - 'buildbot_json_path': 'buildprops.json', 06:29:37 INFO - 'config_files': ('talos/linux_config.py',), 06:29:37 INFO - 'default_actions': ('clobber', 06:29:37 INFO - 'read-buildbot-config', 06:29:37 INFO - 'download-and-extract', 06:29:37 INFO - 'populate-webroot', 06:29:37 INFO - 'create-virtualenv', 06:29:37 INFO - 'install', 06:29:37 INFO - 'run-tests'), 06:29:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:29:37 INFO - 'download_minidump_stackwalk': True, 06:29:37 INFO - 'download_symbols': 'ondemand', 06:29:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:29:37 INFO - 'tooltool.py': '/tools/tooltool.py', 06:29:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:29:37 INFO - '/tools/misc-python/virtualenv.py')}, 06:29:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:29:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:29:37 INFO - 'gecko_profile': False, 06:29:37 INFO - 'gecko_profile_interval': 0, 06:29:37 INFO - 'installer_path': 'installer.exe', 06:29:37 INFO - 'log_level': 'info', 06:29:37 INFO - 'log_name': 'talos', 06:29:37 INFO - 'log_to_console': True, 06:29:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:29:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:29:37 INFO - 'opt_config_files': (), 06:29:37 INFO - 'pip_index': False, 06:29:37 INFO - 'suite': 'dromaeojs', 06:29:37 INFO - 'system_bits': '32', 06:29:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:29:37 INFO - 'title': 'talos-linux64-ix-084', 06:29:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:29:37 INFO - 'use_talos_json': True, 06:29:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:29:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:29:37 INFO - 'work_dir': 'build'} 06:29:37 INFO - [mozharness: 2017-05-18 13:29:37.305677Z] Running clobber step. 06:29:37 INFO - Running pre-action listener: _resource_record_pre_action 06:29:37 INFO - Running main action method: clobber 06:29:37 INFO - rmtree: /builds/slave/test/build 06:29:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:29:38 INFO - Running post-action listener: _resource_record_post_action 06:29:38 INFO - [mozharness: 2017-05-18 13:29:38.872863Z] Finished clobber step (success) 06:29:38 INFO - [mozharness: 2017-05-18 13:29:38.872961Z] Running read-buildbot-config step. 06:29:38 INFO - Running pre-action listener: _resource_record_pre_action 06:29:38 INFO - Running main action method: read_buildbot_config 06:29:38 INFO - Using buildbot properties: 06:29:38 INFO - { 06:29:38 INFO - "project": "", 06:29:38 INFO - "product": "firefox", 06:29:38 INFO - "who": "ryanvm@gmail.com", 06:29:38 INFO - "installer_path": "public/build/target.tar.bz2", 06:29:38 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:29:38 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 06:29:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 06:29:38 INFO - "stage_platform": "linux64", 06:29:38 INFO - "basedir": "/builds/slave/test", 06:29:38 INFO - "buildnumber": 50, 06:29:38 INFO - "platform": "ubuntu64_hw", 06:29:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:29:38 INFO - "slavebuilddir": "test", 06:29:38 INFO - "taskId": "W6w2kT8zQ26JfKpl7Y1k_w", 06:29:38 INFO - "branch": "mozilla-beta", 06:29:38 INFO - "script_repo_revision": "production", 06:29:38 INFO - "revision": "5a67d411498982aec919e3c4d3e045ce3c250d75", 06:29:38 INFO - "slavename": "talos-linux64-ix-084", 06:29:38 INFO - "repo_path": "releases/mozilla-beta" 06:29:38 INFO - } 06:29:38 INFO - Finding installer, test and symbols from parent task. 06:29:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W6w2kT8zQ26JfKpl7Y1k_w'}, attempt #1 06:29:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W6w2kT8zQ26JfKpl7Y1k_w'}, attempt #1 06:29:39 INFO - Task dependencies: IXqZmW9sTNWfh0Q03vytNg 06:29:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg'}, attempt #1 06:29:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.tar.bz2 06:29:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/test_packages.json 06:29:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.crashreporter-symbols.zip 06:29:40 INFO - Running post-action listener: _resource_record_post_action 06:29:40 INFO - [mozharness: 2017-05-18 13:29:40.336463Z] Finished read-buildbot-config step (success) 06:29:40 INFO - [mozharness: 2017-05-18 13:29:40.336683Z] Running download-and-extract step. 06:29:40 INFO - Running pre-action listener: _resource_record_pre_action 06:29:40 INFO - Running main action method: download_and_extract 06:29:40 INFO - mkdir: /builds/slave/test/build/tests 06:29:40 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:29:40 INFO - trying https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.test_packages.json 06:29:40 INFO - Downloading https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:29:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:29:40 INFO - Downloaded 986 bytes. 06:29:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:29:40 INFO - Using the following test package requirements: 06:29:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:29:40 INFO - u'common': [u'target.common.tests.zip'], 06:29:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:29:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:29:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:29:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:29:40 INFO - u'mozbase': [u'target.common.tests.zip'], 06:29:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:29:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:29:40 INFO - u'web-platform': [u'target.common.tests.zip', 06:29:40 INFO - u'target.web-platform.tests.zip'], 06:29:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:29:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:29:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.common.tests.zip 06:29:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:29:40 INFO - Fetch https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.common.tests.zip into memory 06:29:42 INFO - Expected file size: 59560528 06:29:42 INFO - Obtained file size: 59560528 06:29:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:29:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.common.tests.zip 06:29:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:29:51 INFO - Fetch https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.common.tests.zip into memory 06:29:53 INFO - Expected file size: 59560528 06:29:53 INFO - Obtained file size: 59560528 06:30:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.talos.tests.zip 06:30:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:30:03 INFO - Fetch https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.talos.tests.zip into memory 06:30:04 INFO - Expected file size: 14404449 06:30:04 INFO - Obtained file size: 14404449 06:30:04 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:30:04 INFO - trying https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.tar.bz2 06:30:04 INFO - Downloading https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:30:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:30:06 INFO - Downloaded 59689322 bytes. 06:30:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.tar.bz2 06:30:06 INFO - mkdir: /builds/slave/test/properties 06:30:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:30:06 INFO - Writing to file /builds/slave/test/properties/build_url 06:30:06 INFO - Contents: 06:30:06 INFO - build_url:https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.tar.bz2 06:30:06 INFO - Running post-action listener: _resource_record_post_action 06:30:06 INFO - Running post-action listener: set_extra_try_arguments 06:30:06 INFO - [mozharness: 2017-05-18 13:30:06.280095Z] Finished download-and-extract step (success) 06:30:06 INFO - [mozharness: 2017-05-18 13:30:06.280192Z] Running populate-webroot step. 06:30:06 INFO - Running pre-action listener: _resource_record_pre_action 06:30:06 INFO - Running main action method: populate_webroot 06:30:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:30:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:30:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:30:06 INFO - '--tppagecycles', 06:30:06 INFO - '7'], 06:30:06 INFO - 'tests': ['tsvgm']}}, 06:30:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:30:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:30:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:30:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:30:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:30:06 INFO - 'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:30:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:30:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:30:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:30:06 INFO - 'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['damp', 'tps']}, 06:30:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:30:06 INFO - 'tests': ['damp', 'tps']}, 06:30:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['dromaeo_dom']}, 06:30:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:30:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['basic_compositor_video']}, 06:30:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:30:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['a11yr', 06:30:06 INFO - 'ts_paint', 06:30:06 INFO - 'tpaint', 06:30:06 INFO - 'sessionrestore', 06:30:06 INFO - 'sessionrestore_no_auto_restore', 06:30:06 INFO - 'tabpaint']}, 06:30:06 INFO - 'other-e10s': {'tests': ['a11yr', 06:30:06 INFO - 'ts_paint', 06:30:06 INFO - 'tpaint', 06:30:06 INFO - 'sessionrestore', 06:30:06 INFO - 'sessionrestore_no_auto_restore', 06:30:06 INFO - 'tabpaint']}, 06:30:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:30:06 INFO - 'ts_paint', 06:30:06 INFO - 'tpaint', 06:30:06 INFO - 'sessionrestore', 06:30:06 INFO - 'sessionrestore_no_auto_restore', 06:30:06 INFO - 'tabpaint']}, 06:30:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:30:06 INFO - 'ts_paint', 06:30:06 INFO - 'tpaint', 06:30:06 INFO - 'sessionrestore', 06:30:06 INFO - 'sessionrestore_no_auto_restore', 06:30:06 INFO - 'tabpaint']}, 06:30:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['a11yr', 06:30:06 INFO - 'ts_paint', 06:30:06 INFO - 'tpaint', 06:30:06 INFO - 'sessionrestore', 06:30:06 INFO - 'sessionrestore_no_auto_restore', 06:30:06 INFO - 'tabpaint']}, 06:30:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['a11yr', 06:30:06 INFO - 'ts_paint', 06:30:06 INFO - 'tpaint', 06:30:06 INFO - 'sessionrestore', 06:30:06 INFO - 'sessionrestore_no_auto_restore', 06:30:06 INFO - 'tabpaint']}, 06:30:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['tsvgx', 06:30:06 INFO - 'tsvgr_opacity', 06:30:06 INFO - 'tart', 06:30:06 INFO - 'tscrollx', 06:30:06 INFO - 'cart', 06:30:06 INFO - 'tsvg_static']}, 06:30:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:30:06 INFO - 'tsvgr_opacity', 06:30:06 INFO - 'tart', 06:30:06 INFO - 'tscrollx', 06:30:06 INFO - 'cart', 06:30:06 INFO - 'tsvg_static']}, 06:30:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:30:06 INFO - 'talos_options': ['--disable-e10s'], 06:30:06 INFO - 'tests': ['tp5o']}, 06:30:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:30:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:30:06 INFO - 'talos_options': ['--disable-e10s', 06:30:06 INFO - '--xperf_path', 06:30:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:30:06 INFO - 'tests': ['tp5n']}, 06:30:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:30:06 INFO - 'talos_options': ['--xperf_path', 06:30:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:30:06 INFO - 'tests': ['tp5n']}}, 06:30:06 INFO - 'talos.zip': {'path': '', 06:30:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:30:06 INFO - Running post-action listener: _resource_record_post_action 06:30:06 INFO - [mozharness: 2017-05-18 13:30:06.295322Z] Finished populate-webroot step (success) 06:30:06 INFO - [mozharness: 2017-05-18 13:30:06.295413Z] Running create-virtualenv step. 06:30:06 INFO - Running pre-action listener: _resource_record_pre_action 06:30:06 INFO - Running main action method: create_virtualenv 06:30:06 INFO - Creating virtualenv /builds/slave/test/build/venv 06:30:06 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:30:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:30:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:30:06 INFO - Using real prefix '/usr' 06:30:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:30:06 INFO - Installing distribute.............................................................................................................................................................................................done. 06:30:08 INFO - Installing pip.................done. 06:30:08 INFO - Return code: 0 06:30:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:30:09 INFO - Reading from file tmpfile_stdout 06:30:09 INFO - Output received: 06:30:09 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:30:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:30:09 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:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:09 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:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:09 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 0xe701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, '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': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', '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:30:09 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:30:09 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:30:09 INFO - Using env: {'DISPLAY': ':0', 06:30:09 INFO - 'HOME': '/home/cltbld', 06:30:09 INFO - 'LANG': 'en_US.UTF-8', 06:30:09 INFO - 'LANGUAGE': 'en_US:en', 06:30:09 INFO - 'LOGNAME': 'cltbld', 06:30:09 INFO - 'MAIL': '/var/mail/cltbld', 06:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:09 INFO - 'MOZ_NO_REMOTE': '1', 06:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:09 INFO - 'NO_EM_RESTART': '1', 06:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:09 INFO - 'PWD': '/builds/slave/test', 06:30:09 INFO - 'SHELL': '/bin/bash', 06:30:09 INFO - 'SHLVL': '1', 06:30:09 INFO - 'TERM': 'linux', 06:30:09 INFO - 'TMOUT': '86400', 06:30:09 INFO - 'USER': 'cltbld', 06:30:09 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:09 INFO - '_': '/tools/buildbot/bin/python'} 06:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:09 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:30:09 INFO - Cleaning up... 06:30:09 INFO - Return code: 0 06:30:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:30:09 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:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:09 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:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:09 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 0xe701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, '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': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', '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:30:09 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:30:09 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:30:09 INFO - Using env: {'DISPLAY': ':0', 06:30:09 INFO - 'HOME': '/home/cltbld', 06:30:09 INFO - 'LANG': 'en_US.UTF-8', 06:30:09 INFO - 'LANGUAGE': 'en_US:en', 06:30:09 INFO - 'LOGNAME': 'cltbld', 06:30:09 INFO - 'MAIL': '/var/mail/cltbld', 06:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:09 INFO - 'MOZ_NO_REMOTE': '1', 06:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:09 INFO - 'NO_EM_RESTART': '1', 06:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:09 INFO - 'PWD': '/builds/slave/test', 06:30:09 INFO - 'SHELL': '/bin/bash', 06:30:09 INFO - 'SHLVL': '1', 06:30:09 INFO - 'TERM': 'linux', 06:30:09 INFO - 'TMOUT': '86400', 06:30:09 INFO - 'USER': 'cltbld', 06:30:09 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:09 INFO - '_': '/tools/buildbot/bin/python'} 06:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:09 INFO - Downloading/unpacking psutil>=3.1.1 06:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:30:10 INFO - Installing collected packages: psutil 06:30:10 INFO - Running setup.py install for psutil 06:30:10 INFO - building 'psutil._psutil_linux' extension 06:30:10 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:30:10 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:30:10 INFO - building 'psutil._psutil_posix' extension 06:30:10 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:30:11 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:30:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:30:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:30:11 INFO - Successfully installed psutil 06:30:11 INFO - Cleaning up... 06:30:11 INFO - Return code: 0 06:30:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:30:11 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:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:11 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:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:11 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 0xe701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, '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': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', '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:30:11 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:30:11 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:30:11 INFO - Using env: {'DISPLAY': ':0', 06:30:11 INFO - 'HOME': '/home/cltbld', 06:30:11 INFO - 'LANG': 'en_US.UTF-8', 06:30:11 INFO - 'LANGUAGE': 'en_US:en', 06:30:11 INFO - 'LOGNAME': 'cltbld', 06:30:11 INFO - 'MAIL': '/var/mail/cltbld', 06:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:11 INFO - 'MOZ_NO_REMOTE': '1', 06:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:11 INFO - 'NO_EM_RESTART': '1', 06:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:11 INFO - 'PWD': '/builds/slave/test', 06:30:11 INFO - 'SHELL': '/bin/bash', 06:30:11 INFO - 'SHLVL': '1', 06:30:11 INFO - 'TERM': 'linux', 06:30:11 INFO - 'TMOUT': '86400', 06:30:11 INFO - 'USER': 'cltbld', 06:30:11 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:11 INFO - '_': '/tools/buildbot/bin/python'} 06:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:30:11 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:30:11 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:30:11 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:30:11 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:30:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:30:12 INFO - Installing collected packages: mozsystemmonitor 06:30:12 INFO - Running setup.py install for mozsystemmonitor 06:30:12 INFO - Successfully installed mozsystemmonitor 06:30:12 INFO - Cleaning up... 06:30:12 INFO - Return code: 0 06:30:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:30:12 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:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:12 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:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:12 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 0xe701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, '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': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', '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:30:12 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:30:12 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:30:12 INFO - Using env: {'DISPLAY': ':0', 06:30:12 INFO - 'HOME': '/home/cltbld', 06:30:12 INFO - 'LANG': 'en_US.UTF-8', 06:30:12 INFO - 'LANGUAGE': 'en_US:en', 06:30:12 INFO - 'LOGNAME': 'cltbld', 06:30:12 INFO - 'MAIL': '/var/mail/cltbld', 06:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:12 INFO - 'MOZ_NO_REMOTE': '1', 06:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:12 INFO - 'NO_EM_RESTART': '1', 06:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:12 INFO - 'PWD': '/builds/slave/test', 06:30:12 INFO - 'SHELL': '/bin/bash', 06:30:12 INFO - 'SHLVL': '1', 06:30:12 INFO - 'TERM': 'linux', 06:30:12 INFO - 'TMOUT': '86400', 06:30:12 INFO - 'USER': 'cltbld', 06:30:12 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:12 INFO - '_': '/tools/buildbot/bin/python'} 06:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:12 INFO - Downloading/unpacking jsonschema==2.5.1 06:30:12 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:30:12 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:30:12 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:30:12 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:30:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:30:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:30:14 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:30:14 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:30:14 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:30:14 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:30:14 INFO - Downloading functools32-3.2.3-2.tar.gz 06:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:30:14 INFO - warning: no files found matching '*.txt' 06:30:14 INFO - no previously-included directories found matching 'build' 06:30:14 INFO - no previously-included directories found matching 'dist' 06:30:14 INFO - no previously-included directories found matching '.git*' 06:30:14 INFO - Installing collected packages: jsonschema, functools32 06:30:14 INFO - Running setup.py install for functools32 06:30:14 INFO - warning: no files found matching '*.txt' 06:30:14 INFO - no previously-included directories found matching 'build' 06:30:14 INFO - no previously-included directories found matching 'dist' 06:30:14 INFO - no previously-included directories found matching '.git*' 06:30:14 INFO - Successfully installed jsonschema functools32 06:30:14 INFO - Cleaning up... 06:30:14 INFO - Return code: 0 06:30:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:30: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:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30: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:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:14 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 0xe701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, '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': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', '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:30:14 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:30:14 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:30:14 INFO - Using env: {'DISPLAY': ':0', 06:30:14 INFO - 'HOME': '/home/cltbld', 06:30:14 INFO - 'LANG': 'en_US.UTF-8', 06:30:14 INFO - 'LANGUAGE': 'en_US:en', 06:30:14 INFO - 'LOGNAME': 'cltbld', 06:30:14 INFO - 'MAIL': '/var/mail/cltbld', 06:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:14 INFO - 'MOZ_NO_REMOTE': '1', 06:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:14 INFO - 'NO_EM_RESTART': '1', 06:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:14 INFO - 'PWD': '/builds/slave/test', 06:30:14 INFO - 'SHELL': '/bin/bash', 06:30:14 INFO - 'SHLVL': '1', 06:30:14 INFO - 'TERM': 'linux', 06:30:14 INFO - 'TMOUT': '86400', 06:30:14 INFO - 'USER': 'cltbld', 06:30:14 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:14 INFO - '_': '/tools/buildbot/bin/python'} 06:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:30:14 INFO - Cleaning up... 06:30:14 INFO - Return code: 0 06:30:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:30: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:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30: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:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:14 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 0xe701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, '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': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', '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:30:14 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:30:14 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:30:14 INFO - Using env: {'DISPLAY': ':0', 06:30:14 INFO - 'HOME': '/home/cltbld', 06:30:14 INFO - 'LANG': 'en_US.UTF-8', 06:30:14 INFO - 'LANGUAGE': 'en_US:en', 06:30:14 INFO - 'LOGNAME': 'cltbld', 06:30:14 INFO - 'MAIL': '/var/mail/cltbld', 06:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:14 INFO - 'MOZ_NO_REMOTE': '1', 06:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:14 INFO - 'NO_EM_RESTART': '1', 06:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:14 INFO - 'PWD': '/builds/slave/test', 06:30:14 INFO - 'SHELL': '/bin/bash', 06:30:14 INFO - 'SHLVL': '1', 06:30:14 INFO - 'TERM': 'linux', 06:30:14 INFO - 'TMOUT': '86400', 06:30:14 INFO - 'USER': 'cltbld', 06:30:14 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:14 INFO - '_': '/tools/buildbot/bin/python'} 06:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:14 INFO - Downloading/unpacking blobuploader==1.2.4 06:30:14 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:30:14 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:30:14 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:30:14 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:30:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:30:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:30:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:30:15 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:30:15 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:30:15 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:30:15 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:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:30:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:16 INFO - Downloading docopt-0.6.1.tar.gz 06:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:30:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:30:16 INFO - Running setup.py install for blobuploader 06:30:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:30:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:30:16 INFO - Running setup.py install for requests 06:30:16 INFO - Running setup.py install for docopt 06:30:17 INFO - Successfully installed blobuploader requests docopt 06:30:17 INFO - Cleaning up... 06:30:17 INFO - Return code: 0 06:30:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:30:17 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:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:17 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:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:17 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 0xe701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, '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': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', '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:30:17 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:30:17 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:30:17 INFO - Using env: {'DISPLAY': ':0', 06:30:17 INFO - 'HOME': '/home/cltbld', 06:30:17 INFO - 'LANG': 'en_US.UTF-8', 06:30:17 INFO - 'LANGUAGE': 'en_US:en', 06:30:17 INFO - 'LOGNAME': 'cltbld', 06:30:17 INFO - 'MAIL': '/var/mail/cltbld', 06:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:17 INFO - 'MOZ_NO_REMOTE': '1', 06:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:17 INFO - 'NO_EM_RESTART': '1', 06:30:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:17 INFO - 'PWD': '/builds/slave/test', 06:30:17 INFO - 'SHELL': '/bin/bash', 06:30:17 INFO - 'SHLVL': '1', 06:30:17 INFO - 'TERM': 'linux', 06:30:17 INFO - 'TMOUT': '86400', 06:30:17 INFO - 'USER': 'cltbld', 06:30:17 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:17 INFO - '_': '/tools/buildbot/bin/python'} 06:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:30:17 INFO - Running setup.py (path:/tmp/pip-ezwfSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:30:17 INFO - Running setup.py (path:/tmp/pip-zNZMwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:30:17 INFO - Running setup.py (path:/tmp/pip-9V_ZcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:30:17 INFO - Running setup.py (path:/tmp/pip-pP7xlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:30:17 INFO - Running setup.py (path:/tmp/pip-NXM3MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:30:17 INFO - Running setup.py (path:/tmp/pip-CLPhhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:30:17 INFO - Running setup.py (path:/tmp/pip-RqAo1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:30:17 INFO - Running setup.py (path:/tmp/pip-nl5dEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:30:17 INFO - Running setup.py (path:/tmp/pip-YtKr6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:30:17 INFO - Running setup.py (path:/tmp/pip-BV1fdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:30:18 INFO - Running setup.py (path:/tmp/pip-3mZ5um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:30:18 INFO - Running setup.py (path:/tmp/pip-qsWtCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:30:18 INFO - Running setup.py (path:/tmp/pip-xU9hF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:30:18 INFO - Running setup.py (path:/tmp/pip-jFkV1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:18 INFO - Running setup.py (path:/tmp/pip-sRhm1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:30:18 INFO - Running setup.py (path:/tmp/pip-Bq77aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:30:18 INFO - Running setup.py (path:/tmp/pip-kgrweX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:30:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:30:18 INFO - Running setup.py install for manifestparser 06:30:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:30:18 INFO - Running setup.py install for mozcrash 06:30:18 INFO - Running setup.py install for mozdebug 06:30:18 INFO - Running setup.py install for mozdevice 06:30:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:30:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:30:18 INFO - Running setup.py install for mozfile 06:30:19 INFO - Running setup.py install for mozhttpd 06:30:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Running setup.py install for mozinfo 06:30:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Running setup.py install for mozInstall 06:30:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Running setup.py install for mozleak 06:30:19 INFO - Running setup.py install for mozlog 06:30:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Running setup.py install for moznetwork 06:30:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Running setup.py install for mozprocess 06:30:19 INFO - Running setup.py install for mozprofile 06:30:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:30:19 INFO - Running setup.py install for mozrunner 06:30:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:30:20 INFO - Running setup.py install for mozscreenshot 06:30:20 INFO - Running setup.py install for moztest 06:30:20 INFO - Running setup.py install for mozversion 06:30:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:30:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:30:20 INFO - Cleaning up... 06:30:20 INFO - Return code: 0 06:30:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:30:20 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:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:20 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:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:20 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 0xe701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, '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': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', '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:30:20 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:30:20 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:30:20 INFO - Using env: {'DISPLAY': ':0', 06:30:20 INFO - 'HOME': '/home/cltbld', 06:30:20 INFO - 'LANG': 'en_US.UTF-8', 06:30:20 INFO - 'LANGUAGE': 'en_US:en', 06:30:20 INFO - 'LOGNAME': 'cltbld', 06:30:20 INFO - 'MAIL': '/var/mail/cltbld', 06:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:20 INFO - 'MOZ_NO_REMOTE': '1', 06:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:20 INFO - 'NO_EM_RESTART': '1', 06:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:20 INFO - 'PWD': '/builds/slave/test', 06:30:20 INFO - 'SHELL': '/bin/bash', 06:30:20 INFO - 'SHLVL': '1', 06:30:20 INFO - 'TERM': 'linux', 06:30:20 INFO - 'TMOUT': '86400', 06:30:20 INFO - 'USER': 'cltbld', 06:30:20 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:20 INFO - '_': '/tools/buildbot/bin/python'} 06:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:30:20 INFO - Running setup.py (path:/tmp/pip-nwIkL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:30:20 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:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:30:20 INFO - Running setup.py (path:/tmp/pip-ZxV3_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:30:20 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:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:30:20 INFO - Running setup.py (path:/tmp/pip-zLU_lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:30:20 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:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:30:20 INFO - Running setup.py (path:/tmp/pip-YiQezU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:30:20 INFO - Running setup.py (path:/tmp/pip-wz38cZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:30:20 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:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:30:20 INFO - Running setup.py (path:/tmp/pip-P52aau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:30:21 INFO - Running setup.py (path:/tmp/pip-tn9E6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:30:21 INFO - Running setup.py (path:/tmp/pip-QiFbVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:30:21 INFO - Running setup.py (path:/tmp/pip-JdAKJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:30:21 INFO - Running setup.py (path:/tmp/pip-YZgXwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:30:21 INFO - Running setup.py (path:/tmp/pip-A2RzRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:30:21 INFO - Running setup.py (path:/tmp/pip-viMVF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:30:21 INFO - Running setup.py (path:/tmp/pip-xMr9sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:30:21 INFO - Running setup.py (path:/tmp/pip-zGswDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:21 INFO - Running setup.py (path:/tmp/pip-lEJAv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:30:21 INFO - Running setup.py (path:/tmp/pip-HNhAfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:30:21 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:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:30:21 INFO - Running setup.py (path:/tmp/pip-Z3yoh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:30:21 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:30:21 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:30:21 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:30:21 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:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:30:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:30: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:30: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:30: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:30: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:30:22 INFO - Downloading blessings-1.6.tar.gz 06:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:30:23 INFO - Installing collected packages: blessings 06:30:23 INFO - Running setup.py install for blessings 06:30:23 INFO - Successfully installed blessings 06:30:23 INFO - Cleaning up... 06:30:23 INFO - Return code: 0 06:30:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:30:23 INFO - Reading from file tmpfile_stdout 06:30:23 INFO - Current package versions: 06:30:23 INFO - argparse == 1.2.1 06:30:23 INFO - blessings == 1.6 06:30:23 INFO - blobuploader == 1.2.4 06:30:23 INFO - docopt == 0.6.1 06:30:23 INFO - functools32 == 3.2.3-2 06:30:23 INFO - jsonschema == 2.5.1 06:30:23 INFO - manifestparser == 1.1 06:30:23 INFO - mozInstall == 1.12 06:30:23 INFO - mozcrash == 1.0 06:30:23 INFO - mozdebug == 0.1 06:30:23 INFO - mozdevice == 0.49 06:30:23 INFO - mozfile == 1.2 06:30:23 INFO - mozhttpd == 0.7 06:30:23 INFO - mozinfo == 0.9 06:30:23 INFO - mozleak == 0.1 06:30:23 INFO - mozlog == 3.4 06:30:23 INFO - moznetwork == 0.27 06:30:23 INFO - mozprocess == 0.25 06:30:23 INFO - mozprofile == 0.28 06:30:23 INFO - mozrunner == 6.13 06:30:23 INFO - mozscreenshot == 0.1 06:30:23 INFO - mozsystemmonitor == 0.3 06:30:23 INFO - moztest == 0.8 06:30:23 INFO - mozversion == 1.4 06:30:23 INFO - psutil == 3.1.1 06:30:23 INFO - requests == 1.2.3 06:30:23 INFO - wsgiref == 0.1.2 06:30:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:30:23 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:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:23 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:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:23 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 0xe701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, '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': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', '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:30:23 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:30:23 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:30:23 INFO - Using env: {'DISPLAY': ':0', 06:30:23 INFO - 'HOME': '/home/cltbld', 06:30:23 INFO - 'LANG': 'en_US.UTF-8', 06:30:23 INFO - 'LANGUAGE': 'en_US:en', 06:30:23 INFO - 'LOGNAME': 'cltbld', 06:30:23 INFO - 'MAIL': '/var/mail/cltbld', 06:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:23 INFO - 'MOZ_NO_REMOTE': '1', 06:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:23 INFO - 'NO_EM_RESTART': '1', 06:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:23 INFO - 'PWD': '/builds/slave/test', 06:30:23 INFO - 'SHELL': '/bin/bash', 06:30:23 INFO - 'SHLVL': '1', 06:30:23 INFO - 'TERM': 'linux', 06:30:23 INFO - 'TMOUT': '86400', 06:30:23 INFO - 'USER': 'cltbld', 06:30:23 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:23 INFO - '_': '/tools/buildbot/bin/python'} 06:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:23 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:30:23 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:30:23 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:30:23 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:30:23 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:30:23 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:30:23 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:30:23 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:30:23 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:30:23 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:30:23 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:30:23 INFO - Cleaning up... 06:30:23 INFO - Return code: 0 06:30:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:30:23 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:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:23 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:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xe701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, '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': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', '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:30:23 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:30:23 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:30:23 INFO - Using env: {'DISPLAY': ':0', 06:30:23 INFO - 'HOME': '/home/cltbld', 06:30:23 INFO - 'LANG': 'en_US.UTF-8', 06:30:23 INFO - 'LANGUAGE': 'en_US:en', 06:30:23 INFO - 'LOGNAME': 'cltbld', 06:30:23 INFO - 'MAIL': '/var/mail/cltbld', 06:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:23 INFO - 'MOZ_NO_REMOTE': '1', 06:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:23 INFO - 'NO_EM_RESTART': '1', 06:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:23 INFO - 'PWD': '/builds/slave/test', 06:30:23 INFO - 'SHELL': '/bin/bash', 06:30:23 INFO - 'SHLVL': '1', 06:30:23 INFO - 'TERM': 'linux', 06:30:23 INFO - 'TMOUT': '86400', 06:30:23 INFO - 'USER': 'cltbld', 06:30:23 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:23 INFO - '_': '/tools/buildbot/bin/python'} 06:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:30:23 INFO - Cleaning up... 06:30:23 INFO - Return code: 0 06:30:23 INFO - Running post-action listener: _resource_record_post_action 06:30:23 INFO - Running post-action listener: _start_resource_monitoring 06:30:23 INFO - Starting resource monitoring. 06:30:23 INFO - [mozharness: 2017-05-18 13:30:23.888605Z] Finished create-virtualenv step (success) 06:30:23 INFO - [mozharness: 2017-05-18 13:30:23.889122Z] Running install step. 06:30:23 INFO - Running pre-action listener: _resource_record_pre_action 06:30:23 INFO - Running main action method: install 06:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:30:24 INFO - Reading from file tmpfile_stdout 06:30:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:30:24 INFO - Reading from file tmpfile_stdout 06:30:24 INFO - Output received: 06:30:24 INFO - Usage: mozinstall [options] installer 06:30:24 INFO - Options: 06:30:24 INFO - -h, --help show this help message and exit 06:30:24 INFO - -d DEST, --destination=DEST 06:30:24 INFO - Directory to install application into. [default: 06:30:24 INFO - "/builds/slave/test"] 06:30:24 INFO - --app=APP Application being installed. [default: firefox] 06:30:24 INFO - mkdir: /builds/slave/test/build/application 06:30:24 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:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:30:38 INFO - Reading from file tmpfile_stdout 06:30:38 INFO - Output received: 06:30:38 INFO - /builds/slave/test/build/application/firefox/firefox 06:30:38 INFO - Running post-action listener: _resource_record_post_action 06:30:38 INFO - [mozharness: 2017-05-18 13:30:38.618720Z] Finished install step (success) 06:30:38 INFO - [mozharness: 2017-05-18 13:30:38.618964Z] Running run-tests step. 06:30:38 INFO - Running pre-action listener: _resource_record_pre_action 06:30:38 INFO - Running main action method: run_tests 06:30:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:30:38 INFO - Python 2.7.3 06:30:38 INFO - Return code: 0 06:30:38 INFO - grabbing minidump binary from tooltool 06:30:38 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:30:38 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 0x110b400>, '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 0x110c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110c840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:30:38 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:30:38 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:30:38 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:30:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:30:38 INFO - Return code: 0 06:30:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:30:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:30:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:30:38 INFO - ENV: RUST_BACKTRACE is now 1 06:30:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:30:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:30:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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:30:38 INFO - Using env: {'DISPLAY': ':0', 06:30:38 INFO - 'HOME': '/home/cltbld', 06:30:38 INFO - 'LANG': 'en_US.UTF-8', 06:30:38 INFO - 'LANGUAGE': 'en_US:en', 06:30:38 INFO - 'LOGNAME': 'cltbld', 06:30:38 INFO - 'MAIL': '/var/mail/cltbld', 06:30:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:30:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:38 INFO - 'MOZ_NO_REMOTE': '1', 06:30:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:38 INFO - 'NO_EM_RESTART': '1', 06:30:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:38 INFO - 'PWD': '/builds/slave/test', 06:30:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:30:38 INFO - 'RUST_BACKTRACE': '1', 06:30:38 INFO - 'SHELL': '/bin/bash', 06:30:38 INFO - 'SHLVL': '1', 06:30:38 INFO - 'TERM': 'linux', 06:30:38 INFO - 'TMOUT': '86400', 06:30:38 INFO - 'USER': 'cltbld', 06:30:38 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495113641.332403-813516333', 06:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:38 INFO - '_': '/tools/buildbot/bin/python'} 06:30:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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:30:38 INFO - mozversion application_buildid: 20170518123633 06:30:38 INFO - mozversion application_changeset: 5a67d411498982aec919e3c4d3e045ce3c250d75 06:30:38 INFO - mozversion application_display_name: Firefox 06:30:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:30:38 INFO - mozversion application_name: Firefox 06:30:38 INFO - mozversion application_remotingname: firefox 06:30:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:30:38 INFO - mozversion application_vendor: Mozilla 06:30:38 INFO - mozversion application_version: 54.0 06:30:38 INFO - mozversion platform_buildid: 20170518123633 06:30:38 INFO - mozversion platform_changeset: 5a67d411498982aec919e3c4d3e045ce3c250d75 06:30:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:30:38 INFO - mozversion platform_version: 54.0 06:30:38 INFO - using testdate: 1495114238 06:30:38 INFO - actual date: 1495114238 06:30:38 INFO - starting webserver on 'localhost:43674' 06:30:38 INFO - SUITE-START | Running 2 tests 06:30:38 INFO - TEST-START | dromaeo_css 06:30:38 INFO - operating with platform_type : linux_ 06:30:38 INFO - Initialising browser for dromaeo_css test... 06:30:38 INFO - TEST-INFO | started process 10422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoPJFuy/profile http://localhost:43674/getInfo.html) 06:30:43 INFO - PROCESS | 10422 | __metrics Screen width/height:1600/1200 06:30:43 INFO - PROCESS | 10422 | colorDepth:24 06:30:43 INFO - PROCESS | 10422 | Browser inner width/height: 1024/697 06:30:43 INFO - PROCESS | 10422 | __metrics 06:30:44 INFO - PROCESS | 10422 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:30:44 INFO - PROCESS | 10422 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:30:44 INFO - PROCESS | 10422 | console.error: PushService: 06:30:44 INFO - PROCESS | 10422 | stateChangeProcessEnqueue: Error transitioning state 06:30:44 INFO - PROCESS | 10422 | UnknownError 06:30:45 INFO - TEST-INFO | 10422: exit 0 06:30:45 INFO - Browser initialized. 06:30:45 INFO - Running cycle 1/1 for dromaeo_css test... 06:30:45 INFO - TEST-INFO | started process 10511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoPJFuy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:56 INFO - PROCESS | 10511 | RSS: Main: 140972032 06:30:56 INFO - PROCESS | 10511 | 06:33:58 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:43674/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43674/tests/dromaeo/cssquery-ext.html) 06:33:59 INFO - PROCESS | 10511 | RSS: Main: 245575680 06:33:59 INFO - PROCESS | 10511 | 06:37:01 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:43674/tests/dromaeo/cssquery-ext.html (next: http://localhost:43674/tests/dromaeo/cssquery-jquery.html) 06:37:02 INFO - PROCESS | 10511 | RSS: Main: 227151872 06:37:02 INFO - PROCESS | 10511 | 06:40:04 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:43674/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43674/tests/dromaeo/cssquery-mootools.html) 06:40:04 INFO - PROCESS | 10511 | RSS: Main: 170881024 06:40:04 INFO - PROCESS | 10511 | 06:43:06 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:43674/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43674/tests/dromaeo/cssquery-prototype.html) 06:43:07 INFO - PROCESS | 10511 | RSS: Main: 195829760 06:43:07 INFO - PROCESS | 10511 | 06:46:10 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:43674/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43674/tests/dromaeo/cssquery-yui.html) 06:46:10 INFO - PROCESS | 10511 | RSS: Main: 175730688 06:46:10 INFO - PROCESS | 10511 | 06:49:13 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:43674/tests/dromaeo/cssquery-yui.html (next: http://localhost:43674/tests/dromaeo/cssquery-dojo.html) 06:49:13 INFO - PROCESS | 10511 | RSS: Main: 264970240 06:49:13 INFO - PROCESS | 10511 | 06:49:13 INFO - PROCESS | 10511 | __start_tp_report 06:49:13 INFO - PROCESS | 10511 | _x_x_mozilla_page_load 06:49:13 INFO - PROCESS | 10511 | _x_x_mozilla_page_load_details 06:49:13 INFO - PROCESS | 10511 | |i|pagename|runs| 06:49:13 INFO - PROCESS | 10511 | |0;dojo.html;3344.966550334497;3377.5271461995326;3386.1703882548777;3402.183475965769;3432.622411534731;5621.859453513664;5685.175649530821;5696.287964004494;5698.316202055759;5721.742521586528;5651.8304450866435;5679.801206957757;5711.171880077386;5720.056190728525;5721.027425337692;5172.069027575044;5176.171812509999;5196.376434827807;5224.346956630421;5260.421353651095;5068.923966140511;5070.949290507103;5273.578113750891;5284.445133260991;5315.548178404841;5092.439831618519;5108.8978220435565;5112.590992720573;5140.074786538422;5145.202493613478;5214.217867319894;5220.738963051832;5224.111900976805;5225.294585231021;5248.186531087687;5018.347614810052;5066.695998240118;5136.614753893436;5188.792448302063;5196.558292545138;5476.7535460904355;5524.889502209933;5525.309336332958;5547.057000309957;5569.275994120779;5954.672493012882;6002.669853158074;6007.459328660398;6007.549433792439;6042.1238920356745;6057.727402266909;6065.727042283108;6071.666058366788;6072.180255665517;6080.391960803929;5518.227448157261;5565.387807341189;5625.071863142617;5663.093904975267;5687.630304030225;6262.342454042351;6263.561550691408;6268.310485846553;6268.623882567061;6273.247210334789;5956.195913551702;6018.127371531104;6021.157038014681;6033.034714445667;6072.51419886408;5837.29952405714;5869.5010924071075;5970.283565972024;6023.307319658208;6100.48145907594;6050.45545900871;6057.878842423127;6077.24034495688;6080.604760690541;6085.878282434326;5828.475437210672;5862.70686465675;5863.091220860773;5867.383924687846;6101.084837274356;4571.862844114682;4613.953860461353;4622.075584883037;4622.422197225347;4626.21354369758;4110.157417729359;4117.3618089196225;4118.876433706993;4126.195391898551;4162.271602469556;5831.620944638585;5832.475077242983;5835.35811060783;5838.4453476919625;5843.094320380263;5896.439838215363;5938.376470470625;5942.346341902387;5999.550033747487;6095.573309868355;5810.157527158538;5827.970860145672;5846.561507886926;5851.32709738377;5861.17943487912;5144.331236939174;5144.562712169432;5148.897022059613;5150.974245128826;5151.97424012885;6133.233345831771;6165.136880836597;6220.595661282093;6268.874622507525;6283.214598175228;6015.428534289235;6015.428534289235;6028.216331876828;6058.818235452944;6063.060225665029;6282.2147231596055;6315.778947736991;6317.5893566918;6317.747290108344;6318.304986451579;5718.1136923776885;6010.278766548042;6012.368701286302;6014.248218972629;6014.308354539284;6004.279486461653;6010.068439391901;6052.878942421039;6131.468419844818;6142.109394137736;5933.554983376351;5989.8203053908455;5994.400559943971;5996.67018313997;6022.909656355246;5986.2517185351835;5986.760529578768;5988.161657367885;5988.880222395441;5990.400959903975;5701.885962280814;5785.363610002981;5835.737391817293;5857.677827719516;5887.411258874078;6031.638101713911;6037.63774173551;6039.607425517327;6040.577159598786;6060.818175454743;5656.377798442086;5676.17695434168;5845.503132233808;5882.382349853204;5882.705864706833 06:49:13 INFO - PROCESS | 10511 | |1;ext.html;782.9177936316687;840.9495430274184;867.132867132867;915.78021274894;931.6226928094115;30803.537946930785;42580.57419425805;43511.34732979004;43663.78168109155;43672.78163609178;38706.41940370897;39097.41353879694;39135.41296880549;42673.57326426735;42834;7674.5395276283325;8939.240164586;9077.137671921157;9078.273738100936;9081.772955676095;7524.322810947014;10428.16574674028;10613.150947924187;10614.469276536181;10638.095761860213;10746.194035447334;10764.300320479182;10764.623238186665;10772.299800512941;10772.515236814323;10662.573497060108;10665.466726663635;10669.199810014241;10687.519061642206;10715.946420267888;10640.414777187252;10706.250562460631;10711.678649640524;10716.785664286748;10727.892721072767;42626.78686606547;42694;42752.57247427517;42753;42775.57224427747;4307.289297265947;4361.978190109061;4370.759608221547;4458.4426946631675;4470.575295346936;30671.539926900892;31108;31168.8441557793;31206.83378795507;32641.51037734436;4435.135148646015;4471.6199123074575;4527.185106680796;4558.088382323548;4575.6568257380495;226180.8690956551;229882;230012;230228;230405;53638.46361536335;53749.731251343495;53882.46117538775;53895.73052134714;53938.19092713612;56456.717716411156;56493.71753141208;56583.43416565864;56627.15059274114;56659;16765.24556394965;16992.830071699373;17019.48941531756;17031.40390086341;17090.57273568146;13103.279319637511;13288.468461261442;14953.700925981419;14955.700885982436;14957.775633365509;12102.213356131822;13257.602271931857;13576.728465430637;13775.38010789517;14130.364133614012;5280.841574752763;5494.670319780826;5553.527950124285;5670.773169073191;5696.829095127153;1012.3773879064322;1017.8778546574458;1018.8675472188568;1029.9794004120026;1041.354360296621;28454.430911381656;28549.429011419656;28878.566821497694;28960.710392896224;29143.417131657672;1085.8154113800515;1118.6196693124214;1121.2095472691897;1124.6794663520857;1141.594733869481;14439.639009024859;15176.317065732068;15225.467108651366;15359.53921382338;15475.690486190213;301442;301723;303561;303890;305018;55761.163582546294;55880;56023.439765602634;56030.719846400505;56056;1489.5382431446287;1511.2217208137818;1533.9923300383202;1563.4059057558054;1565.1548163991317;27857.8856845732;28346.71653283441;29270.41459170847;29418;29571.40857182801;37381.25237495289;37496.06259843526;37519.43720844135;37571.812140940216;37657.81171094237;285218;285611;286483;286803;287072;25394.238172854843;25959.87020064963;30059.24851878633;31134.22164445907;33122.17194570155;34105.65894341025;37082.258354832215;40833.37496877342;44357.778211108736;45107.32339014983;31767.841160794047;31869;31923.201919952186;32072;32571;30998.690013100484;31307.217319567193;31486.842565787025;31608;31816.045518633553;35269.29461410809;35333.646663533036;35472.46791298184;35522;35531.111722207155;29547.113586592437;29919.401611967205;30349.544756828225;30632.84683576568;30844.845775770977;23651.763482364957;24713.25860224196;24722.50554988926;25017;25045.624315634916 06:49:13 INFO - PROCESS | 10511 | |2;jquery.html;455.8541266794623;467.5883043484722;471.9764011799409;475.6313856761012;480.2100544604126;19963.800361996393;19964.201431942703;21623.243186488475;21806;21810.89094554525;21720.3483895483;22363.217287394946;22402.551948961012;22447.438814029658;22461.550768984653;6762.22234443038;6910.965445172767;6922.169339679245;6995.125609298838;6997.545159564612;6559.3112723164095;6769.729210831585;6776.119104516406;6779.288174741655;6788.11754471918;6647.468202543809;6675.132232809752;6797.626130562817;6830.282820303871;6836.316368363174;6522.7390904363765;6708.228553716336;6766.458683305324;6818.693158807866;6820.522563420563;6605.372489613479;6607.669616519155;6609.834754131185;6610.933890661128;6615.239247486505;24864.25407237786;25558.23325300244;25731;25983.870080649664;25998.35004124893;3429.879954201591;3513.3149035938004;3569.428891377393;3634.7819130851967;3649.543807024122;15745.842541574551;16085.678286434206;16118.952268102654;16186.109763962977;16314.102724350156;2026.9189232430685;2063.7523497180287;2066.73132492775;2076.8753874767413;2110.1453911166004;117898;121145.39427302896;121495.39252303682;122361;124314;18124.546886327684;18745.531361716065;18801.435956921316;18804.529886752665;18888.33890813815;31326.530102048488;31346;31376.686233137832;31377;31588;10708.30396024256;10855.67432977012;10889.128869690407;10893.673189804318;11241.15691323154;9209.447433153899;9280.346050149688;9314.767130821783;9523.142917137491;9543.570539325608;8909.198172164537;9064;9371.156595906401;9404.294677899048;9488.193503552275;3083.057673665576;3774.848671155324;3895.9870433687447;3959.1883663848844;3996.480457540559;970.6990832841842;974.780674348266;979.6816034788579;982.6708052802248;990.3612170150212;20871.269505567234;20908.37274881756;20911.37265882026;20925.26761563338;20928.686069708965;986.9851952220722;987.6543209876629;988.6193815380987;999.4303247149201;1001.6444162322416;10910.61812836547;11494.252873563191;11583.247088939192;11652.592159274385;11752.70618234551;697183;710810;728264;730246;742194;88298.55850720833;96262.51868740752;112144;114924;115148.42425787817;1232.0820988363726;1248.6628610275357;1250.7060840702427;1270.879266469684;1287.620152055146;17818.732719008967;18186.545336366697;18385;18446.538836529195;18711.25154993785;49522;51186.23220651768;51514.48485515097;51589.742051289504;52318.47681523288;70206;70780;71034.22414439681;71792;73336.26663733508;12464.688382790502;12637;12813.295268760308;12907.290099044267;12951.740965180456;14696.55910322692;14722.411103556165;14852.925735371686;15078.623034424227;15330.540083797503;9788.510574471105;12706.428210730724;12730.108892377444;12778.105532612628;12938.611841644766;12110.091743119125;12297.200681955645;12393.62819115428;12458.626241212778;12497.25016499013;12562.93718531438;12719.87280127187;12844.486220551073;13086.14940028895;13153.934230328787;12458.75082498363;12534.811977820158;12596.55912043074;12712.237265764084;12934.611961641165;11787.941060294643;12294.262344259372;12592;12659.81010284828;13084.542041028519 06:49:13 INFO - PROCESS | 10511 | |3;mootools.html;1578.5106616948754;1593.4741535293347;1596.3853916242247;1611.580988942875;1623.8294979027194;10891.727706807324;11685.182037257395;11707.356095414749;11708.414579271044;11713.941430292847;10990;11270.549178032888;11354.034907032912;11361.545538178483;11371.658850234486;2343.8242131840093;2379.95240095198;2381.3213234228247;2385.2844146755992;2388.665586817847;2347.730011048726;2393.9162129325478;2460;2464.7165575958816;2465.6917885264343;2363.657269695893;2375.964360534593;2386.2721869829693;2474.2948259745976;2478.7521247875247;2330.07961855068;2377.7622237776172;2383.8569685818907;2386.5465561543338;2405.6992875890514;2309.919152829643;2355.587772139869;2363.0902102690416;2365.3258821235863;2365.7989070928993;11391.430428478625;11555.480003399867;11605.6518304451;11628.825567616492;11640.06879449642;5642.238297829823;5755.568332375046;5767.509761670263;5769.653820770767;5787.045137552299;3495.4931534927546;3505.684488396031;3513.5959364673135;3525.5416795816636;3590.4973303737497;1363.8158848555518;1409.6334952912214;1428.1359777334771;1451.8402975672668;1483.2138966347852;16932.492025239262;17274.481765547054;17303.567410814703;17367.305307787672;17411.042392668398;4390.100029493946;4534.9319760203625;4627.421572303462;4638.0955713636195;4642.53574642533;12889.226646401059;12900.161489503153;12916.741665166644;12947.482100715866;13032.609021729364;5715.8571035724435;5716.742746576331;5719;5748.252727145445;5788.21859049023;5128.589712822965;5160.380754309507;5229.921551176735;5267.420583735786;5270.657407268515;3941.6649584785614;4011.719179657396;4015.5382131054716;4056.492938382702;4085.1216988347646;1046.9319494233002;1049.7900419916048;1061.400308825511;1066.8666416697913;1073.0878753059992;938.333783014054;960.4717405426987;961.1301771896445;964.3056998960737;988.6539711101057;6349.428551430394;6458.321876203025;6504.268207352923;6568.638724870082;6669.399754022162;1035.3632516002604;1051.2746205118444;1064.6752740414247;1083.344576531203;1087.2226358153957;3847.1920896611464;3885.300645883768;3907.648311651965;3930.3711406174875;4004.3993400989502;14314.355853986595;14903.105813651217;14904.25478726081;14910.030847994845;14922.104673719612;12536.623901282976;13671.658208544866;14140.50508232207;14562.927185364217;14682.486112985995;9239.815203696024;10095.7476063099;10361.585536578603;10412.271141020208;10417.895821041844;6657.600543967377;6761.256261811295;6803.319668033157;6818.829529261808;6926.030355750299;13303.135296205715;13307.135036222615;13351.732965340832;13447.125936814076;13650.112742671694;13727.382267797773;13796.655083622589;13839.792403114163;13888.236147011607;14035.438582456996;9306.162445379949;9642.807143856944;9716.514174291398;9745.269104817025;9777.85333219988;10802.189835762192;10824.296420732628;10851;10907;10990.120790336914;9249.30630202751;9301;9331.953340233527;9437.575309111244;9617.278704097082;8943.910560894308;9101.453912765255;9135.40619859707;9262.490563019099;9496.810063798823;7775.766726998199;7874.921250787419;7882.172371900868;7928.008998875141;7931.246531579491;5686.780911213455;5713.114467257582;5774.162746401664;5816.592838501264;5873.236479257669;5619.100943848965;5751;5767.682777447113;5826.067829147316;5850.414958504116 06:49:13 INFO - PROCESS | 10511 | |4;prototype.html;415.35412433665675;417.2302102620664;434.4048653344916;449.9910001799963;455.078466106135;5235.874287028289;5253.527182553569;5255.448177941318;5260.947390526094;5270.920936185956;4993.825216117437;5126.051680439122;5145.202493613487;5153.149730294497;5168.250603662466;4408.4048653431855;4421.911561768763;4425.831342642098;4426.490953540336;4436.844710435135;4401.2517871961845;4415.757133357664;4437.955620443802;4440.911181776362;4443.555844350582;4225.767288024664;4364.738115713051;4373.562643735633;4429.756363400012;4431.734095954237;4338.481531463994;4363.170997510495;4399.120175964804;4400.669949753766;4417.536158703322;4080.8979775505554;4109.931417831385;4111.4171044147915;4123.113530590907;4148.23257697324;4894.4371397289415;5023.572996295283;5053.545180933696;5081.172885758544;5103.157978933508;5036.7733451994745;5038.823641172541;5043.512163911618;5050.565615381539;5055.216441451581;5351.839444816662;5358.544523715489;5442.346918369782;5444.7822087116465;5459.727013649302;4322.373255877911;4527.049319642879;4528.558295695262;4552.339910712961;4556.749378784166;5428;5491.2312276281355;5543.805966791143;5640.210370548127;5671.744771485293;4690.765461726968;4703.694259873166;4705.882352941204;4708.576228139415;4723.102610503994;4579.129965306581;4629.537046295411;4633.675642705046;4763.618910487153;4763.952360476351;5031.333393301556;5046.924296135561;5047.141985862412;5076.517730815566;5098.770555325019;5477.972610136924;5481.451854814487;5483.506484416422;5490.69801160932;5501.779928802803;1579.2182869479682;1620.3599578166793;1634.6158652716601;1656.6106964863247;1658.4941592814066;1240.3054289597853;1269.1750362264602;1273.4396865379204;1282.8588855225917;1285.7656649616472;5316.883454474603;5321.680699158062;5344.118220493575;5347.572194224453;5356.196570514454;5506.944930550643;5513.228148059275;5527.226188333637;5589.636673616202;5600.4959553640365;5105.821296254688;5301.390340110859;5333.839984800462;5350.411454739976;5366.738816378148;2940.5442156465783;2943.204645166447;2946.6758656547763;2948.43979643867;2962.8962986295805;5598.460423383602;5767.279090113736;5772.336181339116;5776.595638305278;5781.53747700183;5670.688112153789;5677.772889084473;5696.51579615729;5699;5711.657300561979;5718.656880587178;5722.828315150386;5723.370429252779;5777.440091175359;5781.739821708034;5322.040575142832;5562.805301814417;5567.2762540871045;5609.4390560943575;5630.380658127521;5325.80169461868;5419.696628932609;5433.9456605435025;5559.888802223852;5562.16567514876;5769;5793.826185214451;5803.622764520462;5854.941450585439;5857.619254748428;4529.8641040768825;4717.561143851159;4719.466173493697;4722.693024953367;4739.905201895874;5543.362513311021;5629.577781666309;5641.435856414326;5665.745041473061;5666.660000399989;5431.538319242909;5458.808941687022;5477.808276710296;5504.201890725903;5528.474794894479;5239.711815850165;5455.690634247672;5459.69971651563;5526.47498487643;5526.972365138148;5428.267183930119;5444.564434845123;5463.453654634504;5473.233747275305;5495.368032676293;5404.54061404785;5464.508194262536;5473.467429119693;5487.478689524489;5496;5119.948800511947;5308.654937429054;5311.814086506954;5329.760160792696;5335.67985920846 06:49:13 INFO - PROCESS | 10511 | |5;yui.html;856.0241324889631;881.2861582118485;899.986500202497;921.9631214751408;931.9748276895411;16649.25078371473;17614.823851761477;17844.464666060037;17975;18713.625727485476;16385.344586216568;16517.83482165178;16829.747553786703;17842.464726058206;18000.72998905014;879.366855863777;886.4326830828292;911.8996910339857;916.4180745226796;916.5554705967601;882.3294296334767;891.0465801592298;891.1801142948503;891.3582220801013;891.4606662968907;971.5627967414656;971.8299297622923;972.6741541583579;973.1776648731845;974.098958463422;948.8149810786899;951.4529145741192;954.856771484276;959.3620242538703;959.9232061435068;705.5131958948309;707.4729326651626;707.508281744188;707.5330282013846;707.9398251148658;17508.387206447715;17638;17797.19912603936;18991.715124273145;19245;16569.91715041417;16721.83278167227;16876.746848797276;16920.238589263514;17359.566010849703;14120.717585648332;14299.356528956221;14427.78358324626;14436;14457;4053.148838743838;4056.574059723716;4084.65280451159;4151.481064866892;4177.49870015597;93185;93767.53116234374;94502.52748736281;96836.51581742046;97220.51389743076;13075.934620326838;13122.803157952638;13123.212607243597;13142.802857957138;13252.337383130998;21254.78745212559;22210.44473888166;23331.18340858062;23454.530909382058;23704.40738981505;9145.314101442418;9252.95373523128;9433.198178154933;9504.144626983605;9761.560729767178;5138.922916156261;5250.3962044364625;5292.44429334922;5319.680819150786;5410.215518749759;3746.587875333711;3888.747231429948;3909.2181563687377;3917.980410097988;3951.7233793634746;664.9002649602598;667.7729571945562;699.2343383994518;719.0472623773521;730.5981710059446;855.9443636163629;868.2822764746304;874.6442125237222;912.5756523216736;912.6577533424966;11830.147602213076;12004;12278.693032674255;12466;12586.81119783204;684.9212340580797;690.6995456976232;692.0588000319561;704.9577025378494;711.6157275071507;5568.972155139199;5671.120976248688;5711.428302662138;5747;5765.308163020381;86665;86901.56549217213;87269;88350;88491;60557;63501.047484287774;69617;77480;78092.21907780963;63896.68051659805;65056.795456363376;65180.67409662921;65411.34588654053;65518;11274.887251127711;11881.04951603887;11934.4032798358;12081.637550873487;12303.630891072924;38899.80550097232;42825.571744282155;44308.77845610751;44320.77839610782;44550.10899782051;53183.73408132935;55034.44965550293;55639.443605565044;55701.49343279643;57698;13162.47350105985;13761.38073786662;13799;13922.51271205503;14060.789088163481;16130.274137664068;16145.112018839076;16180;16199;16291.266892989606;15708.842911571195;16209.189540523163;16327.836721632631;16617.50147495577;16624.75062874082;15260.923695381452;15668.52994410124;15687.215639218222;16326.591835204215;16329.510114696579;15071.849281507482;15219.543413697607;15244.618884527976;16002;16007.67984640324;11530.898039449537;11742.823857642314;11758.58844940423;12095.75808483843;12293.44679489443;12169.39153042362;12579.930705890101;12742.61772146837;12779.23324600527;12914.612561623166 06:49:13 INFO - PROCESS | 10511 | __end_tp_report 06:49:13 INFO - PROCESS | 10511 | __start_cc_report 06:49:13 INFO - PROCESS | 10511 | _x_x_mozilla_cycle_collect,1105 06:49:13 INFO - PROCESS | 10511 | __end_cc_report 06:49:13 INFO - PROCESS | 10511 | __startTimestamp1495115353451__endTimestamp 06:49:13 INFO - PROCESS | 10511 | 06:49:13 INFO - PROCESS | 10511 | ------- Summary: start ------- 06:49:13 INFO - PROCESS | 10511 | Number of tests: 6 06:49:13 INFO - PROCESS | 10511 | 06:49:13 INFO - PROCESS | 10511 | [#0] dojo.html Cycles:165 Average:5630.94 Median:5851.33 stddev:627.85 (10.7%) stddev-sans-first:603.62 06:49:13 INFO - PROCESS | 10511 | Values: 3345.0 3377.5 3386.2 3402.2 3432.6 5621.9 5685.2 5696.3 5698.3 5721.7 5651.8 5679.8 5711.2 5720.1 5721.0 5172.1 5176.2 5196.4 5224.3 5260.4 5068.9 5070.9 5273.6 5284.4 5315.5 5092.4 5108.9 5112.6 5140.1 5145.2 5214.2 5220.7 5224.1 5225.3 5248.2 5018.3 5066.7 5136.6 5188.8 5196.6 5476.8 5524.9 5525.3 5547.1 5569.3 5954.7 6002.7 6007.5 6007.5 6042.1 6057.7 6065.7 6071.7 6072.2 6080.4 5518.2 5565.4 5625.1 5663.1 5687.6 6262.3 6263.6 6268.3 6268.6 6273.2 5956.2 6018.1 6021.2 6033.0 6072.5 5837.3 5869.5 5970.3 6023.3 6100.5 6050.5 6057.9 6077.2 6080.6 6085.9 5828.5 5862.7 5863.1 5867.4 6101.1 4571.9 4614.0 4622.1 4622.4 4626.2 4110.2 4117.4 4118.9 4126.2 4162.3 5831.6 5832.5 5835.4 5838.4 5843.1 5896.4 5938.4 5942.3 5999.6 6095.6 5810.2 5828.0 5846.6 5851.3 5861.2 5144.3 5144.6 5148.9 5151.0 5152.0 6133.2 6165.1 6220.6 6268.9 6283.2 6015.4 6015.4 6028.2 6058.8 6063.1 6282.2 6315.8 6317.6 6317.7 6318.3 5718.1 6010.3 6012.4 6014.2 6014.3 6004.3 6010.1 6052.9 6131.5 6142.1 5933.6 5989.8 5994.4 5996.7 6022.9 5986.3 5986.8 5988.2 5988.9 5990.4 5701.9 5785.4 5835.7 5857.7 5887.4 6031.6 6037.6 6039.6 6040.6 6060.8 5656.4 5676.2 5845.5 5882.4 5882.7 06:49:13 INFO - PROCESS | 10511 | 06:49:13 INFO - PROCESS | 10511 | [#1] ext.html Cycles:180 Average:44125.14 Median:30652.19 stddev:71606.34 (233.6%) stddev-sans-first:71733.26 06:49:13 INFO - PROCESS | 10511 | Values: 782.9 840.9 867.1 915.8 931.6 30803.5 42580.6 43511.3 43663.8 43672.8 38706.4 39097.4 39135.4 42673.6 42834.0 7674.5 8939.2 9077.1 9078.3 9081.8 7524.3 10428.2 10613.2 10614.5 10638.1 10746.2 10764.3 10764.6 10772.3 10772.5 10662.6 10665.5 10669.2 10687.5 10715.9 10640.4 10706.3 10711.7 10716.8 10727.9 42626.8 42694.0 42752.6 42753.0 42775.6 4307.3 4362.0 4370.8 4458.4 4470.6 30671.5 31108.0 31168.8 31206.8 32641.5 4435.1 4471.6 4527.2 4558.1 4575.7 226180.9 229882.0 230012.0 230228.0 230405.0 53638.5 53749.7 53882.5 53895.7 53938.2 56456.7 56493.7 56583.4 56627.2 56659.0 16765.2 16992.8 17019.5 17031.4 17090.6 13103.3 13288.5 14953.7 14955.7 14957.8 12102.2 13257.6 13576.7 13775.4 14130.4 5280.8 5494.7 5553.5 5670.8 5696.8 1012.4 1017.9 1018.9 1030.0 1041.4 28454.4 28549.4 28878.6 28960.7 29143.4 1085.8 1118.6 1121.2 1124.7 1141.6 14439.6 15176.3 15225.5 15359.5 15475.7 301442.0 301723.0 303561.0 303890.0 305018.0 55761.2 55880.0 56023.4 56030.7 56056.0 1489.5 1511.2 1534.0 1563.4 1565.2 27857.9 28346.7 29270.4 29418.0 29571.4 37381.3 37496.1 37519.4 37571.8 37657.8 285218.0 285611.0 286483.0 286803.0 287072.0 25394.2 25959.9 30059.2 31134.2 33122.2 34105.7 37082.3 40833.4 44357.8 45107.3 31767.8 31869.0 31923.2 32072.0 32571.0 30998.7 31307.2 31486.8 31608.0 31816.0 35269.3 35333.6 35472.5 35522.0 35531.1 29547.1 29919.4 30349.5 30632.8 30844.8 23651.8 24713.3 24722.5 25017.0 25045.6 06:49:13 INFO - PROCESS | 10511 | 06:49:13 INFO - PROCESS | 10511 | [#2] jquery.html Cycles:180 Average:39544.13 Median:22425.00 stddev:118697.18 (529.3%) stddev-sans-first:118993.87 06:49:13 INFO - PROCESS | 10511 | Values: 455.9 467.6 472.0 475.6 480.2 19963.8 19964.2 21623.2 21806.0 21810.9 21720.3 22363.2 22402.6 22447.4 22461.6 6762.2 6911.0 6922.2 6995.1 6997.5 6559.3 6769.7 6776.1 6779.3 6788.1 6647.5 6675.1 6797.6 6830.3 6836.3 6522.7 6708.2 6766.5 6818.7 6820.5 6605.4 6607.7 6609.8 6610.9 6615.2 24864.3 25558.2 25731.0 25983.9 25998.4 3429.9 3513.3 3569.4 3634.8 3649.5 15745.8 16085.7 16119.0 16186.1 16314.1 2026.9 2063.8 2066.7 2076.9 2110.1 117898.0 121145.4 121495.4 122361.0 124314.0 18124.5 18745.5 18801.4 18804.5 18888.3 31326.5 31346.0 31376.7 31377.0 31588.0 10708.3 10855.7 10889.1 10893.7 11241.2 9209.4 9280.3 9314.8 9523.1 9543.6 8909.2 9064.0 9371.2 9404.3 9488.2 3083.1 3774.8 3896.0 3959.2 3996.5 970.7 974.8 979.7 982.7 990.4 20871.3 20908.4 20911.4 20925.3 20928.7 987.0 987.7 988.6 999.4 1001.6 10910.6 11494.3 11583.2 11652.6 11752.7 697183.0 710810.0 728264.0 730246.0 742194.0 88298.6 96262.5 112144.0 114924.0 115148.4 1232.1 1248.7 1250.7 1270.9 1287.6 17818.7 18186.5 18385.0 18446.5 18711.3 49522.0 51186.2 51514.5 51589.7 52318.5 70206.0 70780.0 71034.2 71792.0 73336.3 12464.7 12637.0 12813.3 12907.3 12951.7 14696.6 14722.4 14852.9 15078.6 15330.5 9788.5 12706.4 12730.1 12778.1 12938.6 12110.1 12297.2 12393.6 12458.6 12497.3 12562.9 12719.9 12844.5 13086.1 13153.9 12458.8 12534.8 12596.6 12712.2 12934.6 11787.9 12294.3 12592.0 12659.8 13084.5 06:49:13 INFO - PROCESS | 10511 | 06:49:13 INFO - PROCESS | 10511 | [#3] mootools.html Cycles:180 Average:7034.58 Median:2387.61 stddev:4608.81 (193.0%) stddev-sans-first:4603.51 06:49:13 INFO - PROCESS | 10511 | Values: 1578.5 1593.5 1596.4 1611.6 1623.8 10891.7 11685.2 11707.4 11708.4 11713.9 10990.0 11270.5 11354.0 11361.5 11371.7 2343.8 2380.0 2381.3 2385.3 2388.7 2347.7 2393.9 2460.0 2464.7 2465.7 2363.7 2376.0 2386.3 2474.3 2478.8 2330.1 2377.8 2383.9 2386.5 2405.7 2309.9 2355.6 2363.1 2365.3 2365.8 11391.4 11555.5 11605.7 11628.8 11640.1 5642.2 5755.6 5767.5 5769.7 5787.0 3495.5 3505.7 3513.6 3525.5 3590.5 1363.8 1409.6 1428.1 1451.8 1483.2 16932.5 17274.5 17303.6 17367.3 17411.0 4390.1 4534.9 4627.4 4638.1 4642.5 12889.2 12900.2 12916.7 12947.5 13032.6 5715.9 5716.7 5719.0 5748.3 5788.2 5128.6 5160.4 5229.9 5267.4 5270.7 3941.7 4011.7 4015.5 4056.5 4085.1 1046.9 1049.8 1061.4 1066.9 1073.1 938.3 960.5 961.1 964.3 988.7 6349.4 6458.3 6504.3 6568.6 6669.4 1035.4 1051.3 1064.7 1083.3 1087.2 3847.2 3885.3 3907.6 3930.4 4004.4 14314.4 14903.1 14904.3 14910.0 14922.1 12536.6 13671.7 14140.5 14562.9 14682.5 9239.8 10095.7 10361.6 10412.3 10417.9 6657.6 6761.3 6803.3 6818.8 6926.0 13303.1 13307.1 13351.7 13447.1 13650.1 13727.4 13796.7 13839.8 13888.2 14035.4 9306.2 9642.8 9716.5 9745.3 9777.9 10802.2 10824.3 10851.0 10907.0 10990.1 9249.3 9301.0 9332.0 9437.6 9617.3 8943.9 9101.5 9135.4 9262.5 9496.8 7775.8 7874.9 7882.2 7928.0 7931.2 5686.8 5713.1 5774.2 5816.6 5873.2 5619.1 5751.0 5767.7 5826.1 5850.4 06:49:13 INFO - PROCESS | 10511 | 06:49:13 INFO - PROCESS | 10511 | [#4] prototype.html Cycles:180 Average:4762.48 Median:5258.20 stddev:1256.78 (23.9%) stddev-sans-first:1217.21 06:49:13 INFO - PROCESS | 10511 | Values: 415.4 417.2 434.4 450.0 455.1 5235.9 5253.5 5255.4 5260.9 5270.9 4993.8 5126.1 5145.2 5153.1 5168.3 4408.4 4421.9 4425.8 4426.5 4436.8 4401.3 4415.8 4438.0 4440.9 4443.6 4225.8 4364.7 4373.6 4429.8 4431.7 4338.5 4363.2 4399.1 4400.7 4417.5 4080.9 4109.9 4111.4 4123.1 4148.2 4894.4 5023.6 5053.5 5081.2 5103.2 5036.8 5038.8 5043.5 5050.6 5055.2 5351.8 5358.5 5442.3 5444.8 5459.7 4322.4 4527.0 4528.6 4552.3 4556.7 5428.0 5491.2 5543.8 5640.2 5671.7 4690.8 4703.7 4705.9 4708.6 4723.1 4579.1 4629.5 4633.7 4763.6 4764.0 5031.3 5046.9 5047.1 5076.5 5098.8 5478.0 5481.5 5483.5 5490.7 5501.8 1579.2 1620.4 1634.6 1656.6 1658.5 1240.3 1269.2 1273.4 1282.9 1285.8 5316.9 5321.7 5344.1 5347.6 5356.2 5506.9 5513.2 5527.2 5589.6 5600.5 5105.8 5301.4 5333.8 5350.4 5366.7 2940.5 2943.2 2946.7 2948.4 2962.9 5598.5 5767.3 5772.3 5776.6 5781.5 5670.7 5677.8 5696.5 5699.0 5711.7 5718.7 5722.8 5723.4 5777.4 5781.7 5322.0 5562.8 5567.3 5609.4 5630.4 5325.8 5419.7 5433.9 5559.9 5562.2 5769.0 5793.8 5803.6 5854.9 5857.6 4529.9 4717.6 4719.5 4722.7 4739.9 5543.4 5629.6 5641.4 5665.7 5666.7 5431.5 5458.8 5477.8 5504.2 5528.5 5239.7 5455.7 5459.7 5526.5 5527.0 5428.3 5444.6 5463.5 5473.2 5495.4 5404.5 5464.5 5473.5 5487.5 5496.0 5119.9 5308.7 5311.8 5329.8 5335.7 06:49:13 INFO - PROCESS | 10511 | 06:49:13 INFO - PROCESS | 10511 | [#5] yui.html Cycles:180 Average:19401.15 Median:23501.54 stddev:24426.63 (103.9%) stddev-sans-first:24455.46 06:49:13 INFO - PROCESS | 10511 | Values: 856.0 881.3 900.0 922.0 932.0 16649.3 17614.8 17844.5 17975.0 18713.6 16385.3 16517.8 16829.7 17842.5 18000.7 879.4 886.4 911.9 916.4 916.6 882.3 891.0 891.2 891.4 891.5 971.6 971.8 972.7 973.2 974.1 948.8 951.5 954.9 959.4 959.9 705.5 707.5 707.5 707.5 707.9 17508.4 17638.0 17797.2 18991.7 19245.0 16569.9 16721.8 16876.7 16920.2 17359.6 14120.7 14299.4 14427.8 14436.0 14457.0 4053.1 4056.6 4084.7 4151.5 4177.5 93185.0 93767.5 94502.5 96836.5 97220.5 13075.9 13122.8 13123.2 13142.8 13252.3 21254.8 22210.4 23331.2 23454.5 23704.4 9145.3 9253.0 9433.2 9504.1 9761.6 5138.9 5250.4 5292.4 5319.7 5410.2 3746.6 3888.7 3909.2 3918.0 3951.7 664.9 667.8 699.2 719.0 730.6 855.9 868.3 874.6 912.6 912.7 11830.1 12004.0 12278.7 12466.0 12586.8 684.9 690.7 692.1 705.0 711.6 5569.0 5671.1 5711.4 5747.0 5765.3 86665.0 86901.6 87269.0 88350.0 88491.0 60557.0 63501.0 69617.0 77480.0 78092.2 63896.7 65056.8 65180.7 65411.3 65518.0 11274.9 11881.0 11934.4 12081.6 12303.6 38899.8 42825.6 44308.8 44320.8 44550.1 53183.7 55034.4 55639.4 55701.5 57698.0 13162.5 13761.4 13799.0 13922.5 14060.8 16130.3 16145.1 16180.0 16199.0 16291.3 15708.8 16209.2 16327.8 16617.5 16624.8 15260.9 15668.5 15687.2 16326.6 16329.5 15071.8 15219.5 15244.6 16002.0 16007.7 11530.9 11742.8 11758.6 12095.8 12293.4 12169.4 12579.9 12742.6 12779.2 12914.6 06:49:13 INFO - PROCESS | 10511 | -------- Summary: end -------- 06:49:13 INFO - PROCESS | 10511 | 06:49:14 INFO - TEST-INFO | 10511: exit 0 06:49:14 INFO - TEST-OK | dromaeo_css | took 1115308ms 06:49:14 INFO - TEST-START | kraken 06:49:14 INFO - operating with platform_type : linux_ 06:49:14 INFO - Initialising browser for kraken test... 06:49:14 INFO - TEST-INFO | started process 10812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Er2oV/profile http://localhost:43674/getInfo.html) 06:49:18 INFO - PROCESS | 10812 | __metrics Screen width/height:1600/1200 06:49:18 INFO - PROCESS | 10812 | colorDepth:24 06:49:18 INFO - PROCESS | 10812 | Browser inner width/height: 1024/697 06:49:18 INFO - PROCESS | 10812 | __metrics 06:49:19 INFO - PROCESS | 10812 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:49:19 INFO - PROCESS | 10812 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:49:20 INFO - TEST-INFO | 10812: exit 0 06:49:20 INFO - Browser initialized. 06:49:20 INFO - Running cycle 1/1 for kraken test... 06:49:20 INFO - TEST-INFO | started process 10905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Er2oV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:31 INFO - PROCESS | 10905 | RSS: Main: 141787136 06:49:31 INFO - PROCESS | 10905 | 06:49:34 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43674/tests/kraken/driver.html?testName=audio-beat-detection) 06:49:35 INFO - PROCESS | 10905 | RSS: Main: 183603200 06:49:35 INFO - PROCESS | 10905 | 06:49:37 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43674/tests/kraken/driver.html?testName=audio-dft) 06:49:38 INFO - PROCESS | 10905 | RSS: Main: 173445120 06:49:38 INFO - PROCESS | 10905 | 06:49:41 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43674/tests/kraken/driver.html?testName=audio-fft) 06:49:41 INFO - PROCESS | 10905 | RSS: Main: 264953856 06:49:41 INFO - PROCESS | 10905 | 06:49:43 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43674/tests/kraken/driver.html?testName=audio-oscillator) 06:49:44 INFO - PROCESS | 10905 | RSS: Main: 171282432 06:49:44 INFO - PROCESS | 10905 | 06:49:46 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43674/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:49:47 INFO - PROCESS | 10905 | RSS: Main: 174092288 06:49:47 INFO - PROCESS | 10905 | 06:49:50 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43674/tests/kraken/driver.html?testName=imaging-darkroom) 06:49:50 INFO - PROCESS | 10905 | RSS: Main: 212578304 06:49:50 INFO - PROCESS | 10905 | 06:49:53 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43674/tests/kraken/driver.html?testName=imaging-desaturate) 06:49:54 INFO - PROCESS | 10905 | RSS: Main: 212393984 06:49:54 INFO - PROCESS | 10905 | 06:49:57 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43674/tests/kraken/driver.html?testName=json-parse-financial) 06:49:57 INFO - PROCESS | 10905 | RSS: Main: 211390464 06:49:57 INFO - PROCESS | 10905 | 06:49:59 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43674/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:50:00 INFO - PROCESS | 10905 | RSS: Main: 173641728 06:50:00 INFO - PROCESS | 10905 | 06:50:01 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43674/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:50:02 INFO - PROCESS | 10905 | RSS: Main: 180043776 06:50:02 INFO - PROCESS | 10905 | 06:50:04 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43674/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:50:05 INFO - PROCESS | 10905 | RSS: Main: 184864768 06:50:05 INFO - PROCESS | 10905 | 06:50:07 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:50:08 INFO - PROCESS | 10905 | RSS: Main: 180670464 06:50:08 INFO - PROCESS | 10905 | 06:50:10 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:50:11 INFO - PROCESS | 10905 | RSS: Main: 184549376 06:50:11 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | Cycle 1(1): loaded http://localhost:43674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43674/tests/kraken/driver.html?testName=ai-astar) 06:50:13 INFO - PROCESS | 10905 | RSS: Main: 238817280 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | __start_tp_report 06:50:13 INFO - PROCESS | 10905 | _x_x_mozilla_page_load 06:50:13 INFO - PROCESS | 10905 | _x_x_mozilla_page_load_details 06:50:13 INFO - PROCESS | 10905 | |i|pagename|runs| 06:50:13 INFO - PROCESS | 10905 | |0;ai-astar;102;112;111;111;111;112;112;112;112;111 06:50:13 INFO - PROCESS | 10905 | |1;audio-beat-detection;147;114;115;143;115;115;119;115;141;114 06:50:13 INFO - PROCESS | 10905 | |2;audio-dft;160;162;160;161;161;162;161;161;161;161 06:50:13 INFO - PROCESS | 10905 | |3;audio-fft;75;74;76;114;76;75;75;75;91;75 06:50:13 INFO - PROCESS | 10905 | |4;audio-oscillator;82;82;103;82;83;82;103;82;82;95 06:50:13 INFO - PROCESS | 10905 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;113;113;114 06:50:13 INFO - PROCESS | 10905 | |6;imaging-darkroom;146;145;145;146;147;146;147;146;146;146 06:50:13 INFO - PROCESS | 10905 | |7;imaging-desaturate;94;94;95;93;94;93;94;93;94;93 06:50:13 INFO - PROCESS | 10905 | |8;json-parse-financial;55;57;55;55;56;55;55;56;59;54 06:50:13 INFO - PROCESS | 10905 | |9;json-stringify-tinderbox;53;53;53;52;53;53;56;54;61;53 06:50:13 INFO - PROCESS | 10905 | |10;stanford-crypto-aes;76;79;83;82;79;75;80;79;79;101 06:50:13 INFO - PROCESS | 10905 | |11;stanford-crypto-ccm;129;123;121;128;121;121;118;137;118;133 06:50:13 INFO - PROCESS | 10905 | |12;stanford-crypto-pbkdf2;160;162;158;162;160;162;161;160;162;158 06:50:13 INFO - PROCESS | 10905 | |13;stanford-crypto-sha256-iterative;60;61;59;59;59;60;60;58;59;58 06:50:13 INFO - PROCESS | 10905 | __end_tp_report 06:50:13 INFO - PROCESS | 10905 | __start_cc_report 06:50:13 INFO - PROCESS | 10905 | _x_x_mozilla_cycle_collect,1653 06:50:13 INFO - PROCESS | 10905 | __end_cc_report 06:50:13 INFO - PROCESS | 10905 | __startTimestamp1495115413332__endTimestamp 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | ------- Summary: start ------- 06:50:13 INFO - PROCESS | 10905 | Number of tests: 14 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.06 (2.7%) stddev-sans-first:0.53 06:50:13 INFO - PROCESS | 10905 | Values: 102.0 112.0 111.0 111.0 111.0 112.0 112.0 112.0 112.0 111.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:117.00 stddev:13.85 (11.8%) stddev-sans-first:11.88 06:50:13 INFO - PROCESS | 10905 | Values: 147.0 114.0 115.0 143.0 115.0 115.0 119.0 115.0 141.0 114.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 06:50:13 INFO - PROCESS | 10905 | Values: 160.0 162.0 160.0 161.0 161.0 162.0 161.0 161.0 161.0 161.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.76 (17.0%) stddev-sans-first:13.38 06:50:13 INFO - PROCESS | 10905 | Values: 75.0 74.0 76.0 114.0 76.0 75.0 75.0 75.0 91.0 75.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:82.00 stddev:9.06 (11.0%) stddev-sans-first:9.38 06:50:13 INFO - PROCESS | 10905 | Values: 82.0 82.0 103.0 82.0 83.0 82.0 103.0 82.0 82.0 95.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:50:13 INFO - PROCESS | 10905 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:50:13 INFO - PROCESS | 10905 | Values: 146.0 145.0 145.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:50:13 INFO - PROCESS | 10905 | Values: 94.0 94.0 95.0 93.0 94.0 93.0 94.0 93.0 94.0 93.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:1.42 (2.6%) stddev-sans-first:1.48 06:50:13 INFO - PROCESS | 10905 | Values: 55.0 57.0 55.0 55.0 56.0 55.0 55.0 56.0 59.0 54.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:53.00 stddev:2.64 (5.0%) stddev-sans-first:2.77 06:50:13 INFO - PROCESS | 10905 | Values: 53.0 53.0 53.0 52.0 53.0 53.0 56.0 54.0 61.0 53.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:79.00 stddev:7.32 (9.3%) stddev-sans-first:7.51 06:50:13 INFO - PROCESS | 10905 | Values: 76.0 79.0 83.0 82.0 79.0 75.0 80.0 79.0 79.0 101.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:125.50 stddev:6.52 (5.2%) stddev-sans-first:6.75 06:50:13 INFO - PROCESS | 10905 | Values: 129.0 123.0 121.0 128.0 121.0 121.0 118.0 137.0 118.0 133.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.50 stddev:1.58 (1.0%) stddev-sans-first:1.67 06:50:13 INFO - PROCESS | 10905 | Values: 160.0 162.0 158.0 162.0 160.0 162.0 161.0 160.0 162.0 158.0 06:50:13 INFO - PROCESS | 10905 | 06:50:13 INFO - PROCESS | 10905 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.30 Median:59.50 stddev:0.95 (1.6%) stddev-sans-first:0.97 06:50:13 INFO - PROCESS | 10905 | Values: 60.0 61.0 59.0 59.0 59.0 60.0 60.0 58.0 59.0 58.0 06:50:13 INFO - PROCESS | 10905 | -------- Summary: end -------- 06:50:13 INFO - PROCESS | 10905 | 06:50:14 INFO - TEST-INFO | 10905: exit 0 06:50:14 INFO - TEST-OK | kraken | took 60176ms 06:50:14 INFO - SUITE-END | took 1175s 06:50:14 INFO - Completed test suite (00:19:35) 06:50:14 INFO - javascript benchmark 06:50:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7832.356707014313, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3344.966550334497, 3377.5271461995326, 3386.1703882548777, 3402.183475965769, 3432.622411534731, 5621.859453513664, 5685.175649530821, 5696.287964004494, 5698.316202055759, 5721.742521586528, 5651.8304450866435, 5679.801206957757, 5711.171880077386, 5720.056190728525, 5721.027425337692, 5172.069027575044, 5176.171812509999, 5196.376434827807, 5224.346956630421, 5260.421353651095, 5068.923966140511, 5070.949290507103, 5273.578113750891, 5284.445133260991, 5315.548178404841, 5092.439831618519, 5108.8978220435565, 5112.590992720573, 5140.074786538422, 5145.202493613478, 5214.217867319894, 5220.738963051832, 5224.111900976805, 5225.294585231021, 5248.186531087687, 5018.347614810052, 5066.695998240118, 5136.614753893436, 5188.792448302063, 5196.558292545138, 5476.7535460904355, 5524.889502209933, 5525.309336332958, 5547.057000309957, 5569.275994120779, 5954.672493012882, 6002.669853158074, 6007.459328660398, 6007.549433792439, 6042.1238920356745, 6057.727402266909, 6065.727042283108, 6071.666058366788, 6072.180255665517, 6080.391960803929, 5518.227448157261, 5565.387807341189, 5625.071863142617, 5663.093904975267, 5687.630304030225, 6262.342454042351, 6263.561550691408, 6268.310485846553, 6268.623882567061, 6273.247210334789, 5956.195913551702, 6018.127371531104, 6021.157038014681, 6033.034714445667, 6072.51419886408, 5837.29952405714, 5869.5010924071075, 5970.283565972024, 6023.307319658208, 6100.48145907594, 6050.45545900871, 6057.878842423127, 6077.24034495688, 6080.604760690541, 6085.878282434326, 5828.475437210672, 5862.70686465675, 5863.091220860773, 5867.383924687846, 6101.084837274356, 4571.862844114682, 4613.953860461353, 4622.075584883037, 4622.422197225347, 4626.21354369758, 4110.157417729359, 4117.3618089196225, 4118.876433706993, 4126.195391898551, 4162.271602469556, 5831.620944638585, 5832.475077242983, 5835.35811060783, 5838.4453476919625, 5843.094320380263, 5896.439838215363, 5938.376470470625, 5942.346341902387, 5999.550033747487, 6095.573309868355, 5810.157527158538, 5827.970860145672, 5846.561507886926, 5851.32709738377, 5861.17943487912, 5144.331236939174, 5144.562712169432, 5148.897022059613, 5150.974245128826, 5151.97424012885, 6133.233345831771, 6165.136880836597, 6220.595661282093, 6268.874622507525, 6283.214598175228, 6015.428534289235, 6015.428534289235, 6028.216331876828, 6058.818235452944, 6063.060225665029, 6282.2147231596055, 6315.778947736991, 6317.5893566918, 6317.747290108344, 6318.304986451579, 5718.1136923776885, 6010.278766548042, 6012.368701286302, 6014.248218972629, 6014.308354539284, 6004.279486461653, 6010.068439391901, 6052.878942421039, 6131.468419844818, 6142.109394137736, 5933.554983376351, 5989.8203053908455, 5994.400559943971, 5996.67018313997, 6022.909656355246, 5986.2517185351835, 5986.760529578768, 5988.161657367885, 5988.880222395441, 5990.400959903975, 5701.885962280814, 5785.363610002981, 5835.737391817293, 5857.677827719516, 5887.411258874078, 6031.638101713911, 6037.63774173551, 6039.607425517327, 6040.577159598786, 6060.818175454743, 5656.377798442086, 5676.17695434168, 5845.503132233808, 5882.382349853204, 5882.705864706833], "value": 5589.873417951674, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.9177936316687, 840.9495430274184, 867.132867132867, 915.78021274894, 931.6226928094115, 30803.537946930785, 42580.57419425805, 43511.34732979004, 43663.78168109155, 43672.78163609178, 38706.41940370897, 39097.41353879694, 39135.41296880549, 42673.57326426735, 42834.0, 7674.5395276283325, 8939.240164586, 9077.137671921157, 9078.273738100936, 9081.772955676095, 7524.322810947014, 10428.16574674028, 10613.150947924187, 10614.469276536181, 10638.095761860213, 10746.194035447334, 10764.300320479182, 10764.623238186665, 10772.299800512941, 10772.515236814323, 10662.573497060108, 10665.466726663635, 10669.199810014241, 10687.519061642206, 10715.946420267888, 10640.414777187252, 10706.250562460631, 10711.678649640524, 10716.785664286748, 10727.892721072767, 42626.78686606547, 42694.0, 42752.57247427517, 42753.0, 42775.57224427747, 4307.289297265947, 4361.978190109061, 4370.759608221547, 4458.4426946631675, 4470.575295346936, 30671.539926900892, 31108.0, 31168.8441557793, 31206.83378795507, 32641.51037734436, 4435.135148646015, 4471.6199123074575, 4527.185106680796, 4558.088382323548, 4575.6568257380495, 226180.8690956551, 229882.0, 230012.0, 230228.0, 230405.0, 53638.46361536335, 53749.731251343495, 53882.46117538775, 53895.73052134714, 53938.19092713612, 56456.717716411156, 56493.71753141208, 56583.43416565864, 56627.15059274114, 56659.0, 16765.24556394965, 16992.830071699373, 17019.48941531756, 17031.40390086341, 17090.57273568146, 13103.279319637511, 13288.468461261442, 14953.700925981419, 14955.700885982436, 14957.775633365509, 12102.213356131822, 13257.602271931857, 13576.728465430637, 13775.38010789517, 14130.364133614012, 5280.841574752763, 5494.670319780826, 5553.527950124285, 5670.773169073191, 5696.829095127153, 1012.3773879064322, 1017.8778546574458, 1018.8675472188568, 1029.9794004120026, 1041.354360296621, 28454.430911381656, 28549.429011419656, 28878.566821497694, 28960.710392896224, 29143.417131657672, 1085.8154113800515, 1118.6196693124214, 1121.2095472691897, 1124.6794663520857, 1141.594733869481, 14439.639009024859, 15176.317065732068, 15225.467108651366, 15359.53921382338, 15475.690486190213, 301442.0, 301723.0, 303561.0, 303890.0, 305018.0, 55761.163582546294, 55880.0, 56023.439765602634, 56030.719846400505, 56056.0, 1489.5382431446287, 1511.2217208137818, 1533.9923300383202, 1563.4059057558054, 1565.1548163991317, 27857.8856845732, 28346.71653283441, 29270.41459170847, 29418.0, 29571.40857182801, 37381.25237495289, 37496.06259843526, 37519.43720844135, 37571.812140940216, 37657.81171094237, 285218.0, 285611.0, 286483.0, 286803.0, 287072.0, 25394.238172854843, 25959.87020064963, 30059.24851878633, 31134.22164445907, 33122.17194570155, 34105.65894341025, 37082.258354832215, 40833.37496877342, 44357.778211108736, 45107.32339014983, 31767.841160794047, 31869.0, 31923.201919952186, 32072.0, 32571.0, 30998.690013100484, 31307.217319567193, 31486.842565787025, 31608.0, 31816.045518633553, 35269.29461410809, 35333.646663533036, 35472.46791298184, 35522.0, 35531.111722207155, 29547.113586592437, 29919.401611967205, 30349.544756828225, 30632.84683576568, 30844.845775770977, 23651.763482364957, 24713.25860224196, 24722.50554988926, 25017.0, 25045.624315634916], "value": 18729.596774959413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.8541266794623, 467.5883043484722, 471.9764011799409, 475.6313856761012, 480.2100544604126, 19963.800361996393, 19964.201431942703, 21623.243186488475, 21806.0, 21810.89094554525, 21720.3483895483, 22363.217287394946, 22402.551948961012, 22447.438814029658, 22461.550768984653, 6762.22234443038, 6910.965445172767, 6922.169339679245, 6995.125609298838, 6997.545159564612, 6559.3112723164095, 6769.729210831585, 6776.119104516406, 6779.288174741655, 6788.11754471918, 6647.468202543809, 6675.132232809752, 6797.626130562817, 6830.282820303871, 6836.316368363174, 6522.7390904363765, 6708.228553716336, 6766.458683305324, 6818.693158807866, 6820.522563420563, 6605.372489613479, 6607.669616519155, 6609.834754131185, 6610.933890661128, 6615.239247486505, 24864.25407237786, 25558.23325300244, 25731.0, 25983.870080649664, 25998.35004124893, 3429.879954201591, 3513.3149035938004, 3569.428891377393, 3634.7819130851967, 3649.543807024122, 15745.842541574551, 16085.678286434206, 16118.952268102654, 16186.109763962977, 16314.102724350156, 2026.9189232430685, 2063.7523497180287, 2066.73132492775, 2076.8753874767413, 2110.1453911166004, 117898.0, 121145.39427302896, 121495.39252303682, 122361.0, 124314.0, 18124.546886327684, 18745.531361716065, 18801.435956921316, 18804.529886752665, 18888.33890813815, 31326.530102048488, 31346.0, 31376.686233137832, 31377.0, 31588.0, 10708.30396024256, 10855.67432977012, 10889.128869690407, 10893.673189804318, 11241.15691323154, 9209.447433153899, 9280.346050149688, 9314.767130821783, 9523.142917137491, 9543.570539325608, 8909.198172164537, 9064.0, 9371.156595906401, 9404.294677899048, 9488.193503552275, 3083.057673665576, 3774.848671155324, 3895.9870433687447, 3959.1883663848844, 3996.480457540559, 970.6990832841842, 974.780674348266, 979.6816034788579, 982.6708052802248, 990.3612170150212, 20871.269505567234, 20908.37274881756, 20911.37265882026, 20925.26761563338, 20928.686069708965, 986.9851952220722, 987.6543209876629, 988.6193815380987, 999.4303247149201, 1001.6444162322416, 10910.61812836547, 11494.252873563191, 11583.247088939192, 11652.592159274385, 11752.70618234551, 697183.0, 710810.0, 728264.0, 730246.0, 742194.0, 88298.55850720833, 96262.51868740752, 112144.0, 114924.0, 115148.42425787817, 1232.0820988363726, 1248.6628610275357, 1250.7060840702427, 1270.879266469684, 1287.620152055146, 17818.732719008967, 18186.545336366697, 18385.0, 18446.538836529195, 18711.25154993785, 49522.0, 51186.23220651768, 51514.48485515097, 51589.742051289504, 52318.47681523288, 70206.0, 70780.0, 71034.22414439681, 71792.0, 73336.26663733508, 12464.688382790502, 12637.0, 12813.295268760308, 12907.290099044267, 12951.740965180456, 14696.55910322692, 14722.411103556165, 14852.925735371686, 15078.623034424227, 15330.540083797503, 9788.510574471105, 12706.428210730724, 12730.108892377444, 12778.105532612628, 12938.611841644766, 12110.091743119125, 12297.200681955645, 12393.62819115428, 12458.626241212778, 12497.25016499013, 12562.93718531438, 12719.87280127187, 12844.486220551073, 13086.14940028895, 13153.934230328787, 12458.75082498363, 12534.811977820158, 12596.55912043074, 12712.237265764084, 12934.611961641165, 11787.941060294643, 12294.262344259372, 12592.0, 12659.81010284828, 13084.542041028519], "value": 11596.699104265574, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1578.5106616948754, 1593.4741535293347, 1596.3853916242247, 1611.580988942875, 1623.8294979027194, 10891.727706807324, 11685.182037257395, 11707.356095414749, 11708.414579271044, 11713.941430292847, 10990.0, 11270.549178032888, 11354.034907032912, 11361.545538178483, 11371.658850234486, 2343.8242131840093, 2379.95240095198, 2381.3213234228247, 2385.2844146755992, 2388.665586817847, 2347.730011048726, 2393.9162129325478, 2460.0, 2464.7165575958816, 2465.6917885264343, 2363.657269695893, 2375.964360534593, 2386.2721869829693, 2474.2948259745976, 2478.7521247875247, 2330.07961855068, 2377.7622237776172, 2383.8569685818907, 2386.5465561543338, 2405.6992875890514, 2309.919152829643, 2355.587772139869, 2363.0902102690416, 2365.3258821235863, 2365.7989070928993, 11391.430428478625, 11555.480003399867, 11605.6518304451, 11628.825567616492, 11640.06879449642, 5642.238297829823, 5755.568332375046, 5767.509761670263, 5769.653820770767, 5787.045137552299, 3495.4931534927546, 3505.684488396031, 3513.5959364673135, 3525.5416795816636, 3590.4973303737497, 1363.8158848555518, 1409.6334952912214, 1428.1359777334771, 1451.8402975672668, 1483.2138966347852, 16932.492025239262, 17274.481765547054, 17303.567410814703, 17367.305307787672, 17411.042392668398, 4390.100029493946, 4534.9319760203625, 4627.421572303462, 4638.0955713636195, 4642.53574642533, 12889.226646401059, 12900.161489503153, 12916.741665166644, 12947.482100715866, 13032.609021729364, 5715.8571035724435, 5716.742746576331, 5719.0, 5748.252727145445, 5788.21859049023, 5128.589712822965, 5160.380754309507, 5229.921551176735, 5267.420583735786, 5270.657407268515, 3941.6649584785614, 4011.719179657396, 4015.5382131054716, 4056.492938382702, 4085.1216988347646, 1046.9319494233002, 1049.7900419916048, 1061.400308825511, 1066.8666416697913, 1073.0878753059992, 938.333783014054, 960.4717405426987, 961.1301771896445, 964.3056998960737, 988.6539711101057, 6349.428551430394, 6458.321876203025, 6504.268207352923, 6568.638724870082, 6669.399754022162, 1035.3632516002604, 1051.2746205118444, 1064.6752740414247, 1083.344576531203, 1087.2226358153957, 3847.1920896611464, 3885.300645883768, 3907.648311651965, 3930.3711406174875, 4004.3993400989502, 14314.355853986595, 14903.105813651217, 14904.25478726081, 14910.030847994845, 14922.104673719612, 12536.623901282976, 13671.658208544866, 14140.50508232207, 14562.927185364217, 14682.486112985995, 9239.815203696024, 10095.7476063099, 10361.585536578603, 10412.271141020208, 10417.895821041844, 6657.600543967377, 6761.256261811295, 6803.319668033157, 6818.829529261808, 6926.030355750299, 13303.135296205715, 13307.135036222615, 13351.732965340832, 13447.125936814076, 13650.112742671694, 13727.382267797773, 13796.655083622589, 13839.792403114163, 13888.236147011607, 14035.438582456996, 9306.162445379949, 9642.807143856944, 9716.514174291398, 9745.269104817025, 9777.85333219988, 10802.189835762192, 10824.296420732628, 10851.0, 10907.0, 10990.120790336914, 9249.30630202751, 9301.0, 9331.953340233527, 9437.575309111244, 9617.278704097082, 8943.910560894308, 9101.453912765255, 9135.40619859707, 9262.490563019099, 9496.810063798823, 7775.766726998199, 7874.921250787419, 7882.172371900868, 7928.008998875141, 7931.246531579491, 5686.780911213455, 5713.114467257582, 5774.162746401664, 5816.592838501264, 5873.236479257669, 5619.100943848965, 5751.0, 5767.682777447113, 5826.067829147316, 5850.414958504116], "value": 5295.2286016152875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.35412433665675, 417.2302102620664, 434.4048653344916, 449.9910001799963, 455.078466106135, 5235.874287028289, 5253.527182553569, 5255.448177941318, 5260.947390526094, 5270.920936185956, 4993.825216117437, 5126.051680439122, 5145.202493613487, 5153.149730294497, 5168.250603662466, 4408.4048653431855, 4421.911561768763, 4425.831342642098, 4426.490953540336, 4436.844710435135, 4401.2517871961845, 4415.757133357664, 4437.955620443802, 4440.911181776362, 4443.555844350582, 4225.767288024664, 4364.738115713051, 4373.562643735633, 4429.756363400012, 4431.734095954237, 4338.481531463994, 4363.170997510495, 4399.120175964804, 4400.669949753766, 4417.536158703322, 4080.8979775505554, 4109.931417831385, 4111.4171044147915, 4123.113530590907, 4148.23257697324, 4894.4371397289415, 5023.572996295283, 5053.545180933696, 5081.172885758544, 5103.157978933508, 5036.7733451994745, 5038.823641172541, 5043.512163911618, 5050.565615381539, 5055.216441451581, 5351.839444816662, 5358.544523715489, 5442.346918369782, 5444.7822087116465, 5459.727013649302, 4322.373255877911, 4527.049319642879, 4528.558295695262, 4552.339910712961, 4556.749378784166, 5428.0, 5491.2312276281355, 5543.805966791143, 5640.210370548127, 5671.744771485293, 4690.765461726968, 4703.694259873166, 4705.882352941204, 4708.576228139415, 4723.102610503994, 4579.129965306581, 4629.537046295411, 4633.675642705046, 4763.618910487153, 4763.952360476351, 5031.333393301556, 5046.924296135561, 5047.141985862412, 5076.517730815566, 5098.770555325019, 5477.972610136924, 5481.451854814487, 5483.506484416422, 5490.69801160932, 5501.779928802803, 1579.2182869479682, 1620.3599578166793, 1634.6158652716601, 1656.6106964863247, 1658.4941592814066, 1240.3054289597853, 1269.1750362264602, 1273.4396865379204, 1282.8588855225917, 1285.7656649616472, 5316.883454474603, 5321.680699158062, 5344.118220493575, 5347.572194224453, 5356.196570514454, 5506.944930550643, 5513.228148059275, 5527.226188333637, 5589.636673616202, 5600.4959553640365, 5105.821296254688, 5301.390340110859, 5333.839984800462, 5350.411454739976, 5366.738816378148, 2940.5442156465783, 2943.204645166447, 2946.6758656547763, 2948.43979643867, 2962.8962986295805, 5598.460423383602, 5767.279090113736, 5772.336181339116, 5776.595638305278, 5781.53747700183, 5670.688112153789, 5677.772889084473, 5696.51579615729, 5699.0, 5711.657300561979, 5718.656880587178, 5722.828315150386, 5723.370429252779, 5777.440091175359, 5781.739821708034, 5322.040575142832, 5562.805301814417, 5567.2762540871045, 5609.4390560943575, 5630.380658127521, 5325.80169461868, 5419.696628932609, 5433.9456605435025, 5559.888802223852, 5562.16567514876, 5769.0, 5793.826185214451, 5803.622764520462, 5854.941450585439, 5857.619254748428, 4529.8641040768825, 4717.561143851159, 4719.466173493697, 4722.693024953367, 4739.905201895874, 5543.362513311021, 5629.577781666309, 5641.435856414326, 5665.745041473061, 5666.660000399989, 5431.538319242909, 5458.808941687022, 5477.808276710296, 5504.201890725903, 5528.474794894479, 5239.711815850165, 5455.690634247672, 5459.69971651563, 5526.47498487643, 5526.972365138148, 5428.267183930119, 5444.564434845123, 5463.453654634504, 5473.233747275305, 5495.368032676293, 5404.54061404785, 5464.508194262536, 5473.467429119693, 5487.478689524489, 5496.0, 5119.948800511947, 5308.654937429054, 5311.814086506954, 5329.760160792696, 5335.67985920846], "value": 4401.7722436258655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.0241324889631, 881.2861582118485, 899.986500202497, 921.9631214751408, 931.9748276895411, 16649.25078371473, 17614.823851761477, 17844.464666060037, 17975.0, 18713.625727485476, 16385.344586216568, 16517.83482165178, 16829.747553786703, 17842.464726058206, 18000.72998905014, 879.366855863777, 886.4326830828292, 911.8996910339857, 916.4180745226796, 916.5554705967601, 882.3294296334767, 891.0465801592298, 891.1801142948503, 891.3582220801013, 891.4606662968907, 971.5627967414656, 971.8299297622923, 972.6741541583579, 973.1776648731845, 974.098958463422, 948.8149810786899, 951.4529145741192, 954.856771484276, 959.3620242538703, 959.9232061435068, 705.5131958948309, 707.4729326651626, 707.508281744188, 707.5330282013846, 707.9398251148658, 17508.387206447715, 17638.0, 17797.19912603936, 18991.715124273145, 19245.0, 16569.91715041417, 16721.83278167227, 16876.746848797276, 16920.238589263514, 17359.566010849703, 14120.717585648332, 14299.356528956221, 14427.78358324626, 14436.0, 14457.0, 4053.148838743838, 4056.574059723716, 4084.65280451159, 4151.481064866892, 4177.49870015597, 93185.0, 93767.53116234374, 94502.52748736281, 96836.51581742046, 97220.51389743076, 13075.934620326838, 13122.803157952638, 13123.212607243597, 13142.802857957138, 13252.337383130998, 21254.78745212559, 22210.44473888166, 23331.18340858062, 23454.530909382058, 23704.40738981505, 9145.314101442418, 9252.95373523128, 9433.198178154933, 9504.144626983605, 9761.560729767178, 5138.922916156261, 5250.3962044364625, 5292.44429334922, 5319.680819150786, 5410.215518749759, 3746.587875333711, 3888.747231429948, 3909.2181563687377, 3917.980410097988, 3951.7233793634746, 664.9002649602598, 667.7729571945562, 699.2343383994518, 719.0472623773521, 730.5981710059446, 855.9443636163629, 868.2822764746304, 874.6442125237222, 912.5756523216736, 912.6577533424966, 11830.147602213076, 12004.0, 12278.693032674255, 12466.0, 12586.81119783204, 684.9212340580797, 690.6995456976232, 692.0588000319561, 704.9577025378494, 711.6157275071507, 5568.972155139199, 5671.120976248688, 5711.428302662138, 5747.0, 5765.308163020381, 86665.0, 86901.56549217213, 87269.0, 88350.0, 88491.0, 60557.0, 63501.047484287774, 69617.0, 77480.0, 78092.21907780963, 63896.68051659805, 65056.795456363376, 65180.67409662921, 65411.34588654053, 65518.0, 11274.887251127711, 11881.04951603887, 11934.4032798358, 12081.637550873487, 12303.630891072924, 38899.80550097232, 42825.571744282155, 44308.77845610751, 44320.77839610782, 44550.10899782051, 53183.73408132935, 55034.44965550293, 55639.443605565044, 55701.49343279643, 57698.0, 13162.47350105985, 13761.38073786662, 13799.0, 13922.51271205503, 14060.789088163481, 16130.274137664068, 16145.112018839076, 16180.0, 16199.0, 16291.266892989606, 15708.842911571195, 16209.189540523163, 16327.836721632631, 16617.50147495577, 16624.75062874082, 15260.923695381452, 15668.52994410124, 15687.215639218222, 16326.591835204215, 16329.510114696579, 15071.849281507482, 15219.543413697607, 15244.618884527976, 16002.0, 16007.67984640324, 11530.898039449537, 11742.823857642314, 11758.58844940423, 12095.75808483843, 12293.44679489443, 12169.39153042362, 12579.930705890101, 12742.61772146837, 12779.23324600527, 12914.612561623166], "value": 8157.144005534334, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1452.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 111.0, 111.0, 112.0, 112.0, 112.0, 112.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 114.0, 115.0, 143.0, 115.0, 115.0, 119.0, 115.0, 141.0, 114.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 114.0, 76.0, 75.0, 75.0, 75.0, 91.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 103.0, 82.0, 83.0, 82.0, 103.0, 82.0, 82.0, 95.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 93.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 59.0, 54.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 56.0, 54.0, 61.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 83.0, 82.0, 79.0, 75.0, 80.0, 79.0, 79.0, 101.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 121.0, 128.0, 121.0, 121.0, 118.0, 137.0, 118.0, 133.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 158.0, 162.0, 160.0, 162.0, 161.0, 160.0, 162.0, 158.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 59.0, 59.0, 60.0, 60.0, 58.0, 59.0, 58.0], "value": 59.3, "unit": "score"}]}]} 06:50:14 INFO - Return code: 0 06:50:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:50:14 INFO - # TBPL SUCCESS # 06:50:14 INFO - Running post-action listener: _resource_record_post_action 06:50:14 INFO - [mozharness: 2017-05-18 13:50:14.669769Z] Finished run-tests step (success) 06:50:14 INFO - Running post-run listener: _resource_record_post_run 06:50:14 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 326201344; Read time: 0; Write time: 211080 06:50:14 INFO - TinderboxPrint: CPU usage
13.1% 06:50:14 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:50:14 INFO - TinderboxPrint: I/O write bytes / time
326,201,344 / 211,080 06:50:14 INFO - TinderboxPrint: CPU idle
8,251.9 (86.9%) 06:50:14 INFO - TinderboxPrint: CPU user
1,200.6 (12.6%) 06:50:14 INFO - TinderboxPrint: Swap in / out
0 / 0 06:50:14 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 90419200; Read time: 0; Write time: 68160 06:50:14 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 235782144; Read time: 0; Write time: 142920 06:50:15 INFO - Running post-run listener: _upload_blobber_files 06:50:15 INFO - Blob upload gear active. 06:50:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:50:15 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:50:15 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:50:15 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:50:15 INFO - (blobuploader) - INFO - Open directory for files ... 06:50:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:50:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:50:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:18 INFO - (blobuploader) - INFO - Done attempting. 06:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:50:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:50:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:50:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:19 INFO - (blobuploader) - INFO - Done attempting. 06:50:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:50:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:50:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:50:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:20 INFO - (blobuploader) - INFO - Done attempting. 06:50:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:50:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:50:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:50:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:21 INFO - (blobuploader) - INFO - Done attempting. 06:50:21 INFO - (blobuploader) - INFO - Iteration through files over. 06:50:21 INFO - Return code: 0 06:50:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:50:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:50:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bbfac6bffb2215df5c53e59a1f03c13e00b96ebafae3176658f31a89376f1654b301682a7d7baa063c16d0ee3a629ea6193f0429364cf926bb8cf5c914b36aea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0e730320e3346e284fdbeee06d0d71792375d11172c75f345d5932ae1a25ece22b53ce7e5c6fd10aaeb1036b64ce7cdc49e9140257fb3d4bbe31ddb6fd03f3b5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c06bb25be4326c207002b3acfa2a1aed4c5130f99c6c9c695541a8a77a16eddb0def391ccdf5e74976c3d6c001d77cc9648863b5a1df425f788c08f9f1aabd5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ec322ec217588e3e78f27ef4c8e1f23f559c88e4d87290499794120751730eb089b40282a838d4b2b3fd0448472b38765e7ddf2b9f208e977ba0c8409f6f9be9"} 06:50:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:50:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:50:21 INFO - Contents: 06:50:21 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bbfac6bffb2215df5c53e59a1f03c13e00b96ebafae3176658f31a89376f1654b301682a7d7baa063c16d0ee3a629ea6193f0429364cf926bb8cf5c914b36aea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0e730320e3346e284fdbeee06d0d71792375d11172c75f345d5932ae1a25ece22b53ce7e5c6fd10aaeb1036b64ce7cdc49e9140257fb3d4bbe31ddb6fd03f3b5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c06bb25be4326c207002b3acfa2a1aed4c5130f99c6c9c695541a8a77a16eddb0def391ccdf5e74976c3d6c001d77cc9648863b5a1df425f788c08f9f1aabd5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ec322ec217588e3e78f27ef4c8e1f23f559c88e4d87290499794120751730eb089b40282a838d4b2b3fd0448472b38765e7ddf2b9f208e977ba0c8409f6f9be9"} 06:50:21 INFO - Running post-run listener: copy_logs_to_upload_dir 06:50:21 INFO - Copying logs to upload dir... 06:50:21 INFO - mkdir: /builds/slave/test/build/upload/logs 06:50:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.085262 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-05-18 06:50:20.007116) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 06:50:20.011815) ========= 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=ea65d483da93c827905c2090000001f5-1495113641.332403-813516333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bbfac6bffb2215df5c53e59a1f03c13e00b96ebafae3176658f31a89376f1654b301682a7d7baa063c16d0ee3a629ea6193f0429364cf926bb8cf5c914b36aea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0e730320e3346e284fdbeee06d0d71792375d11172c75f345d5932ae1a25ece22b53ce7e5c6fd10aaeb1036b64ce7cdc49e9140257fb3d4bbe31ddb6fd03f3b5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c06bb25be4326c207002b3acfa2a1aed4c5130f99c6c9c695541a8a77a16eddb0def391ccdf5e74976c3d6c001d77cc9648863b5a1df425f788c08f9f1aabd5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ec322ec217588e3e78f27ef4c8e1f23f559c88e4d87290499794120751730eb089b40282a838d4b2b3fd0448472b38765e7ddf2b9f208e977ba0c8409f6f9be9"} build_url:https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/IXqZmW9sTNWfh0Q03vytNg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bbfac6bffb2215df5c53e59a1f03c13e00b96ebafae3176658f31a89376f1654b301682a7d7baa063c16d0ee3a629ea6193f0429364cf926bb8cf5c914b36aea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0e730320e3346e284fdbeee06d0d71792375d11172c75f345d5932ae1a25ece22b53ce7e5c6fd10aaeb1036b64ce7cdc49e9140257fb3d4bbe31ddb6fd03f3b5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c06bb25be4326c207002b3acfa2a1aed4c5130f99c6c9c695541a8a77a16eddb0def391ccdf5e74976c3d6c001d77cc9648863b5a1df425f788c08f9f1aabd5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ec322ec217588e3e78f27ef4c8e1f23f559c88e4d87290499794120751730eb089b40282a838d4b2b3fd0448472b38765e7ddf2b9f208e977ba0c8409f6f9be9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 06:50:20.038983) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:50:20.039379) ========= 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=ea65d483da93c827905c2090000001f5-1495113641.332403-813516333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:50:20.121264) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 06:50:20.124643) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 06:50:20.124960) ========= ========= Total master_lag: 0.21 =========