builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1495084375.46 results: success (0) revision: baf05f61bc14fdf45511bc1165ce76daa08c5c0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:55.459390) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:55.459791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:55.460059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:55.503194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:55.503500) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-17 22:12:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-05-17 22:12:56 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:55.666376) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:55.666715) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017875 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:55.717607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-17 22:12:55.718044) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev baf05f61bc14fdf45511bc1165ce76daa08c5c0f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev baf05f61bc14fdf45511bc1165ce76daa08c5c0f --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=e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-17 22:12:56,126 truncating revision to first 12 chars 2017-05-17 22:12:56,126 Setting DEBUG logging. 2017-05-17 22:12:56,126 attempt 1/10 2017-05-17 22:12:56,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/baf05f61bc14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-17 22:12:57,196 unpacking tar archive at: mozilla-central-baf05f61bc14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.375799 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-17 22:12:57.106160) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:57.106526) ========= script_repo_revision: baf05f61bc14fdf45511bc1165ce76daa08c5c0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:57.106923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:57.107225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 22:12:57.115620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-05-17 22:12:57.115891) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:12:57 INFO - MultiFileLogger online at 20170517 22:12:57 in /builds/slave/test 22:12:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:12:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:12:57 INFO - {'append_to_log': False, 22:12:57 INFO - 'base_work_dir': '/builds/slave/test', 22:12:57 INFO - 'blob_upload_branch': 'Firefox', 22:12:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:12:57 INFO - 'branch': 'Firefox', 22:12:57 INFO - 'buildbot_json_path': 'buildprops.json', 22:12:57 INFO - 'config_files': ('talos/linux_config.py',), 22:12:57 INFO - 'default_actions': ('clobber', 22:12:57 INFO - 'read-buildbot-config', 22:12:57 INFO - 'download-and-extract', 22:12:57 INFO - 'populate-webroot', 22:12:57 INFO - 'create-virtualenv', 22:12:57 INFO - 'install', 22:12:57 INFO - 'run-tests'), 22:12:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:12:57 INFO - 'download_minidump_stackwalk': True, 22:12:57 INFO - 'download_symbols': 'ondemand', 22:12:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:12:57 INFO - 'tooltool.py': '/tools/tooltool.py', 22:12:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:12:57 INFO - '/tools/misc-python/virtualenv.py')}, 22:12:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:12:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:12:57 INFO - 'gecko_profile': False, 22:12:57 INFO - 'gecko_profile_interval': 0, 22:12:57 INFO - 'installer_path': 'installer.exe', 22:12:57 INFO - 'log_level': 'info', 22:12:57 INFO - 'log_name': 'talos', 22:12:57 INFO - 'log_to_console': True, 22:12:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:12:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:12:57 INFO - 'opt_config_files': (), 22:12:57 INFO - 'pip_index': False, 22:12:57 INFO - 'suite': 'dromaeojs-e10s', 22:12:57 INFO - 'system_bits': '32', 22:12:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:12:57 INFO - 'title': 'talos-linux64-ix-067', 22:12:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:12:57 INFO - 'use_talos_json': True, 22:12:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:12:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:12:57 INFO - 'work_dir': 'build'} 22:12:57 INFO - [mozharness: 2017-05-18 05:12:57.629585Z] Running clobber step. 22:12:57 INFO - Running pre-action listener: _resource_record_pre_action 22:12:57 INFO - Running main action method: clobber 22:12:57 INFO - rmtree: /builds/slave/test/build 22:12:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:12:58 INFO - Running post-action listener: _resource_record_post_action 22:12:58 INFO - [mozharness: 2017-05-18 05:12:58.646716Z] Finished clobber step (success) 22:12:58 INFO - [mozharness: 2017-05-18 05:12:58.646817Z] Running read-buildbot-config step. 22:12:58 INFO - Running pre-action listener: _resource_record_pre_action 22:12:58 INFO - Running main action method: read_buildbot_config 22:12:58 INFO - Using buildbot properties: 22:12:58 INFO - { 22:12:58 INFO - "project": "", 22:12:58 INFO - "product": "firefox", 22:12:58 INFO - "who": "ihsiao@mozilla.com", 22:12:58 INFO - "installer_path": "public/build/target.tar.bz2", 22:12:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 22:12:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:12:58 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 22:12:58 INFO - "stage_platform": "linux64-styloseq", 22:12:58 INFO - "basedir": "/builds/slave/test", 22:12:58 INFO - "buildnumber": 3, 22:12:58 INFO - "platform": "ubuntu64_hw_styloseq", 22:12:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:12:58 INFO - "slavebuilddir": "test", 22:12:58 INFO - "taskId": "Cl-wC5pxTiuagV08XqJhOg", 22:12:58 INFO - "branch": "mozilla-central", 22:12:58 INFO - "script_repo_revision": "production", 22:12:58 INFO - "revision": "baf05f61bc14fdf45511bc1165ce76daa08c5c0f", 22:12:58 INFO - "slavename": "talos-linux64-ix-067", 22:12:58 INFO - "repo_path": "mozilla-central" 22:12:58 INFO - } 22:12:58 INFO - Finding installer, test and symbols from parent task. 22:12:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cl-wC5pxTiuagV08XqJhOg'}, attempt #1 22:12:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cl-wC5pxTiuagV08XqJhOg'}, attempt #1 22:12:59 INFO - Task dependencies: PgcfRhxQQ_aS-nMtQEMpNw 22:12:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw'}, attempt #1 22:13:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.tar.bz2 22:13:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/test_packages.json 22:13:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.crashreporter-symbols.zip 22:13:00 INFO - Running post-action listener: _resource_record_post_action 22:13:00 INFO - [mozharness: 2017-05-18 05:13:00.024954Z] Finished read-buildbot-config step (success) 22:13:00 INFO - [mozharness: 2017-05-18 05:13:00.025175Z] Running download-and-extract step. 22:13:00 INFO - Running pre-action listener: _resource_record_pre_action 22:13:00 INFO - Running main action method: download_and_extract 22:13:00 INFO - mkdir: /builds/slave/test/build/tests 22:13:00 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')]} 22:13:00 INFO - trying https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.test_packages.json 22:13:00 INFO - Downloading https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:13:00 INFO - Downloaded 986 bytes. 22:13:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:13:00 INFO - Using the following test package requirements: 22:13:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:13:00 INFO - u'common': [u'target.common.tests.zip'], 22:13:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:13:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:13:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:13:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:13:00 INFO - u'mozbase': [u'target.common.tests.zip'], 22:13:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:13:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:13:00 INFO - u'web-platform': [u'target.common.tests.zip', 22:13:00 INFO - u'target.web-platform.tests.zip'], 22:13:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:13:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:13:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.common.tests.zip 22:13:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:13:00 INFO - Fetch https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.common.tests.zip into memory 22:13:02 INFO - Content-Length response header: 62452570 22:13:02 INFO - Bytes received: 62452570 22:13:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:13:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.common.tests.zip 22:13:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:13:13 INFO - Fetch https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.common.tests.zip into memory 22:13:15 INFO - Content-Length response header: 62452570 22:13:15 INFO - Bytes received: 62452570 22:13:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.talos.tests.zip 22:13:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:13:27 INFO - Fetch https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.talos.tests.zip into memory 22:13:31 INFO - Content-Length response header: 14410001 22:13:31 INFO - Bytes received: 14410001 22:13:31 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')]} 22:13:31 INFO - trying https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.tar.bz2 22:13:31 INFO - Downloading https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:13:34 INFO - Downloaded 59827781 bytes. 22:13:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.tar.bz2 22:13:34 INFO - mkdir: /builds/slave/test/properties 22:13:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:13:34 INFO - Writing to file /builds/slave/test/properties/build_url 22:13:34 INFO - Contents: 22:13:34 INFO - build_url:https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.tar.bz2 22:13:34 INFO - Running post-action listener: _resource_record_post_action 22:13:34 INFO - Running post-action listener: set_extra_try_arguments 22:13:34 INFO - [mozharness: 2017-05-18 05:13:34.678271Z] Finished download-and-extract step (success) 22:13:34 INFO - [mozharness: 2017-05-18 05:13:34.678500Z] Running populate-webroot step. 22:13:34 INFO - Running pre-action listener: _resource_record_pre_action 22:13:34 INFO - Running main action method: populate_webroot 22:13:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:13:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:13:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:13:34 INFO - '--tppagecycles', 22:13:34 INFO - '7'], 22:13:34 INFO - 'tests': ['tsvgm']}}, 22:13:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:13:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:13:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:13:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:13:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:13:34 INFO - 'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:13:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:13:34 INFO - 'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['damp', 'tps']}, 22:13:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:13:34 INFO - 'tests': ['damp', 'tps']}, 22:13:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['dromaeo_dom']}, 22:13:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:13:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 22:13:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:13:34 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 22:13:34 INFO - 'tests': ['ts_paint', 'tp5o']}, 22:13:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['a11yr', 22:13:34 INFO - 'ts_paint', 22:13:34 INFO - 'tpaint', 22:13:34 INFO - 'sessionrestore', 22:13:34 INFO - 'sessionrestore_no_auto_restore', 22:13:34 INFO - 'tabpaint']}, 22:13:34 INFO - 'other-e10s': {'tests': ['a11yr', 22:13:34 INFO - 'ts_paint', 22:13:34 INFO - 'tpaint', 22:13:34 INFO - 'sessionrestore', 22:13:34 INFO - 'sessionrestore_no_auto_restore', 22:13:34 INFO - 'tabpaint']}, 22:13:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:13:34 INFO - 'ts_paint', 22:13:34 INFO - 'tpaint', 22:13:34 INFO - 'sessionrestore', 22:13:34 INFO - 'sessionrestore_no_auto_restore', 22:13:34 INFO - 'tabpaint']}, 22:13:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:13:34 INFO - 'ts_paint', 22:13:34 INFO - 'tpaint', 22:13:34 INFO - 'sessionrestore', 22:13:34 INFO - 'sessionrestore_no_auto_restore', 22:13:34 INFO - 'tabpaint']}, 22:13:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['a11yr', 22:13:34 INFO - 'ts_paint', 22:13:34 INFO - 'tpaint', 22:13:34 INFO - 'sessionrestore', 22:13:34 INFO - 'sessionrestore_no_auto_restore', 22:13:34 INFO - 'tabpaint']}, 22:13:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['a11yr', 22:13:34 INFO - 'ts_paint', 22:13:34 INFO - 'tpaint', 22:13:34 INFO - 'sessionrestore', 22:13:34 INFO - 'sessionrestore_no_auto_restore', 22:13:34 INFO - 'tabpaint']}, 22:13:34 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 22:13:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 22:13:34 INFO - 'bloom_basic_ref']}, 22:13:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['tsvgx', 22:13:34 INFO - 'tsvgr_opacity', 22:13:34 INFO - 'tart', 22:13:34 INFO - 'tscrollx', 22:13:34 INFO - 'cart', 22:13:34 INFO - 'tsvg_static']}, 22:13:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:13:34 INFO - 'tsvgr_opacity', 22:13:34 INFO - 'tart', 22:13:34 INFO - 'tscrollx', 22:13:34 INFO - 'cart', 22:13:34 INFO - 'tsvg_static']}, 22:13:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:13:34 INFO - 'talos_options': ['--disable-e10s'], 22:13:34 INFO - 'tests': ['tp5o']}, 22:13:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:13:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:13:34 INFO - 'talos_options': ['--disable-e10s', 22:13:34 INFO - '--xperf_path', 22:13:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:34 INFO - 'tests': ['tp5n']}, 22:13:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:13:34 INFO - 'talos_options': ['--xperf_path', 22:13:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:34 INFO - 'tests': ['tp5n']}}, 22:13:34 INFO - 'talos.zip': {'path': '', 22:13:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:13:34 INFO - Running post-action listener: _resource_record_post_action 22:13:34 INFO - [mozharness: 2017-05-18 05:13:34.694708Z] Finished populate-webroot step (success) 22:13:34 INFO - [mozharness: 2017-05-18 05:13:34.694798Z] Running create-virtualenv step. 22:13:34 INFO - Running pre-action listener: _resource_record_pre_action 22:13:34 INFO - Running main action method: create_virtualenv 22:13:34 INFO - Creating virtualenv /builds/slave/test/build/venv 22:13:34 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 22:13:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:13:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:13:34 INFO - Using real prefix '/usr' 22:13:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:13:35 INFO - Installing distribute.............................................................................................................................................................................................done. 22:13:37 INFO - Installing pip.................done. 22:13:37 INFO - Return code: 0 22:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:13:37 INFO - Reading from file tmpfile_stdout 22:13:37 INFO - Output received: 22:13:37 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) 22:13:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:13:37 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')]} 22:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:37 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')]} 22:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:37 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 0x1d6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', '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 22:13:37 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 22:13:37 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 22:13:37 INFO - Using env: {'DISPLAY': ':0', 22:13:37 INFO - 'HOME': '/home/cltbld', 22:13:37 INFO - 'LANG': 'en_US.UTF-8', 22:13:37 INFO - 'LANGUAGE': 'en_US:en', 22:13:37 INFO - 'LOGNAME': 'cltbld', 22:13:37 INFO - 'MAIL': '/var/mail/cltbld', 22:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:37 INFO - 'MOZ_NO_REMOTE': '1', 22:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:37 INFO - 'NO_EM_RESTART': '1', 22:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:37 INFO - 'PWD': '/builds/slave/test', 22:13:37 INFO - 'SHELL': '/bin/bash', 22:13:37 INFO - 'SHLVL': '1', 22:13:37 INFO - 'TERM': 'linux', 22:13:37 INFO - 'TMOUT': '86400', 22:13:37 INFO - 'USER': 'cltbld', 22:13:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:37 INFO - '_': '/tools/buildbot/bin/python'} 22:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:37 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 22:13:37 INFO - Cleaning up... 22:13:37 INFO - Return code: 0 22:13:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:13:37 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')]} 22:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:37 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')]} 22:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:37 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 0x1d6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', '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 22:13:37 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 22:13:37 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 22:13:37 INFO - Using env: {'DISPLAY': ':0', 22:13:37 INFO - 'HOME': '/home/cltbld', 22:13:37 INFO - 'LANG': 'en_US.UTF-8', 22:13:37 INFO - 'LANGUAGE': 'en_US:en', 22:13:37 INFO - 'LOGNAME': 'cltbld', 22:13:37 INFO - 'MAIL': '/var/mail/cltbld', 22:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:37 INFO - 'MOZ_NO_REMOTE': '1', 22:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:37 INFO - 'NO_EM_RESTART': '1', 22:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:37 INFO - 'PWD': '/builds/slave/test', 22:13:37 INFO - 'SHELL': '/bin/bash', 22:13:37 INFO - 'SHLVL': '1', 22:13:37 INFO - 'TERM': 'linux', 22:13:37 INFO - 'TMOUT': '86400', 22:13:37 INFO - 'USER': 'cltbld', 22:13:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:37 INFO - '_': '/tools/buildbot/bin/python'} 22:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:37 INFO - Downloading/unpacking psutil>=3.1.1 22:13:37 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 22:13:37 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 22:13:37 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 22:13:37 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 22:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:13:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:39 INFO - Installing collected packages: psutil 22:13:39 INFO - Running setup.py install for psutil 22:13:39 INFO - building 'psutil._psutil_linux' extension 22:13:39 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 22:13:39 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 22:13:39 INFO - building 'psutil._psutil_posix' extension 22:13:39 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 22:13:39 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 22:13:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:39 INFO - Successfully installed psutil 22:13:39 INFO - Cleaning up... 22:13:39 INFO - Return code: 0 22:13:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:13:39 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')]} 22:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:39 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')]} 22:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:39 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 0x1d6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', '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 22:13:39 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 22:13:39 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 22:13:39 INFO - Using env: {'DISPLAY': ':0', 22:13:39 INFO - 'HOME': '/home/cltbld', 22:13:39 INFO - 'LANG': 'en_US.UTF-8', 22:13:39 INFO - 'LANGUAGE': 'en_US:en', 22:13:39 INFO - 'LOGNAME': 'cltbld', 22:13:39 INFO - 'MAIL': '/var/mail/cltbld', 22:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:39 INFO - 'MOZ_NO_REMOTE': '1', 22:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:39 INFO - 'NO_EM_RESTART': '1', 22:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:39 INFO - 'PWD': '/builds/slave/test', 22:13:39 INFO - 'SHELL': '/bin/bash', 22:13:39 INFO - 'SHLVL': '1', 22:13:39 INFO - 'TERM': 'linux', 22:13:39 INFO - 'TMOUT': '86400', 22:13:39 INFO - 'USER': 'cltbld', 22:13:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:39 INFO - '_': '/tools/buildbot/bin/python'} 22:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:13:39 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 22:13:39 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 22:13:39 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 22:13:39 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 22:13:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:13:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:13:41 INFO - Installing collected packages: mozsystemmonitor 22:13:41 INFO - Running setup.py install for mozsystemmonitor 22:13:41 INFO - Successfully installed mozsystemmonitor 22:13:41 INFO - Cleaning up... 22:13:41 INFO - Return code: 0 22:13:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:13:41 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')]} 22:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:41 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')]} 22:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:41 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 0x1d6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', '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 22:13:41 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 22:13:41 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 22:13:41 INFO - Using env: {'DISPLAY': ':0', 22:13:41 INFO - 'HOME': '/home/cltbld', 22:13:41 INFO - 'LANG': 'en_US.UTF-8', 22:13:41 INFO - 'LANGUAGE': 'en_US:en', 22:13:41 INFO - 'LOGNAME': 'cltbld', 22:13:41 INFO - 'MAIL': '/var/mail/cltbld', 22:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:41 INFO - 'MOZ_NO_REMOTE': '1', 22:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:41 INFO - 'NO_EM_RESTART': '1', 22:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:41 INFO - 'PWD': '/builds/slave/test', 22:13:41 INFO - 'SHELL': '/bin/bash', 22:13:41 INFO - 'SHLVL': '1', 22:13:41 INFO - 'TERM': 'linux', 22:13:41 INFO - 'TMOUT': '86400', 22:13:41 INFO - 'USER': 'cltbld', 22:13:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:41 INFO - '_': '/tools/buildbot/bin/python'} 22:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:41 INFO - Downloading/unpacking jsonschema==2.5.1 22:13:41 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 22:13:41 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 22:13:41 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 22:13:41 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 22:13:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:13:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:13:42 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 22:13:42 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 22:13:42 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 22:13:42 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 22:13:42 INFO - Downloading functools32-3.2.3-2.tar.gz 22:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:13:42 INFO - warning: no files found matching '*.txt' 22:13:42 INFO - no previously-included directories found matching 'build' 22:13:42 INFO - no previously-included directories found matching 'dist' 22:13:42 INFO - no previously-included directories found matching '.git*' 22:13:42 INFO - Installing collected packages: jsonschema, functools32 22:13:42 INFO - Running setup.py install for functools32 22:13:42 INFO - warning: no files found matching '*.txt' 22:13:42 INFO - no previously-included directories found matching 'build' 22:13:42 INFO - no previously-included directories found matching 'dist' 22:13:42 INFO - no previously-included directories found matching '.git*' 22:13:42 INFO - Successfully installed jsonschema functools32 22:13:42 INFO - Cleaning up... 22:13:42 INFO - Return code: 0 22:13:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:13:42 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')]} 22:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:42 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')]} 22:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:42 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 0x1d6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', '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 22:13:42 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 22:13:42 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 22:13:42 INFO - Using env: {'DISPLAY': ':0', 22:13:42 INFO - 'HOME': '/home/cltbld', 22:13:42 INFO - 'LANG': 'en_US.UTF-8', 22:13:42 INFO - 'LANGUAGE': 'en_US:en', 22:13:42 INFO - 'LOGNAME': 'cltbld', 22:13:42 INFO - 'MAIL': '/var/mail/cltbld', 22:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:42 INFO - 'MOZ_NO_REMOTE': '1', 22:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:42 INFO - 'NO_EM_RESTART': '1', 22:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:42 INFO - 'PWD': '/builds/slave/test', 22:13:42 INFO - 'SHELL': '/bin/bash', 22:13:42 INFO - 'SHLVL': '1', 22:13:42 INFO - 'TERM': 'linux', 22:13:42 INFO - 'TMOUT': '86400', 22:13:42 INFO - 'USER': 'cltbld', 22:13:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:42 INFO - '_': '/tools/buildbot/bin/python'} 22:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:13:43 INFO - Cleaning up... 22:13:43 INFO - Return code: 0 22:13:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:13:43 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')]} 22:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:43 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')]} 22:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:43 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 0x1d6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', '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 22:13:43 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 22:13:43 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 22:13:43 INFO - Using env: {'DISPLAY': ':0', 22:13:43 INFO - 'HOME': '/home/cltbld', 22:13:43 INFO - 'LANG': 'en_US.UTF-8', 22:13:43 INFO - 'LANGUAGE': 'en_US:en', 22:13:43 INFO - 'LOGNAME': 'cltbld', 22:13:43 INFO - 'MAIL': '/var/mail/cltbld', 22:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:43 INFO - 'MOZ_NO_REMOTE': '1', 22:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:43 INFO - 'NO_EM_RESTART': '1', 22:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:43 INFO - 'PWD': '/builds/slave/test', 22:13:43 INFO - 'SHELL': '/bin/bash', 22:13:43 INFO - 'SHLVL': '1', 22:13:43 INFO - 'TERM': 'linux', 22:13:43 INFO - 'TMOUT': '86400', 22:13:43 INFO - 'USER': 'cltbld', 22:13:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:43 INFO - '_': '/tools/buildbot/bin/python'} 22:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:43 INFO - Downloading/unpacking blobuploader==1.2.4 22:13:43 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 22:13:43 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 22:13:43 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 22:13:43 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 22:13:44 INFO - Downloading blobuploader-1.2.4.tar.gz 22:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:13:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:13:44 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 22:13:44 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 22:13:44 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 22:13:44 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 22:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:13:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:13:44 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 22:13:44 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 22:13:44 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 22:13:44 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 22:13:44 INFO - Downloading docopt-0.6.1.tar.gz 22:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:13:45 INFO - Installing collected packages: blobuploader, requests, docopt 22:13:45 INFO - Running setup.py install for blobuploader 22:13:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:13:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:13:45 INFO - Running setup.py install for requests 22:13:45 INFO - Running setup.py install for docopt 22:13:45 INFO - Successfully installed blobuploader requests docopt 22:13:45 INFO - Cleaning up... 22:13:45 INFO - Return code: 0 22:13:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:45 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')]} 22:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:45 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')]} 22:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:45 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 0x1d6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', '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 22:13:45 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 22:13:45 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 22:13:45 INFO - Using env: {'DISPLAY': ':0', 22:13:45 INFO - 'HOME': '/home/cltbld', 22:13:45 INFO - 'LANG': 'en_US.UTF-8', 22:13:45 INFO - 'LANGUAGE': 'en_US:en', 22:13:45 INFO - 'LOGNAME': 'cltbld', 22:13:45 INFO - 'MAIL': '/var/mail/cltbld', 22:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:45 INFO - 'MOZ_NO_REMOTE': '1', 22:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:45 INFO - 'NO_EM_RESTART': '1', 22:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:45 INFO - 'PWD': '/builds/slave/test', 22:13:45 INFO - 'SHELL': '/bin/bash', 22:13:45 INFO - 'SHLVL': '1', 22:13:45 INFO - 'TERM': 'linux', 22:13:45 INFO - 'TMOUT': '86400', 22:13:45 INFO - 'USER': 'cltbld', 22:13:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:45 INFO - '_': '/tools/buildbot/bin/python'} 22:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:45 INFO - Running setup.py (path:/tmp/pip-1fvubP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:45 INFO - Running setup.py (path:/tmp/pip-paS793-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:45 INFO - Running setup.py (path:/tmp/pip-BrpdHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:46 INFO - Running setup.py (path:/tmp/pip-oojX_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:46 INFO - Running setup.py (path:/tmp/pip-LBaQFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:46 INFO - Running setup.py (path:/tmp/pip-8ukW4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:46 INFO - Running setup.py (path:/tmp/pip-4VIRqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:46 INFO - Running setup.py (path:/tmp/pip-ylArx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:46 INFO - Running setup.py (path:/tmp/pip-XY4b_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:46 INFO - Running setup.py (path:/tmp/pip-lxSY4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:46 INFO - Running setup.py (path:/tmp/pip-rTcpwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:46 INFO - Running setup.py (path:/tmp/pip-Viia8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:46 INFO - Running setup.py (path:/tmp/pip-oO1STp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:46 INFO - Running setup.py (path:/tmp/pip-demQ3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:46 INFO - Running setup.py (path:/tmp/pip-LZ6xUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:46 INFO - Running setup.py (path:/tmp/pip-yXmrNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:46 INFO - Running setup.py (path:/tmp/pip-mM3DZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:13:47 INFO - Running setup.py install for manifestparser 22:13:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:13:47 INFO - Running setup.py install for mozcrash 22:13:47 INFO - Running setup.py install for mozdebug 22:13:47 INFO - Running setup.py install for mozdevice 22:13:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:13:47 INFO - Running setup.py install for mozfile 22:13:47 INFO - Running setup.py install for mozhttpd 22:13:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:13:47 INFO - Running setup.py install for mozinfo 22:13:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:13:47 INFO - Running setup.py install for mozInstall 22:13:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:13:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:13:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:13:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:13:47 INFO - Running setup.py install for mozleak 22:13:47 INFO - Running setup.py install for mozlog 22:13:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:13:48 INFO - Running setup.py install for moznetwork 22:13:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:13:48 INFO - Running setup.py install for mozprocess 22:13:48 INFO - Running setup.py install for mozprofile 22:13:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:13:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:13:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:13:48 INFO - Running setup.py install for mozrunner 22:13:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:13:48 INFO - Running setup.py install for mozscreenshot 22:13:48 INFO - Running setup.py install for moztest 22:13:48 INFO - Running setup.py install for mozversion 22:13:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:13:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:13:48 INFO - Cleaning up... 22:13:48 INFO - Return code: 0 22:13:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:48 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')]} 22:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:48 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')]} 22:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:48 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 0x1d6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', '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 22:13:48 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 22:13:48 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 22:13:48 INFO - Using env: {'DISPLAY': ':0', 22:13:48 INFO - 'HOME': '/home/cltbld', 22:13:48 INFO - 'LANG': 'en_US.UTF-8', 22:13:48 INFO - 'LANGUAGE': 'en_US:en', 22:13:48 INFO - 'LOGNAME': 'cltbld', 22:13:48 INFO - 'MAIL': '/var/mail/cltbld', 22:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:48 INFO - 'MOZ_NO_REMOTE': '1', 22:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:48 INFO - 'NO_EM_RESTART': '1', 22:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:48 INFO - 'PWD': '/builds/slave/test', 22:13:48 INFO - 'SHELL': '/bin/bash', 22:13:48 INFO - 'SHLVL': '1', 22:13:48 INFO - 'TERM': 'linux', 22:13:48 INFO - 'TMOUT': '86400', 22:13:48 INFO - 'USER': 'cltbld', 22:13:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:48 INFO - '_': '/tools/buildbot/bin/python'} 22:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:49 INFO - Running setup.py (path:/tmp/pip-accHZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:49 INFO - Running setup.py (path:/tmp/pip-BM3enq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:49 INFO - Running setup.py (path:/tmp/pip-dlXPwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:49 INFO - Running setup.py (path:/tmp/pip-coTx5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:49 INFO - Running setup.py (path:/tmp/pip-S2hWe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:49 INFO - Running setup.py (path:/tmp/pip-GJfo1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:49 INFO - Running setup.py (path:/tmp/pip-guKxSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:49 INFO - Running setup.py (path:/tmp/pip-iOl6CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:49 INFO - Running setup.py (path:/tmp/pip-6lQXNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:49 INFO - Running setup.py (path:/tmp/pip-SzQuNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:49 INFO - Running setup.py (path:/tmp/pip-IiW1IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:49 INFO - Running setup.py (path:/tmp/pip-XoNbbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:49 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)) 22:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:49 INFO - Running setup.py (path:/tmp/pip-xSPhaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:50 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)) 22:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:50 INFO - Running setup.py (path:/tmp/pip-YH96Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:50 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)) 22:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:50 INFO - Running setup.py (path:/tmp/pip-63LzDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:50 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)) 22:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:50 INFO - Running setup.py (path:/tmp/pip-fAXtsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:50 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)) 22:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:50 INFO - Running setup.py (path:/tmp/pip-5tejoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:50 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)) 22:13:50 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)) 22:13:50 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)) 22:13:50 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)) 22:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:13:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:51 INFO - Downloading blessings-1.6.tar.gz 22:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:13:51 INFO - Installing collected packages: blessings 22:13:51 INFO - Running setup.py install for blessings 22:13:51 INFO - Successfully installed blessings 22:13:51 INFO - Cleaning up... 22:13:51 INFO - Return code: 0 22:13:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:51 INFO - Reading from file tmpfile_stdout 22:13:51 INFO - Current package versions: 22:13:51 INFO - argparse == 1.2.1 22:13:51 INFO - blessings == 1.6 22:13:51 INFO - blobuploader == 1.2.4 22:13:51 INFO - docopt == 0.6.1 22:13:51 INFO - functools32 == 3.2.3-2 22:13:51 INFO - jsonschema == 2.5.1 22:13:51 INFO - manifestparser == 1.1 22:13:51 INFO - mozInstall == 1.12 22:13:51 INFO - mozcrash == 1.0 22:13:51 INFO - mozdebug == 0.1 22:13:51 INFO - mozdevice == 0.50 22:13:51 INFO - mozfile == 1.2 22:13:51 INFO - mozhttpd == 0.7 22:13:51 INFO - mozinfo == 0.9 22:13:51 INFO - mozleak == 0.1 22:13:51 INFO - mozlog == 3.4 22:13:51 INFO - moznetwork == 0.27 22:13:51 INFO - mozprocess == 0.25 22:13:51 INFO - mozprofile == 0.28 22:13:51 INFO - mozrunner == 6.13 22:13:51 INFO - mozscreenshot == 0.1 22:13:51 INFO - mozsystemmonitor == 0.3 22:13:51 INFO - moztest == 0.8 22:13:51 INFO - mozversion == 1.4 22:13:51 INFO - psutil == 3.1.1 22:13:51 INFO - requests == 1.2.3 22:13:51 INFO - wsgiref == 0.1.2 22:13:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:51 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')]} 22:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:51 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')]} 22:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:51 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 0x1d6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', '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 22:13:51 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 22:13:51 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 22:13:51 INFO - Using env: {'DISPLAY': ':0', 22:13:51 INFO - 'HOME': '/home/cltbld', 22:13:51 INFO - 'LANG': 'en_US.UTF-8', 22:13:51 INFO - 'LANGUAGE': 'en_US:en', 22:13:51 INFO - 'LOGNAME': 'cltbld', 22:13:51 INFO - 'MAIL': '/var/mail/cltbld', 22:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:51 INFO - 'MOZ_NO_REMOTE': '1', 22:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:51 INFO - 'NO_EM_RESTART': '1', 22:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:51 INFO - 'PWD': '/builds/slave/test', 22:13:51 INFO - 'SHELL': '/bin/bash', 22:13:51 INFO - 'SHLVL': '1', 22:13:51 INFO - 'TERM': 'linux', 22:13:51 INFO - 'TMOUT': '86400', 22:13:51 INFO - 'USER': 'cltbld', 22:13:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:51 INFO - '_': '/tools/buildbot/bin/python'} 22:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:52 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)) 22:13:52 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)) 22:13:52 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)) 22:13:52 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)) 22:13:52 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)) 22:13:52 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)) 22:13:52 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)) 22:13:52 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)) 22:13:52 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)) 22:13:52 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)) 22:13:52 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)) 22:13:52 INFO - Cleaning up... 22:13:52 INFO - Return code: 0 22:13:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:13:52 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')]} 22:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:52 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')]} 22:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1d6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', '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 22:13:52 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 22:13:52 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 22:13:52 INFO - Using env: {'DISPLAY': ':0', 22:13:52 INFO - 'HOME': '/home/cltbld', 22:13:52 INFO - 'LANG': 'en_US.UTF-8', 22:13:52 INFO - 'LANGUAGE': 'en_US:en', 22:13:52 INFO - 'LOGNAME': 'cltbld', 22:13:52 INFO - 'MAIL': '/var/mail/cltbld', 22:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:52 INFO - 'MOZ_NO_REMOTE': '1', 22:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:52 INFO - 'NO_EM_RESTART': '1', 22:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:52 INFO - 'PWD': '/builds/slave/test', 22:13:52 INFO - 'SHELL': '/bin/bash', 22:13:52 INFO - 'SHLVL': '1', 22:13:52 INFO - 'TERM': 'linux', 22:13:52 INFO - 'TMOUT': '86400', 22:13:52 INFO - 'USER': 'cltbld', 22:13:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:52 INFO - '_': '/tools/buildbot/bin/python'} 22:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:13:52 INFO - Cleaning up... 22:13:52 INFO - Return code: 0 22:13:52 INFO - Running post-action listener: _resource_record_post_action 22:13:52 INFO - Running post-action listener: _start_resource_monitoring 22:13:52 INFO - Starting resource monitoring. 22:13:52 INFO - [mozharness: 2017-05-18 05:13:52.308887Z] Finished create-virtualenv step (success) 22:13:52 INFO - [mozharness: 2017-05-18 05:13:52.309395Z] Running install step. 22:13:52 INFO - Running pre-action listener: _resource_record_pre_action 22:13:52 INFO - Running main action method: install 22:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:52 INFO - Reading from file tmpfile_stdout 22:13:52 INFO - Detecting whether we're running mozinstall >=1.0... 22:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:13:52 INFO - Reading from file tmpfile_stdout 22:13:52 INFO - Output received: 22:13:52 INFO - Usage: mozinstall [options] installer 22:13:52 INFO - Options: 22:13:52 INFO - -h, --help show this help message and exit 22:13:52 INFO - -d DEST, --destination=DEST 22:13:52 INFO - Directory to install application into. [default: 22:13:52 INFO - "/builds/slave/test"] 22:13:52 INFO - --app=APP Application being installed. [default: firefox] 22:13:52 INFO - mkdir: /builds/slave/test/build/application 22:13:52 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'] 22:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:14:10 INFO - Reading from file tmpfile_stdout 22:14:10 INFO - Output received: 22:14:10 INFO - /builds/slave/test/build/application/firefox/firefox 22:14:10 INFO - Running post-action listener: _resource_record_post_action 22:14:10 INFO - [mozharness: 2017-05-18 05:14:10.311742Z] Finished install step (success) 22:14:10 INFO - [mozharness: 2017-05-18 05:14:10.312019Z] Running run-tests step. 22:14:10 INFO - Running pre-action listener: _resource_record_pre_action 22:14:10 INFO - Running main action method: run_tests 22:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:14:10 INFO - Python 2.7.3 22:14:10 INFO - Return code: 0 22:14:10 INFO - grabbing minidump binary from tooltool 22:14:10 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')]} 22:14:10 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 0x20db7a0>, '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 0x20dc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:14:10 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 22:14:10 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 22:14:10 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 22:14:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:14:10 INFO - Return code: 0 22:14:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:14:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:14:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:14:10 INFO - ENV: RUST_BACKTRACE is now 1 22:14:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:14:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:14:10 INFO - Using env: {'DISPLAY': ':0', 22:14:10 INFO - 'HOME': '/home/cltbld', 22:14:10 INFO - 'LANG': 'en_US.UTF-8', 22:14:10 INFO - 'LANGUAGE': 'en_US:en', 22:14:10 INFO - 'LOGNAME': 'cltbld', 22:14:10 INFO - 'MAIL': '/var/mail/cltbld', 22:14:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:14:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:10 INFO - 'MOZ_NO_REMOTE': '1', 22:14:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:10 INFO - 'NO_EM_RESTART': '1', 22:14:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:10 INFO - 'PWD': '/builds/slave/test', 22:14:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:14:10 INFO - 'RUST_BACKTRACE': '1', 22:14:10 INFO - 'SHELL': '/bin/bash', 22:14:10 INFO - 'SHLVL': '1', 22:14:10 INFO - 'TERM': 'linux', 22:14:10 INFO - 'TMOUT': '86400', 22:14:10 INFO - 'USER': 'cltbld', 22:14:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784', 22:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:10 INFO - '_': '/tools/buildbot/bin/python'} 22:14:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:14:10 INFO - mozversion application_buildid: 20170518040634 22:14:10 INFO - mozversion application_changeset: baf05f61bc14fdf45511bc1165ce76daa08c5c0f 22:14:10 INFO - mozversion application_display_name: Nightly 22:14:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:14:10 INFO - mozversion application_name: Firefox 22:14:10 INFO - mozversion application_remotingname: firefox 22:14:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:14:10 INFO - mozversion application_vendor: Mozilla 22:14:10 INFO - mozversion application_version: 55.0a1 22:14:10 INFO - mozversion platform_buildid: 20170518040634 22:14:10 INFO - mozversion platform_changeset: baf05f61bc14fdf45511bc1165ce76daa08c5c0f 22:14:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:14:10 INFO - mozversion platform_version: 55.0a1 22:14:10 INFO - using testdate: 1495084450 22:14:10 INFO - actual date: 1495084450 22:14:10 INFO - starting webserver on 'localhost:52453' 22:14:10 INFO - SUITE-START | Running 2 tests 22:14:10 INFO - TEST-START | dromaeo_css 22:14:10 INFO - operating with platform_type : linux_ 22:14:10 INFO - Initialising browser for dromaeo_css test... 22:14:10 INFO - TEST-INFO | started process 16700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkT6HaH/profile http://localhost:52453/getInfo.html) 22:14:11 INFO - PID 16700 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 22:14:14 INFO - PID 16700 | __metrics Screen width/height:1600/1200 22:14:14 INFO - PID 16700 | colorDepth:24 22:14:14 INFO - PID 16700 | Browser inner width/height: 1024/695 22:14:14 INFO - PID 16700 | __metrics 22:14:15 INFO - TEST-INFO | 16700: exit 0 22:14:15 INFO - Browser initialized. 22:14:15 INFO - Running cycle 1/1 for dromaeo_css test... 22:14:15 INFO - TEST-INFO | started process 16878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkT6HaH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:27 INFO - PID 16878 | RSS: Main: 170225664 22:14:27 INFO - PID 16878 | 22:17:32 INFO - PID 16878 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52453/tests/dromaeo/cssquery-ext.html) 22:17:34 INFO - PID 16878 | RSS: Main: 175218688 22:17:34 INFO - PID 16878 | 22:20:36 INFO - PID 16878 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-ext.html (next: http://localhost:52453/tests/dromaeo/cssquery-jquery.html) 22:20:36 INFO - PID 16878 | RSS: Main: 174755840 22:20:36 INFO - PID 16878 | 22:23:38 INFO - PID 16878 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52453/tests/dromaeo/cssquery-mootools.html) 22:23:39 INFO - PID 16878 | RSS: Main: 178339840 22:23:39 INFO - PID 16878 | 22:26:41 INFO - PID 16878 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52453/tests/dromaeo/cssquery-prototype.html) 22:26:41 INFO - PID 16878 | RSS: Main: 176119808 22:26:41 INFO - PID 16878 | 22:29:44 INFO - PID 16878 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52453/tests/dromaeo/cssquery-yui.html) 22:29:45 INFO - PID 16878 | RSS: Main: 174718976 22:29:45 INFO - PID 16878 | 22:32:47 INFO - PID 16878 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-yui.html (next: http://localhost:52453/tests/dromaeo/cssquery-dojo.html) 22:32:47 INFO - PID 16878 | RSS: Main: 182026240 22:32:47 INFO - PID 16878 | 22:32:47 INFO - PID 16878 | __start_tp_report 22:32:47 INFO - PID 16878 | _x_x_mozilla_page_load 22:32:47 INFO - PID 16878 | _x_x_mozilla_page_load_details 22:32:47 INFO - PID 16878 | |i|pagename|runs| 22:32:47 INFO - PID 16878 | |0;dojo.html;2714.402831377097;2727.3045373429773;2755.4489102179555;2759.0481283957033;2774.042955180462;5153.665011774232;5158.123119069758;5185.585153187745;5216.139337009394;5232.1366974449265;5192.1432963560965;5225.320708307924;5230.6600070995355;5295.735213239342;5310.0441920454305;4354.1074079813725;4522.072975040125;4607.539246075399;4638.2115040443205;4651.302304654295;4637.513061128567;4676.532346765313;4687.01572669738;4713.858584242478;4721.716696998174;4591.494935557086;4598.310253461974;4610.124076425502;4672.415948006499;4677.92983105252;4658.18481765693;4672.57946784791;4696.342512048316;4703.435587729495;4714.434267887841;4575.382323386333;4578.381918441001;4611.3313569532565;4617.099665565216;4652.906941861143;5104.489551044866;5112.977404519111;5157.974210128963;5170.508801663836;5185.248139019821;5575.721213939328;5625.437456254383;5625.746841392147;5630.90197411505;5665.405132461115;5612.41069687681;5710.685912274823;5714.171445140431;5716.256886604757;5725.5419566435;5286.60350473716;5297.814576489882;5311.336082989626;5322.680639161663;5360.088784906575;5673.234113394721;5741.45456181662;5780.1907732917425;5809.941900581025;5815.563832712563;5595.832125036255;5597.272354593958;5608.719564021782;5609.607327487037;5624.100143976944;5588.776448942078;5591.4688104629995;5640;5658.7170641467765;5671.035923892866;5553.0559804832465;5658.858528536737;5664.631798933056;5683.2895888014;5701.116326969326;5559.221708960748;5585.078462053797;5613.129964855454;5631.831045068655;5647.322321321386;4712.5994290485005;4751.358566593535;4754.120487709784;4780.402449693788;4827.758612069382;4078.5513593504693;4112.753234805921;4116.135611521554;4122.031322639177;4160.334346504545;4676.859694209179;4747.881302967454;4762.64280178988;4819.734914579732;4832.4684284728655;5654.491095801398;5676;5689.68706721126;5725.971370143206;5729.226554415184;4768.785404656799;4780.426348838162;4792.353032340589;4799.6400269979895;4833.347498087784;4880.292357608198;4955.1823949048;4982.177940639754;4998.2002879539095;5006.549410553068;5226.614947039114;5245.029669511153;5270.130428479258;5276.81531146408;5282.84151475441;5683.119116536944;5689.288838895138;5697.287839020122;5705.37240903492;5712.257406537124;5177.974110129425;5355.384130825005;5363.731813409236;5368.597355198298;5404.7567859445635;5575.776968921197;5582.190582365615;5661.660300381825;5663.377028526941;5665.461781130786;5682.744276507485;5685.630434021776;5698.886022279448;5727.971360143172;5750.971245143747;5348.438413966477;5418.566514678895;5478.342598888;5498.80754173602;5542.528885044816;5451.509364157245;5533.114701647717;5538.9169162461785;5550.222968784454;5584.329880414376;5355.357357117171;5413.918791218056;5430.40265570779;5470.480304371078;5480.095784195722;5518.944810551843;5525.171224316385;5530.806421775219;5562.694051827027;5584.804531841366;5358.410574836843;5370.731463426891;5375.3280839895015;5380.246765452918;5383.300170977748 22:32:47 INFO - PID 16878 | |1;ext.html;690.451091382351;737.8339873528457;762.8054846014265;1167.1829719196564;1228.4717571444287;34132.48801267983;35002.474962875574;35011.12472188196;35015.82492087536;35022.47466288004;32964.340713185724;33303.50044749324;33362.33275334492;33417;33491.49762753561;6520.869582608345;6665.533412661116;6806.693698783567;7019.5788252705;7028.086348774652;6974.302569743036;7050.435965122778;7084.504084714072;7087.255838136999;7087.610181440019;7025.402840758542;7031.085958825372;7036.929630703704;7067.611281379522;7071.292870712913;6991.8601627967155;7077.504574679774;7078.575285482836;7079.752208672698;7085.220625731191;6990.370866621977;7048.823779405505;7049.753258635923;7054.611996340199;7061.611611361373;32248.421620919064;32564.6743532564;32843.343133137445;32855;32863;3109.5646609474693;3116.8597413116463;3119.376124775054;3137.043201823443;3137.6391714952842;25178.370540736443;25185.748142518525;25239.49521009588;25250.368740781443;25253.242402727763;2567.743225677436;2569.8843552040016;2575.8196926215173;2580.342012786746;2586.7154612992554;139735.30132349374;140313;147095.26452367668;148434.25782871124;148786.25606872005;39025.80487097603;39112.6088739109;39142;39205.80397097996;39309.803450983134;41002.79498602488;41261;45140.548594514294;45413.772931135136;45760.313595296095;11417.828732569018;11524.078073754079;11578.76842463163;11604.419779011016;11605.825912611317;8899.866502002475;8951.686690965786;8970.641174352953;8977.057408972094;8990.056044115274;13120.803187952188;13152.145110567782;13155.144915580457;13241.337933103307;13342.266175360448;5562.276904002454;5661.801836935688;5693.430656934273;5720.711715313908;5762.596618236767;893.9106089391139;920.406337912043;926.6015613286216;939.957701903416;964.2045312616979;20875.79124208769;21768.78231217699;21880;21908.671369929147;21963.121475140815;996.820572296979;1001.2740762946805;1011.049613363436;1018.5314755212537;1024.5235965276183;10897.509612067475;11733.589324373606;11764.176507644383;11781.410929453494;11826.94086529579;171644;172308;172501;173117;173256;40555.18889622191;40917.79541102275;40976.38535421971;40994.59005409908;41065.38401923973;1187.8337032815414;1227.6010296653624;1241.757857217852;1246.0156476383736;1255.8179064035664;19782.219600236047;19908.402747917586;20377.388678339674;21283.36149915505;21357.572848543252;29075;29280;29367.85316073406;29526.704732953254;29539.55690664685;149117.25441372723;149438.25280873527;149550.80165781075;149951;150097;28798;29523.409531809673;29729.554056688736;30317.635706392823;30638.540421894137;34831.65168348284;35689.286214276086;35731;36086;36344.45483317805;22158.224462143746;22861.19985800489;23414.88292558526;24244;24429;27085.59371609388;27168.864155679887;27860.30349241204;28472.715272847006;28692.282692932844;29658.258543536584;29768.55347169751;30112.698873011865;30599.388012240077;30675.2331191722;26196.21411357662;26711;26814.463710726068;27001.729982699922;28326;20188.495287617927;22718.432039199153;22740.317790466313;22760.544789104457;22821 22:32:47 INFO - PID 16878 | |2;jquery.html;419.8971252043246;421.93038148705466;423.6441389233042;431.5210116770384;448.65453600727443;17369.392071277507;18150.909245453786;18166;18244.270229190817;19244.61510769784;16340.346386144569;16729.330826766945;17878.64242715148;18133.37332533492;18386.908065459687;5398.2712333834825;5435.537979271767;5546.473085056913;5596.468335508121;5599.804006859761;5474.370447398541;5567.359753628324;5578.0517312057045;5578.972105139469;5584.441555844423;5397.190421436777;5511.200875873016;5534.169874518814;5550.888982220353;5570.248016517779;5422.9728851355885;5482.835514934558;5513.062779327524;5541.944580554204;5566.359868615121;4934.185859333205;4976.676516026483;5020.673656212334;5020.949790502084;5061.013102445025;21938.232161874257;21983.670244946337;22339.994700238527;22783.886080569657;22859.085636574517;1660.692771837214;1675.4722262487398;1681.2518429298966;1701.4045084220425;1702.8893121947033;14519.927400363036;15056.623584410368;15154.318055687521;15228.162451065187;15261.923690381476;2084.5518213584;2097.318371529244;2117.7246957895527;2143.98928005359;2157.2018353209414;87644;88153.55923220344;88792;90458;91644.08355916422;10984.780304393867;11020.614278500214;11136.554537818396;11360.886391135982;11696.35670038156;14833.70332593342;14936.402543898339;14946.70106597862;15057.54827355181;15197.392104315924;7008.439324853999;7167.104111986002;7195.496315257987;7417.666205020787;7438.1446133694235;6353.30113687494;6415.871682566416;6531.738730450824;6613.636250006296;6625.436837868835;6952.478564107712;6994.203835916276;7031.644399126248;7055.753048643272;7072.787816365517;2003.5291706448972;2029.6245194639039;2039.9796002039789;2080.126346934291;2197.1540956731774;852.9189726975927;878.3544095090103;883.9381243313035;886.6719313853915;909.3907082254905;16906.239219235165;16953.745693814602;17227.138643068047;17325.7401138983;17951;861.7931696392945;870.6082262981683;872.5201139373446;876.8027193881326;887.7114937645291;9338.299627527962;9762.121409073217;9781.608735650494;9791;9846;355467;356739;361594;361889;361932;74864.62567687126;77240.61379693066;77358;78348.60825695835;79349.20650793418;1023.1072515845775;1050.9527071281811;1075.8708954925303;1078.6224821312478;1081.6917178604217;14645.340959656627;14762.852371476578;14833.406663733329;14963.925180374028;15349.07905525672;38012.429813553375;38858.6114138855;39049.21901561896;39450.2109957805;39926.80036599799;48649;48663.67372241586;48794.26808597803;49009.50990490049;49327.753361232964;7878.409119315959;8112.675492980215;8176.345892328718;8182.590870456334;8518.957405212934;12544.811827822772;12659.430325635185;12788.104832661624;13018.088733788923;13090.80363794563;9911.65309214174;10119.494025298853;10170.491475426052;10203.795924081329;10326;9758.219342452445;9932.056454636799;10010.249231307827;10018.899811002088;10048.648297309559;11110.944445277722;11432.199746018032;11461.598844040418;11936.701582460508;11949.462274197856;7448.255174482509;7852.13626501073;8185.631646576037;8212.753617391489;8400.579971001547;10849.349039057683;10872.293300935415;10873.184511161537;10891.891081089088;11320.9433952833 22:32:47 INFO - PID 16878 | |3;mootools.html;1271.7774389481838;1336.2316667915945;1348.858369871163;1348.9527866524675;1351.8242628458302;9916.157126644235;10244.590216391336;10399.168066554676;10415.843762343562;10461.163106951444;10236.744081397968;10489.213309001836;10506.317089389184;10508.842367364476;10518.631847885326;2267.2631394796717;2317.409060689522;2327.406511339606;2331;2340.1458467659268;2247.5954328220914;2280.4184932842186;2298.241580278504;2302.1712183613886;2312.2600767754325;2215.944601384962;2221.255879280435;2290.4273931517123;2292.277932451281;2300.160441438871;2148.656215005607;2151.6557350823873;2196.4069701180592;2197.2199869046417;2204.2946257197705;1993.651111055574;2079.7209716024536;2090.2579584247524;2272.9090836366527;2283.0981762204;9894.109530142321;9909.950450247703;9944.651937182236;9991.650292239809;10004.54979525923;5488.313960754906;5716.3426205986425;5719.656820590736;5727.914081288784;5739.225204597367;3034.4689679306252;3269.6076470823414;3314.8176850273226;3343.8160901150427;3346.9497957530657;1088.8638920134983;1112.3993043756361;1122.859642544682;1147.73602071524;1170.444039081438;14965.850341496664;15070.849291507164;15227.847721522754;15265;15270.618234544114;4888.828890988798;5012.195609580548;5076.162433198481;5126.000429916131;5151.124308867502;12373.505059797688;12387.07096967731;12437.93781031089;12450.190737602208;12469.438875250455;5575;5619.213310136584;5637.887242255132;5639.125935480007;5648.378678345379;4847.75761211938;4944.184209605375;4980.103581355391;5062.848114556569;5068.873278168076;4115.323504960948;4121.649659778893;4206.326987681956;4216.198922204771;4253.914921701548;1314.7436249931172;1366.9179849209079;1367.3368416318078;1391.2487256881373;1397.5667543061684;740.9962950185322;761.5735188294573;764.4763337114094;771.5293670860883;775.5734346109617;5726.513246374105;5780.104083867007;5842.883142337129;5899.852503687443;5909.084091965752;541.6885290957715;541.9918701219485;547.3322546493272;550.9889802204013;557.0863783395235;3526.1713497328105;3546.875859344962;3611.3499570077115;3995.840166393312;4041.4948131483566;12741.55404560836;13083.869161308456;13223.73552528944;13249.735005300034;13294.800577991338;13011.284379359036;13037;13066.281354525592;13083.672908177181;13129.73740525184;6897.137857767779;7172.784816455514;7445.776626701316;7480.962595186989;7488.251174882468;6356.841078973062;6407.455366293731;6601.911001370679;6609;6624.238212605419;11537.365444900612;11702.29786212796;11709.824352634547;12054.698632534257;12065.457054432396;11702.473388697359;11931.4034298283;12128.272303661808;12160.759600534328;12216.816747748968;8053.275205231557;8286;8299.419040667095;8312.709055183039;8314.916850831414;9394.67118650844;9395.2953528487;9455.385399949257;9477.905220947703;9530.857037144588;8150.75547733569;8181.222783835526;8182.22268884455;8227.629756660845;8312.584370781558;7977.08263549676;7994.84010319802;7996.440249182501;7996.440249182734;8073.475224110414;7262.636868156676;7308.926910730825;7357.889631655423;7359.632018398952;7642.312191902755;5082.136036873666;5133.820316288912;5221.4778522149;5249.291345668286;5331.253624492497;5638.323401191883;5661.547076233974;5713.114467257582;5783.074708046693;5875.676837773964 22:32:47 INFO - PID 16878 | |4;prototype.html;371.31492396528415;389.6473691309365;395.1543696489511;397.749417866744;398.1817365314278;5288.60335474839;5412.918806217905;5429.782808687648;5452.127659574468;5460.645058071227;5190.688558686482;5312.760925758341;5314.627976041669;5331.386890507592;5332.546733527645;4027.65764909983;4030.637242648161;4033.394990751389;4043.555208927016;4043.919121617566;3887.2225554888996;4026.3491968293006;4032.9395059074136;4044.130511939932;4045.1368942659838;3991.1219531703123;3991.7604943703327;3991.9022268876;3995.9800200998952;4010.13782036862;3998.8200530975887;4000.159966407058;4007.639312461878;4014.9397759033636;4027.194561087794;3505.94741078884;3511.315293517765;3515.525404070469;3519.6480351964597;3523.154442933703;5193.350831146106;5196.298499702568;5207.9479205207845;5232.424433312332;5251.584271235236;4701.576858082754;4703.623710103184;4707.328898241143;4710.222813235812;4724.905501889977;5539.612227144102;5586.776528938837;5637.379888212294;5645.5483561314995;5649.293838270216;3908.9609103909165;3914.4911161549103;3931.5871833457645;3933.370660694275;3941.9211615767813;5784.595078344518;5961.91057134139;5969.761209551612;5992.370801065869;6022.6687532185715;4023.436718859362;4028.7582745035393;4034.939475907805;4055.1484188320783;4057.4725285713257;4077.388391741203;4094.3653733671326;4103.466549348565;4103.610157035077;4106.240345536085;4646.930296045562;4648.233041548175;4690.226112691368;4719.528047195253;4722.3235751308475;5606.355269144101;5630.465105814941;5633.605647604629;5663.6035477517;5666.263385759825;1390.1728471559406;1395.874371306567;1414.745345837759;1415.2923538230884;1421.9928900355433;897.7800438892513;937.9718608441758;947.8720372749591;958.9184919281939;960.8366577681811;4883.218685010382;4920.704757714549;4930.950690493121;4934.284528743384;4940.8764780880765;5807.216025836458;5813;5840.620359676607;5845.912311315334;5852.15143804146;4799.208130658472;4806.375171227718;4893.266010098514;4905.852824415273;4908.41099068107;3057.755379569629;3089.598352214198;3090.799098058619;3098.5352197170605;3117.7973431726864;5533.695646739468;5541.750621222055;5541.833744987657;5555.972220138873;5557.360903496069;5776.306843178845;6009.2188015557695;6024.427679370453;6057.727402266909;6072.726727297282;5504.80733174345;5526.7892842863175;5531.589444691658;5536.972315138479;5563.582731295169;5724.313082429969;5826.475617194473;5848.590598658223;5883.264591926009;5907.261592300963;5808.257522743075;5812.18629391877;5813.157092221689;5815.76736930518;5815.9709201453725;5375.865603359947;5500;5546.500814926676;5548.445155484419;5560.833175004756;4020;4045.3931910212527;4056.59434056592;4058.066644671801;4074.6536544392875;5846.795362162304;5909.3795151508475;5951.303878394637;5956.791512297049;5969.224000879858;5667.178259152317;5671;5692.48767610917;5706.657600543981;5710.685912274865;5676.829695109153;5678.119891416837;5707.315122185199;5721.656700597811;5727.677946790935;5469.863253418696;5618.269624948731;5623.522000629992;5663.490285874126;5664.320281566238;5741.62679425836;5750.223719797774;5762;5762.222100016612;5767.942320576908;5486.780528778804;5592.161175823659;5593.216949627137;5620.690862002629;5624.268845050117 22:32:47 INFO - PID 16878 | |5;yui.html;655.5149189599698;661.434473525136;731.5354749733921;771.5794891783977;790.3361176611645;11438.828417573743;12368.938155309233;13294.335283235849;13956.930215348935;14177.929110354447;14469;15140.24298785062;15182.468613598527;15204.543863684079;15408.922955385235;835.2941764209248;859.8323326951247;863.5336918064238;864.2092485375873;868.0408148995364;907.6641642592217;908.7773495493614;915.6108653822132;916.2532535983153;916.8808054952847;953.5280036381967;958.8130314588658;959.4291396619035;959.5633986536144;962.3840741925173;946.7633091727068;950.9286803489731;951.6098399656108;952.7332346942867;952.8332541805156;692.7194486233084;695.8851789454734;697.5152269172927;697.6407150317591;699.1854489519703;14277.928610356985;14673;14758.114513129247;14933.850661493354;15034.924825375912;14986.925065374713;15090.17004064776;15375.154366509838;15873;16165.272562734704;12230.14388992771;12409.937950310281;12455.439505222195;12534.185277956904;12586.685332866751;3060.4032213718333;3076.7077127672837;3078.8768449262;3082.475979083561;3090.98454507726;71511;71697.28302716959;71842.2815771846;72697.63651181763;73364.63317683377;12007.639770806889;12469.127161098817;12629.494820207088;12629.74740505203;12641.43113559892;21070.683939740917;22514.774852251594;22707.88646056759;22844.200452984398;22896.7710322898;6359.491240700733;6377.7130029147875;6612.07430959666;6613.4709223262025;6619.635920024349;3066.7699922505903;3099.4575949208797;3125.281185327342;3128.9687103128676;3138.1370123216298;3623.1123374772824;3651.7626354287418;3655.1958569114754;3694.963050369462;3752.62473752628;734.2363941500886;747.5178509861217;755.1089714137371;756.0322786832862;757.473555878659;613.6900865063114;618.1068356225211;628.2586547873553;631.958922670025;647.7247169952846;9587.856182157273;10170.288079834489;10497.842532362021;10711.25021248505;11143.442827858575;568.46848196936;573.5812856614695;577.0910815465659;577.5754820207144;578.8292453726077;4478.2386994211065;4598.954010459853;4600.700954437951;4776.235802271689;4798.928016079762;59635;59802;60810;63449;63604;52557.47442525602;56326;57079.71460142673;57303.42696572981;57854.7107264461;46844;46990.29514557285;47314.52685473101;48326.03347933092;48899.75550122298;10530;11118.110551156049;11169.553217871195;11234;11349.943250284026;24596.139135130186;24796.884140213373;25108.372290692878;25316.367090822878;25644.61533076968;42155.3676694856;43129.13741725211;44011;44341.33487997747;45208;14063.718725625225;14080.366383512972;14337.06809057408;14551.563453096423;14561.781573276197;14190.645233869236;14434.206118663575;14449.711005780036;14565.053271537316;14820.03669761462;12947.093703440669;13104.541341053398;13130.080894337305;13133.540326088541;13365.131266467648;14120.78818817698;14336.71326573442;14374.856251437352;14478.27608619586;14522.419103235752;14002.929985350009;14292.785608216092;14335.641608959859;14393.568192954228;14636.634084147981;9023.639054437748;9084.772880678036;9223.86164207524;9237.584308706259;9486.715398538056;10326.48367581633;10428;10681.359118452918;10948.56205751793;10999.780004400027 22:32:47 INFO - PID 16878 | __end_tp_report 22:32:47 INFO - PID 16878 | __start_cc_report 22:32:47 INFO - PID 16878 | _x_x_mozilla_cycle_collect,277 22:32:47 INFO - PID 16878 | __end_cc_report 22:32:47 INFO - PID 16878 | __startTimestamp1495085567380__endTimestamp 22:32:47 INFO - PID 16878 | 22:32:47 INFO - PID 16878 | ------- Summary: start ------- 22:32:47 INFO - PID 16878 | Number of tests: 6 22:32:47 INFO - PID 16878 | 22:32:47 INFO - PID 16878 | [#0] dojo.html Cycles:165 Average:5165.77 Median:5355.38 stddev:611.00 (11.4%) stddev-sans-first:581.82 22:32:47 INFO - PID 16878 | Values: 2714.4 2727.3 2755.4 2759.0 2774.0 5153.7 5158.1 5185.6 5216.1 5232.1 5192.1 5225.3 5230.7 5295.7 5310.0 4354.1 4522.1 4607.5 4638.2 4651.3 4637.5 4676.5 4687.0 4713.9 4721.7 4591.5 4598.3 4610.1 4672.4 4677.9 4658.2 4672.6 4696.3 4703.4 4714.4 4575.4 4578.4 4611.3 4617.1 4652.9 5104.5 5113.0 5158.0 5170.5 5185.2 5575.7 5625.4 5625.7 5630.9 5665.4 5612.4 5710.7 5714.2 5716.3 5725.5 5286.6 5297.8 5311.3 5322.7 5360.1 5673.2 5741.5 5780.2 5809.9 5815.6 5595.8 5597.3 5608.7 5609.6 5624.1 5588.8 5591.5 5640.0 5658.7 5671.0 5553.1 5658.9 5664.6 5683.3 5701.1 5559.2 5585.1 5613.1 5631.8 5647.3 4712.6 4751.4 4754.1 4780.4 4827.8 4078.6 4112.8 4116.1 4122.0 4160.3 4676.9 4747.9 4762.6 4819.7 4832.5 5654.5 5676.0 5689.7 5726.0 5729.2 4768.8 4780.4 4792.4 4799.6 4833.3 4880.3 4955.2 4982.2 4998.2 5006.5 5226.6 5245.0 5270.1 5276.8 5282.8 5683.1 5689.3 5697.3 5705.4 5712.3 5178.0 5355.4 5363.7 5368.6 5404.8 5575.8 5582.2 5661.7 5663.4 5665.5 5682.7 5685.6 5698.9 5728.0 5751.0 5348.4 5418.6 5478.3 5498.8 5542.5 5451.5 5533.1 5538.9 5550.2 5584.3 5355.4 5413.9 5430.4 5470.5 5480.1 5518.9 5525.2 5530.8 5562.7 5584.8 5358.4 5370.7 5375.3 5380.2 5383.3 22:32:47 INFO - PID 16878 | 22:32:47 INFO - PID 16878 | [#1] ext.html Cycles:180 Average:30013.62 Median:29940.63 stddev:40283.62 (134.5%) stddev-sans-first:40336.45 22:32:47 INFO - PID 16878 | Values: 690.5 737.8 762.8 1167.2 1228.5 34132.5 35002.5 35011.1 35015.8 35022.5 32964.3 33303.5 33362.3 33417.0 33491.5 6520.9 6665.5 6806.7 7019.6 7028.1 6974.3 7050.4 7084.5 7087.3 7087.6 7025.4 7031.1 7036.9 7067.6 7071.3 6991.9 7077.5 7078.6 7079.8 7085.2 6990.4 7048.8 7049.8 7054.6 7061.6 32248.4 32564.7 32843.3 32855.0 32863.0 3109.6 3116.9 3119.4 3137.0 3137.6 25178.4 25185.7 25239.5 25250.4 25253.2 2567.7 2569.9 2575.8 2580.3 2586.7 139735.3 140313.0 147095.3 148434.3 148786.3 39025.8 39112.6 39142.0 39205.8 39309.8 41002.8 41261.0 45140.5 45413.8 45760.3 11417.8 11524.1 11578.8 11604.4 11605.8 8899.9 8951.7 8970.6 8977.1 8990.1 13120.8 13152.1 13155.1 13241.3 13342.3 5562.3 5661.8 5693.4 5720.7 5762.6 893.9 920.4 926.6 940.0 964.2 20875.8 21768.8 21880.0 21908.7 21963.1 996.8 1001.3 1011.0 1018.5 1024.5 10897.5 11733.6 11764.2 11781.4 11826.9 171644.0 172308.0 172501.0 173117.0 173256.0 40555.2 40917.8 40976.4 40994.6 41065.4 1187.8 1227.6 1241.8 1246.0 1255.8 19782.2 19908.4 20377.4 21283.4 21357.6 29075.0 29280.0 29367.9 29526.7 29539.6 149117.3 149438.3 149550.8 149951.0 150097.0 28798.0 29523.4 29729.6 30317.6 30638.5 34831.7 35689.3 35731.0 36086.0 36344.5 22158.2 22861.2 23414.9 24244.0 24429.0 27085.6 27168.9 27860.3 28472.7 28692.3 29658.3 29768.6 30112.7 30599.4 30675.2 26196.2 26711.0 26814.5 27001.7 28326.0 20188.5 22718.4 22740.3 22760.5 22821.0 22:32:47 INFO - PID 16878 | 22:32:47 INFO - PID 16878 | [#2] jquery.html Cycles:180 Average:24560.05 Median:39688.51 stddev:59990.57 (151.2%) stddev-sans-first:60131.48 22:32:47 INFO - PID 16878 | Values: 419.9 421.9 423.6 431.5 448.7 17369.4 18150.9 18166.0 18244.3 19244.6 16340.3 16729.3 17878.6 18133.4 18386.9 5398.3 5435.5 5546.5 5596.5 5599.8 5474.4 5567.4 5578.1 5579.0 5584.4 5397.2 5511.2 5534.2 5550.9 5570.2 5423.0 5482.8 5513.1 5541.9 5566.4 4934.2 4976.7 5020.7 5020.9 5061.0 21938.2 21983.7 22340.0 22783.9 22859.1 1660.7 1675.5 1681.3 1701.4 1702.9 14519.9 15056.6 15154.3 15228.2 15261.9 2084.6 2097.3 2117.7 2144.0 2157.2 87644.0 88153.6 88792.0 90458.0 91644.1 10984.8 11020.6 11136.6 11360.9 11696.4 14833.7 14936.4 14946.7 15057.5 15197.4 7008.4 7167.1 7195.5 7417.7 7438.1 6353.3 6415.9 6531.7 6613.6 6625.4 6952.5 6994.2 7031.6 7055.8 7072.8 2003.5 2029.6 2040.0 2080.1 2197.2 852.9 878.4 883.9 886.7 909.4 16906.2 16953.7 17227.1 17325.7 17951.0 861.8 870.6 872.5 876.8 887.7 9338.3 9762.1 9781.6 9791.0 9846.0 355467.0 356739.0 361594.0 361889.0 361932.0 74864.6 77240.6 77358.0 78348.6 79349.2 1023.1 1051.0 1075.9 1078.6 1081.7 14645.3 14762.9 14833.4 14963.9 15349.1 38012.4 38858.6 39049.2 39450.2 39926.8 48649.0 48663.7 48794.3 49009.5 49327.8 7878.4 8112.7 8176.3 8182.6 8519.0 12544.8 12659.4 12788.1 13018.1 13090.8 9911.7 10119.5 10170.5 10203.8 10326.0 9758.2 9932.1 10010.2 10018.9 10048.6 11110.9 11432.2 11461.6 11936.7 11949.5 7448.3 7852.1 8185.6 8212.8 8400.6 10849.3 10872.3 10873.2 10891.9 11320.9 22:32:47 INFO - PID 16878 | 22:32:47 INFO - PID 16878 | [#3] mootools.html Cycles:180 Average:6362.42 Median:4118.49 stddev:4055.79 (98.5%) stddev-sans-first:4049.13 22:32:47 INFO - PID 16878 | Values: 1271.8 1336.2 1348.9 1349.0 1351.8 9916.2 10244.6 10399.2 10415.8 10461.2 10236.7 10489.2 10506.3 10508.8 10518.6 2267.3 2317.4 2327.4 2331.0 2340.1 2247.6 2280.4 2298.2 2302.2 2312.3 2215.9 2221.3 2290.4 2292.3 2300.2 2148.7 2151.7 2196.4 2197.2 2204.3 1993.7 2079.7 2090.3 2272.9 2283.1 9894.1 9910.0 9944.7 9991.7 10004.5 5488.3 5716.3 5719.7 5727.9 5739.2 3034.5 3269.6 3314.8 3343.8 3346.9 1088.9 1112.4 1122.9 1147.7 1170.4 14965.9 15070.8 15227.8 15265.0 15270.6 4888.8 5012.2 5076.2 5126.0 5151.1 12373.5 12387.1 12437.9 12450.2 12469.4 5575.0 5619.2 5637.9 5639.1 5648.4 4847.8 4944.2 4980.1 5062.8 5068.9 4115.3 4121.6 4206.3 4216.2 4253.9 1314.7 1366.9 1367.3 1391.2 1397.6 741.0 761.6 764.5 771.5 775.6 5726.5 5780.1 5842.9 5899.9 5909.1 541.7 542.0 547.3 551.0 557.1 3526.2 3546.9 3611.3 3995.8 4041.5 12741.6 13083.9 13223.7 13249.7 13294.8 13011.3 13037.0 13066.3 13083.7 13129.7 6897.1 7172.8 7445.8 7481.0 7488.3 6356.8 6407.5 6601.9 6609.0 6624.2 11537.4 11702.3 11709.8 12054.7 12065.5 11702.5 11931.4 12128.3 12160.8 12216.8 8053.3 8286.0 8299.4 8312.7 8314.9 9394.7 9395.3 9455.4 9477.9 9530.9 8150.8 8181.2 8182.2 8227.6 8312.6 7977.1 7994.8 7996.4 7996.4 8073.5 7262.6 7308.9 7357.9 7359.6 7642.3 5082.1 5133.8 5221.5 5249.3 5331.3 5638.3 5661.5 5713.1 5783.1 5875.7 22:32:47 INFO - PID 16878 | 22:32:47 INFO - PID 16878 | [#4] prototype.html Cycles:180 Average:4670.27 Median:5354.21 stddev:1393.21 (26.0%) stddev-sans-first:1359.24 22:32:47 INFO - PID 16878 | Values: 371.3 389.6 395.2 397.7 398.2 5288.6 5412.9 5429.8 5452.1 5460.6 5190.7 5312.8 5314.6 5331.4 5332.5 4027.7 4030.6 4033.4 4043.6 4043.9 3887.2 4026.3 4032.9 4044.1 4045.1 3991.1 3991.8 3991.9 3996.0 4010.1 3998.8 4000.2 4007.6 4014.9 4027.2 3505.9 3511.3 3515.5 3519.6 3523.2 5193.4 5196.3 5207.9 5232.4 5251.6 4701.6 4703.6 4707.3 4710.2 4724.9 5539.6 5586.8 5637.4 5645.5 5649.3 3909.0 3914.5 3931.6 3933.4 3941.9 5784.6 5961.9 5969.8 5992.4 6022.7 4023.4 4028.8 4034.9 4055.1 4057.5 4077.4 4094.4 4103.5 4103.6 4106.2 4646.9 4648.2 4690.2 4719.5 4722.3 5606.4 5630.5 5633.6 5663.6 5666.3 1390.2 1395.9 1414.7 1415.3 1422.0 897.8 938.0 947.9 958.9 960.8 4883.2 4920.7 4931.0 4934.3 4940.9 5807.2 5813.0 5840.6 5845.9 5852.2 4799.2 4806.4 4893.3 4905.9 4908.4 3057.8 3089.6 3090.8 3098.5 3117.8 5533.7 5541.8 5541.8 5556.0 5557.4 5776.3 6009.2 6024.4 6057.7 6072.7 5504.8 5526.8 5531.6 5537.0 5563.6 5724.3 5826.5 5848.6 5883.3 5907.3 5808.3 5812.2 5813.2 5815.8 5816.0 5375.9 5500.0 5546.5 5548.4 5560.8 4020.0 4045.4 4056.6 4058.1 4074.7 5846.8 5909.4 5951.3 5956.8 5969.2 5667.2 5671.0 5692.5 5706.7 5710.7 5676.8 5678.1 5707.3 5721.7 5727.7 5469.9 5618.3 5623.5 5663.5 5664.3 5741.6 5750.2 5762.0 5762.2 5767.9 5486.8 5592.2 5593.2 5620.7 5624.3 22:32:47 INFO - PID 16878 | 22:32:47 INFO - PID 16878 | [#5] yui.html Cycles:180 Average:15340.34 Median:3653.48 stddev:18087.58 (495.1%) stddev-sans-first:18104.70 22:32:47 INFO - PID 16878 | Values: 655.5 661.4 731.5 771.6 790.3 11438.8 12368.9 13294.3 13956.9 14177.9 14469.0 15140.2 15182.5 15204.5 15408.9 835.3 859.8 863.5 864.2 868.0 907.7 908.8 915.6 916.3 916.9 953.5 958.8 959.4 959.6 962.4 946.8 950.9 951.6 952.7 952.8 692.7 695.9 697.5 697.6 699.2 14277.9 14673.0 14758.1 14933.9 15034.9 14986.9 15090.2 15375.2 15873.0 16165.3 12230.1 12409.9 12455.4 12534.2 12586.7 3060.4 3076.7 3078.9 3082.5 3091.0 71511.0 71697.3 71842.3 72697.6 73364.6 12007.6 12469.1 12629.5 12629.7 12641.4 21070.7 22514.8 22707.9 22844.2 22896.8 6359.5 6377.7 6612.1 6613.5 6619.6 3066.8 3099.5 3125.3 3129.0 3138.1 3623.1 3651.8 3655.2 3695.0 3752.6 734.2 747.5 755.1 756.0 757.5 613.7 618.1 628.3 632.0 647.7 9587.9 10170.3 10497.8 10711.3 11143.4 568.5 573.6 577.1 577.6 578.8 4478.2 4599.0 4600.7 4776.2 4798.9 59635.0 59802.0 60810.0 63449.0 63604.0 52557.5 56326.0 57079.7 57303.4 57854.7 46844.0 46990.3 47314.5 48326.0 48899.8 10530.0 11118.1 11169.6 11234.0 11349.9 24596.1 24796.9 25108.4 25316.4 25644.6 42155.4 43129.1 44011.0 44341.3 45208.0 14063.7 14080.4 14337.1 14551.6 14561.8 14190.6 14434.2 14449.7 14565.1 14820.0 12947.1 13104.5 13130.1 13133.5 13365.1 14120.8 14336.7 14374.9 14478.3 14522.4 14002.9 14292.8 14335.6 14393.6 14636.6 9023.6 9084.8 9223.9 9237.6 9486.7 10326.5 10428.0 10681.4 10948.6 10999.8 22:32:47 INFO - PID 16878 | -------- Summary: end -------- 22:32:47 INFO - PID 16878 | 22:32:48 INFO - TEST-INFO | 16878: exit 0 22:32:48 INFO - TEST-OK | dromaeo_css | took 1117608ms 22:32:48 INFO - TEST-START | kraken 22:32:48 INFO - operating with platform_type : linux_ 22:32:48 INFO - Initialising browser for kraken test... 22:32:48 INFO - TEST-INFO | started process 17286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHZPWnG/profile http://localhost:52453/getInfo.html) 22:32:48 INFO - PID 17286 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 22:32:51 INFO - PID 17286 | __metrics Screen width/height:1600/1200 22:32:51 INFO - PID 17286 | colorDepth:24 22:32:51 INFO - PID 17286 | Browser inner width/height: 1024/695 22:32:51 INFO - PID 17286 | __metrics 22:32:53 INFO - TEST-INFO | 17286: exit 0 22:32:53 INFO - Browser initialized. 22:32:53 INFO - Running cycle 1/1 for kraken test... 22:32:53 INFO - TEST-INFO | started process 17466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHZPWnG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:33:04 INFO - PID 17466 | RSS: Main: 169480192 22:33:04 INFO - PID 17466 | 22:33:07 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52453/tests/kraken/driver.html?testName=audio-beat-detection) 22:33:08 INFO - PID 17466 | RSS: Main: 174575616 22:33:08 INFO - PID 17466 | 22:33:11 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52453/tests/kraken/driver.html?testName=audio-dft) 22:33:12 INFO - PID 17466 | RSS: Main: 173948928 22:33:12 INFO - PID 17466 | 22:33:14 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52453/tests/kraken/driver.html?testName=audio-fft) 22:33:15 INFO - PID 17466 | RSS: Main: 169185280 22:33:15 INFO - PID 17466 | 22:33:17 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52453/tests/kraken/driver.html?testName=audio-oscillator) 22:33:18 INFO - PID 17466 | RSS: Main: 169672704 22:33:18 INFO - PID 17466 | 22:33:20 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52453/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:33:21 INFO - PID 17466 | RSS: Main: 170254336 22:33:21 INFO - PID 17466 | 22:33:24 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52453/tests/kraken/driver.html?testName=imaging-darkroom) 22:33:24 INFO - PID 17466 | RSS: Main: 174063616 22:33:24 INFO - PID 17466 | 22:33:28 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52453/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:29 INFO - PID 17466 | RSS: Main: 171712512 22:33:29 INFO - PID 17466 | 22:33:31 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52453/tests/kraken/driver.html?testName=json-parse-financial) 22:33:32 INFO - PID 17466 | RSS: Main: 172552192 22:33:32 INFO - PID 17466 | 22:33:34 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52453/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:33:34 INFO - PID 17466 | RSS: Main: 172367872 22:33:34 INFO - PID 17466 | 22:33:36 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:33:37 INFO - PID 17466 | RSS: Main: 172613632 22:33:37 INFO - PID 17466 | 22:33:39 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:33:40 INFO - PID 17466 | RSS: Main: 172433408 22:33:40 INFO - PID 17466 | 22:33:42 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:33:43 INFO - PID 17466 | RSS: Main: 173019136 22:33:43 INFO - PID 17466 | 22:33:46 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:33:47 INFO - PID 17466 | RSS: Main: 172744704 22:33:47 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52453/tests/kraken/driver.html?testName=ai-astar) 22:33:49 INFO - PID 17466 | RSS: Main: 173674496 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | __start_tp_report 22:33:49 INFO - PID 17466 | _x_x_mozilla_page_load 22:33:49 INFO - PID 17466 | _x_x_mozilla_page_load_details 22:33:49 INFO - PID 17466 | |i|pagename|runs| 22:33:49 INFO - PID 17466 | |0;ai-astar;104;112;110;111;113;111;111;112;113;112 22:33:49 INFO - PID 17466 | |1;audio-beat-detection;153;125;131;180;124;123;123;129;160;125 22:33:49 INFO - PID 17466 | |2;audio-dft;164;167;164;162;163;165;166;166;164;165 22:33:49 INFO - PID 17466 | |3;audio-fft;76;78;76;104;75;75;75;77;104;77 22:33:49 INFO - PID 17466 | |4;audio-oscillator;85;84;107;83;85;85;98;83;83;108 22:33:49 INFO - PID 17466 | |5;imaging-gaussian-blur;116;115;115;115;114;114;114;114;117;113 22:33:49 INFO - PID 17466 | |6;imaging-darkroom;150;150;153;150;153;152;150;152;151;152 22:33:49 INFO - PID 17466 | |7;imaging-desaturate;95;95;94;95;95;97;95;95;94;95 22:33:49 INFO - PID 17466 | |8;json-parse-financial;53;56;54;57;54;54;56;55;54;55 22:33:49 INFO - PID 17466 | |9;json-stringify-tinderbox;56;56;56;56;57;57;57;56;56;57 22:33:49 INFO - PID 17466 | |10;stanford-crypto-aes;83;91;83;93;83;82;83;84;84;87 22:33:49 INFO - PID 17466 | |11;stanford-crypto-ccm;138;136;134;135;139;137;135;137;185;141 22:33:49 INFO - PID 17466 | |12;stanford-crypto-pbkdf2;186;193;194;200;191;190;195;187;198;190 22:33:49 INFO - PID 17466 | |13;stanford-crypto-sha256-iterative;75;75;74;73;75;76;73;74;73;73 22:33:49 INFO - PID 17466 | __end_tp_report 22:33:49 INFO - PID 17466 | __start_cc_report 22:33:49 INFO - PID 17466 | _x_x_mozilla_cycle_collect,795 22:33:49 INFO - PID 17466 | __end_cc_report 22:33:49 INFO - PID 17466 | __startTimestamp1495085629422__endTimestamp 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | ------- Summary: start ------- 22:33:49 INFO - PID 17466 | Number of tests: 14 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.60 (2.3%) stddev-sans-first:1.00 22:33:49 INFO - PID 17466 | Values: 104.0 112.0 110.0 111.0 113.0 111.0 111.0 112.0 113.0 112.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:130.00 stddev:19.95 (15.3%) stddev-sans-first:20.34 22:33:49 INFO - PID 17466 | Values: 153.0 125.0 131.0 180.0 124.0 123.0 123.0 129.0 160.0 125.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 22:33:49 INFO - PID 17466 | Values: 164.0 167.0 164.0 162.0 163.0 165.0 166.0 166.0 164.0 165.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:11.80 (15.5%) stddev-sans-first:12.33 22:33:49 INFO - PID 17466 | Values: 76.0 78.0 76.0 104.0 75.0 75.0 75.0 77.0 104.0 77.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.50 stddev:10.19 (12.1%) stddev-sans-first:10.64 22:33:49 INFO - PID 17466 | Values: 85.0 84.0 107.0 83.0 85.0 85.0 98.0 83.0 83.0 108.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:1.16 (1.0%) stddev-sans-first:1.13 22:33:49 INFO - PID 17466 | Values: 116.0 115.0 115.0 115.0 114.0 114.0 114.0 114.0 117.0 113.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:152.00 stddev:1.25 (0.8%) stddev-sans-first:1.24 22:33:49 INFO - PID 17466 | Values: 150.0 150.0 153.0 150.0 153.0 152.0 150.0 152.0 151.0 152.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 22:33:49 INFO - PID 17466 | Values: 95.0 95.0 94.0 95.0 95.0 97.0 95.0 95.0 94.0 95.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.23 (2.2%) stddev-sans-first:1.12 22:33:49 INFO - PID 17466 | Values: 53.0 56.0 54.0 57.0 54.0 54.0 56.0 55.0 54.0 55.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 22:33:49 INFO - PID 17466 | Values: 56.0 56.0 56.0 56.0 57.0 57.0 57.0 56.0 56.0 57.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:3.80 (4.5%) stddev-sans-first:3.94 22:33:49 INFO - PID 17466 | Values: 83.0 91.0 83.0 93.0 83.0 82.0 83.0 84.0 84.0 87.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:137.50 stddev:15.36 (11.2%) stddev-sans-first:16.23 22:33:49 INFO - PID 17466 | Values: 138.0 136.0 134.0 135.0 139.0 137.0 135.0 137.0 185.0 141.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.40 Median:193.50 stddev:4.50 (2.3%) stddev-sans-first:4.14 22:33:49 INFO - PID 17466 | Values: 186.0 193.0 194.0 200.0 191.0 190.0 195.0 187.0 198.0 190.0 22:33:49 INFO - PID 17466 | 22:33:49 INFO - PID 17466 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:74.50 stddev:1.10 (1.5%) stddev-sans-first:1.12 22:33:49 INFO - PID 17466 | Values: 75.0 75.0 74.0 73.0 75.0 76.0 73.0 74.0 73.0 73.0 22:33:49 INFO - PID 17466 | -------- Summary: end -------- 22:33:49 INFO - PID 17466 | 22:33:50 INFO - TEST-INFO | 17466: exit 0 22:33:50 INFO - TEST-OK | kraken | took 62301ms 22:33:50 INFO - SUITE-END | took 1179s 22:33:50 INFO - Completed test suite (00:19:39) 22:33:50 INFO - javascript benchmark 22:33:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6701.610687313833, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2714.402831377097, 2727.3045373429773, 2755.4489102179555, 2759.0481283957033, 2774.042955180462, 5153.665011774232, 5158.123119069758, 5185.585153187745, 5216.139337009394, 5232.1366974449265, 5192.1432963560965, 5225.320708307924, 5230.6600070995355, 5295.735213239342, 5310.0441920454305, 4354.1074079813725, 4522.072975040125, 4607.539246075399, 4638.2115040443205, 4651.302304654295, 4637.513061128567, 4676.532346765313, 4687.01572669738, 4713.858584242478, 4721.716696998174, 4591.494935557086, 4598.310253461974, 4610.124076425502, 4672.415948006499, 4677.92983105252, 4658.18481765693, 4672.57946784791, 4696.342512048316, 4703.435587729495, 4714.434267887841, 4575.382323386333, 4578.381918441001, 4611.3313569532565, 4617.099665565216, 4652.906941861143, 5104.489551044866, 5112.977404519111, 5157.974210128963, 5170.508801663836, 5185.248139019821, 5575.721213939328, 5625.437456254383, 5625.746841392147, 5630.90197411505, 5665.405132461115, 5612.41069687681, 5710.685912274823, 5714.171445140431, 5716.256886604757, 5725.5419566435, 5286.60350473716, 5297.814576489882, 5311.336082989626, 5322.680639161663, 5360.088784906575, 5673.234113394721, 5741.45456181662, 5780.1907732917425, 5809.941900581025, 5815.563832712563, 5595.832125036255, 5597.272354593958, 5608.719564021782, 5609.607327487037, 5624.100143976944, 5588.776448942078, 5591.4688104629995, 5640.0, 5658.7170641467765, 5671.035923892866, 5553.0559804832465, 5658.858528536737, 5664.631798933056, 5683.2895888014, 5701.116326969326, 5559.221708960748, 5585.078462053797, 5613.129964855454, 5631.831045068655, 5647.322321321386, 4712.5994290485005, 4751.358566593535, 4754.120487709784, 4780.402449693788, 4827.758612069382, 4078.5513593504693, 4112.753234805921, 4116.135611521554, 4122.031322639177, 4160.334346504545, 4676.859694209179, 4747.881302967454, 4762.64280178988, 4819.734914579732, 4832.4684284728655, 5654.491095801398, 5676.0, 5689.68706721126, 5725.971370143206, 5729.226554415184, 4768.785404656799, 4780.426348838162, 4792.353032340589, 4799.6400269979895, 4833.347498087784, 4880.292357608198, 4955.1823949048, 4982.177940639754, 4998.2002879539095, 5006.549410553068, 5226.614947039114, 5245.029669511153, 5270.130428479258, 5276.81531146408, 5282.84151475441, 5683.119116536944, 5689.288838895138, 5697.287839020122, 5705.37240903492, 5712.257406537124, 5177.974110129425, 5355.384130825005, 5363.731813409236, 5368.597355198298, 5404.7567859445635, 5575.776968921197, 5582.190582365615, 5661.660300381825, 5663.377028526941, 5665.461781130786, 5682.744276507485, 5685.630434021776, 5698.886022279448, 5727.971360143172, 5750.971245143747, 5348.438413966477, 5418.566514678895, 5478.342598888, 5498.80754173602, 5542.528885044816, 5451.509364157245, 5533.114701647717, 5538.9169162461785, 5550.222968784454, 5584.329880414376, 5355.357357117171, 5413.918791218056, 5430.40265570779, 5470.480304371078, 5480.095784195722, 5518.944810551843, 5525.171224316385, 5530.806421775219, 5562.694051827027, 5584.804531841366, 5358.410574836843, 5370.731463426891, 5375.3280839895015, 5380.246765452918, 5383.300170977748], "value": 5121.4628089722355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.451091382351, 737.8339873528457, 762.8054846014265, 1167.1829719196564, 1228.4717571444287, 34132.48801267983, 35002.474962875574, 35011.12472188196, 35015.82492087536, 35022.47466288004, 32964.340713185724, 33303.50044749324, 33362.33275334492, 33417.0, 33491.49762753561, 6520.869582608345, 6665.533412661116, 6806.693698783567, 7019.5788252705, 7028.086348774652, 6974.302569743036, 7050.435965122778, 7084.504084714072, 7087.255838136999, 7087.610181440019, 7025.402840758542, 7031.085958825372, 7036.929630703704, 7067.611281379522, 7071.292870712913, 6991.8601627967155, 7077.504574679774, 7078.575285482836, 7079.752208672698, 7085.220625731191, 6990.370866621977, 7048.823779405505, 7049.753258635923, 7054.611996340199, 7061.611611361373, 32248.421620919064, 32564.6743532564, 32843.343133137445, 32855.0, 32863.0, 3109.5646609474693, 3116.8597413116463, 3119.376124775054, 3137.043201823443, 3137.6391714952842, 25178.370540736443, 25185.748142518525, 25239.49521009588, 25250.368740781443, 25253.242402727763, 2567.743225677436, 2569.8843552040016, 2575.8196926215173, 2580.342012786746, 2586.7154612992554, 139735.30132349374, 140313.0, 147095.26452367668, 148434.25782871124, 148786.25606872005, 39025.80487097603, 39112.6088739109, 39142.0, 39205.80397097996, 39309.803450983134, 41002.79498602488, 41261.0, 45140.548594514294, 45413.772931135136, 45760.313595296095, 11417.828732569018, 11524.078073754079, 11578.76842463163, 11604.419779011016, 11605.825912611317, 8899.866502002475, 8951.686690965786, 8970.641174352953, 8977.057408972094, 8990.056044115274, 13120.803187952188, 13152.145110567782, 13155.144915580457, 13241.337933103307, 13342.266175360448, 5562.276904002454, 5661.801836935688, 5693.430656934273, 5720.711715313908, 5762.596618236767, 893.9106089391139, 920.406337912043, 926.6015613286216, 939.957701903416, 964.2045312616979, 20875.79124208769, 21768.78231217699, 21880.0, 21908.671369929147, 21963.121475140815, 996.820572296979, 1001.2740762946805, 1011.049613363436, 1018.5314755212537, 1024.5235965276183, 10897.509612067475, 11733.589324373606, 11764.176507644383, 11781.410929453494, 11826.94086529579, 171644.0, 172308.0, 172501.0, 173117.0, 173256.0, 40555.18889622191, 40917.79541102275, 40976.38535421971, 40994.59005409908, 41065.38401923973, 1187.8337032815414, 1227.6010296653624, 1241.757857217852, 1246.0156476383736, 1255.8179064035664, 19782.219600236047, 19908.402747917586, 20377.388678339674, 21283.36149915505, 21357.572848543252, 29075.0, 29280.0, 29367.85316073406, 29526.704732953254, 29539.55690664685, 149117.25441372723, 149438.25280873527, 149550.80165781075, 149951.0, 150097.0, 28798.0, 29523.409531809673, 29729.554056688736, 30317.635706392823, 30638.540421894137, 34831.65168348284, 35689.286214276086, 35731.0, 36086.0, 36344.45483317805, 22158.224462143746, 22861.19985800489, 23414.88292558526, 24244.0, 24429.0, 27085.59371609388, 27168.864155679887, 27860.30349241204, 28472.715272847006, 28692.282692932844, 29658.258543536584, 29768.55347169751, 30112.698873011865, 30599.388012240077, 30675.2331191722, 26196.21411357662, 26711.0, 26814.463710726068, 27001.729982699922, 28326.0, 20188.495287617927, 22718.432039199153, 22740.317790466313, 22760.544789104457, 22821.0], "value": 14425.464241021617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.8971252043246, 421.93038148705466, 423.6441389233042, 431.5210116770384, 448.65453600727443, 17369.392071277507, 18150.909245453786, 18166.0, 18244.270229190817, 19244.61510769784, 16340.346386144569, 16729.330826766945, 17878.64242715148, 18133.37332533492, 18386.908065459687, 5398.2712333834825, 5435.537979271767, 5546.473085056913, 5596.468335508121, 5599.804006859761, 5474.370447398541, 5567.359753628324, 5578.0517312057045, 5578.972105139469, 5584.441555844423, 5397.190421436777, 5511.200875873016, 5534.169874518814, 5550.888982220353, 5570.248016517779, 5422.9728851355885, 5482.835514934558, 5513.062779327524, 5541.944580554204, 5566.359868615121, 4934.185859333205, 4976.676516026483, 5020.673656212334, 5020.949790502084, 5061.013102445025, 21938.232161874257, 21983.670244946337, 22339.994700238527, 22783.886080569657, 22859.085636574517, 1660.692771837214, 1675.4722262487398, 1681.2518429298966, 1701.4045084220425, 1702.8893121947033, 14519.927400363036, 15056.623584410368, 15154.318055687521, 15228.162451065187, 15261.923690381476, 2084.5518213584, 2097.318371529244, 2117.7246957895527, 2143.98928005359, 2157.2018353209414, 87644.0, 88153.55923220344, 88792.0, 90458.0, 91644.08355916422, 10984.780304393867, 11020.614278500214, 11136.554537818396, 11360.886391135982, 11696.35670038156, 14833.70332593342, 14936.402543898339, 14946.70106597862, 15057.54827355181, 15197.392104315924, 7008.439324853999, 7167.104111986002, 7195.496315257987, 7417.666205020787, 7438.1446133694235, 6353.30113687494, 6415.871682566416, 6531.738730450824, 6613.636250006296, 6625.436837868835, 6952.478564107712, 6994.203835916276, 7031.644399126248, 7055.753048643272, 7072.787816365517, 2003.5291706448972, 2029.6245194639039, 2039.9796002039789, 2080.126346934291, 2197.1540956731774, 852.9189726975927, 878.3544095090103, 883.9381243313035, 886.6719313853915, 909.3907082254905, 16906.239219235165, 16953.745693814602, 17227.138643068047, 17325.7401138983, 17951.0, 861.7931696392945, 870.6082262981683, 872.5201139373446, 876.8027193881326, 887.7114937645291, 9338.299627527962, 9762.121409073217, 9781.608735650494, 9791.0, 9846.0, 355467.0, 356739.0, 361594.0, 361889.0, 361932.0, 74864.62567687126, 77240.61379693066, 77358.0, 78348.60825695835, 79349.20650793418, 1023.1072515845775, 1050.9527071281811, 1075.8708954925303, 1078.6224821312478, 1081.6917178604217, 14645.340959656627, 14762.852371476578, 14833.406663733329, 14963.925180374028, 15349.07905525672, 38012.429813553375, 38858.6114138855, 39049.21901561896, 39450.2109957805, 39926.80036599799, 48649.0, 48663.67372241586, 48794.26808597803, 49009.50990490049, 49327.753361232964, 7878.409119315959, 8112.675492980215, 8176.345892328718, 8182.590870456334, 8518.957405212934, 12544.811827822772, 12659.430325635185, 12788.104832661624, 13018.088733788923, 13090.80363794563, 9911.65309214174, 10119.494025298853, 10170.491475426052, 10203.795924081329, 10326.0, 9758.219342452445, 9932.056454636799, 10010.249231307827, 10018.899811002088, 10048.648297309559, 11110.944445277722, 11432.199746018032, 11461.598844040418, 11936.701582460508, 11949.462274197856, 7448.255174482509, 7852.13626501073, 8185.631646576037, 8212.753617391489, 8400.579971001547, 10849.349039057683, 10872.293300935415, 10873.184511161537, 10891.891081089088, 11320.9433952833], "value": 8781.895696831993, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.7774389481838, 1336.2316667915945, 1348.858369871163, 1348.9527866524675, 1351.8242628458302, 9916.157126644235, 10244.590216391336, 10399.168066554676, 10415.843762343562, 10461.163106951444, 10236.744081397968, 10489.213309001836, 10506.317089389184, 10508.842367364476, 10518.631847885326, 2267.2631394796717, 2317.409060689522, 2327.406511339606, 2331.0, 2340.1458467659268, 2247.5954328220914, 2280.4184932842186, 2298.241580278504, 2302.1712183613886, 2312.2600767754325, 2215.944601384962, 2221.255879280435, 2290.4273931517123, 2292.277932451281, 2300.160441438871, 2148.656215005607, 2151.6557350823873, 2196.4069701180592, 2197.2199869046417, 2204.2946257197705, 1993.651111055574, 2079.7209716024536, 2090.2579584247524, 2272.9090836366527, 2283.0981762204, 9894.109530142321, 9909.950450247703, 9944.651937182236, 9991.650292239809, 10004.54979525923, 5488.313960754906, 5716.3426205986425, 5719.656820590736, 5727.914081288784, 5739.225204597367, 3034.4689679306252, 3269.6076470823414, 3314.8176850273226, 3343.8160901150427, 3346.9497957530657, 1088.8638920134983, 1112.3993043756361, 1122.859642544682, 1147.73602071524, 1170.444039081438, 14965.850341496664, 15070.849291507164, 15227.847721522754, 15265.0, 15270.618234544114, 4888.828890988798, 5012.195609580548, 5076.162433198481, 5126.000429916131, 5151.124308867502, 12373.505059797688, 12387.07096967731, 12437.93781031089, 12450.190737602208, 12469.438875250455, 5575.0, 5619.213310136584, 5637.887242255132, 5639.125935480007, 5648.378678345379, 4847.75761211938, 4944.184209605375, 4980.103581355391, 5062.848114556569, 5068.873278168076, 4115.323504960948, 4121.649659778893, 4206.326987681956, 4216.198922204771, 4253.914921701548, 1314.7436249931172, 1366.9179849209079, 1367.3368416318078, 1391.2487256881373, 1397.5667543061684, 740.9962950185322, 761.5735188294573, 764.4763337114094, 771.5293670860883, 775.5734346109617, 5726.513246374105, 5780.104083867007, 5842.883142337129, 5899.852503687443, 5909.084091965752, 541.6885290957715, 541.9918701219485, 547.3322546493272, 550.9889802204013, 557.0863783395235, 3526.1713497328105, 3546.875859344962, 3611.3499570077115, 3995.840166393312, 4041.4948131483566, 12741.55404560836, 13083.869161308456, 13223.73552528944, 13249.735005300034, 13294.800577991338, 13011.284379359036, 13037.0, 13066.281354525592, 13083.672908177181, 13129.73740525184, 6897.137857767779, 7172.784816455514, 7445.776626701316, 7480.962595186989, 7488.251174882468, 6356.841078973062, 6407.455366293731, 6601.911001370679, 6609.0, 6624.238212605419, 11537.365444900612, 11702.29786212796, 11709.824352634547, 12054.698632534257, 12065.457054432396, 11702.473388697359, 11931.4034298283, 12128.272303661808, 12160.759600534328, 12216.816747748968, 8053.275205231557, 8286.0, 8299.419040667095, 8312.709055183039, 8314.916850831414, 9394.67118650844, 9395.2953528487, 9455.385399949257, 9477.905220947703, 9530.857037144588, 8150.75547733569, 8181.222783835526, 8182.22268884455, 8227.629756660845, 8312.584370781558, 7977.08263549676, 7994.84010319802, 7996.440249182501, 7996.440249182734, 8073.475224110414, 7262.636868156676, 7308.926910730825, 7357.889631655423, 7359.632018398952, 7642.312191902755, 5082.136036873666, 5133.820316288912, 5221.4778522149, 5249.291345668286, 5331.253624492497, 5638.323401191883, 5661.547076233974, 5713.114467257582, 5783.074708046693, 5875.676837773964], "value": 4787.781341468652, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.31492396528415, 389.6473691309365, 395.1543696489511, 397.749417866744, 398.1817365314278, 5288.60335474839, 5412.918806217905, 5429.782808687648, 5452.127659574468, 5460.645058071227, 5190.688558686482, 5312.760925758341, 5314.627976041669, 5331.386890507592, 5332.546733527645, 4027.65764909983, 4030.637242648161, 4033.394990751389, 4043.555208927016, 4043.919121617566, 3887.2225554888996, 4026.3491968293006, 4032.9395059074136, 4044.130511939932, 4045.1368942659838, 3991.1219531703123, 3991.7604943703327, 3991.9022268876, 3995.9800200998952, 4010.13782036862, 3998.8200530975887, 4000.159966407058, 4007.639312461878, 4014.9397759033636, 4027.194561087794, 3505.94741078884, 3511.315293517765, 3515.525404070469, 3519.6480351964597, 3523.154442933703, 5193.350831146106, 5196.298499702568, 5207.9479205207845, 5232.424433312332, 5251.584271235236, 4701.576858082754, 4703.623710103184, 4707.328898241143, 4710.222813235812, 4724.905501889977, 5539.612227144102, 5586.776528938837, 5637.379888212294, 5645.5483561314995, 5649.293838270216, 3908.9609103909165, 3914.4911161549103, 3931.5871833457645, 3933.370660694275, 3941.9211615767813, 5784.595078344518, 5961.91057134139, 5969.761209551612, 5992.370801065869, 6022.6687532185715, 4023.436718859362, 4028.7582745035393, 4034.939475907805, 4055.1484188320783, 4057.4725285713257, 4077.388391741203, 4094.3653733671326, 4103.466549348565, 4103.610157035077, 4106.240345536085, 4646.930296045562, 4648.233041548175, 4690.226112691368, 4719.528047195253, 4722.3235751308475, 5606.355269144101, 5630.465105814941, 5633.605647604629, 5663.6035477517, 5666.263385759825, 1390.1728471559406, 1395.874371306567, 1414.745345837759, 1415.2923538230884, 1421.9928900355433, 897.7800438892513, 937.9718608441758, 947.8720372749591, 958.9184919281939, 960.8366577681811, 4883.218685010382, 4920.704757714549, 4930.950690493121, 4934.284528743384, 4940.8764780880765, 5807.216025836458, 5813.0, 5840.620359676607, 5845.912311315334, 5852.15143804146, 4799.208130658472, 4806.375171227718, 4893.266010098514, 4905.852824415273, 4908.41099068107, 3057.755379569629, 3089.598352214198, 3090.799098058619, 3098.5352197170605, 3117.7973431726864, 5533.695646739468, 5541.750621222055, 5541.833744987657, 5555.972220138873, 5557.360903496069, 5776.306843178845, 6009.2188015557695, 6024.427679370453, 6057.727402266909, 6072.726727297282, 5504.80733174345, 5526.7892842863175, 5531.589444691658, 5536.972315138479, 5563.582731295169, 5724.313082429969, 5826.475617194473, 5848.590598658223, 5883.264591926009, 5907.261592300963, 5808.257522743075, 5812.18629391877, 5813.157092221689, 5815.76736930518, 5815.9709201453725, 5375.865603359947, 5500.0, 5546.500814926676, 5548.445155484419, 5560.833175004756, 4020.0, 4045.3931910212527, 4056.59434056592, 4058.066644671801, 4074.6536544392875, 5846.795362162304, 5909.3795151508475, 5951.303878394637, 5956.791512297049, 5969.224000879858, 5667.178259152317, 5671.0, 5692.48767610917, 5706.657600543981, 5710.685912274865, 5676.829695109153, 5678.119891416837, 5707.315122185199, 5721.656700597811, 5727.677946790935, 5469.863253418696, 5618.269624948731, 5623.522000629992, 5663.490285874126, 5664.320281566238, 5741.62679425836, 5750.223719797774, 5762.0, 5762.222100016612, 5767.942320576908, 5486.780528778804, 5592.161175823659, 5593.216949627137, 5620.690862002629, 5624.268845050117], "value": 4243.398319306798, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.5149189599698, 661.434473525136, 731.5354749733921, 771.5794891783977, 790.3361176611645, 11438.828417573743, 12368.938155309233, 13294.335283235849, 13956.930215348935, 14177.929110354447, 14469.0, 15140.24298785062, 15182.468613598527, 15204.543863684079, 15408.922955385235, 835.2941764209248, 859.8323326951247, 863.5336918064238, 864.2092485375873, 868.0408148995364, 907.6641642592217, 908.7773495493614, 915.6108653822132, 916.2532535983153, 916.8808054952847, 953.5280036381967, 958.8130314588658, 959.4291396619035, 959.5633986536144, 962.3840741925173, 946.7633091727068, 950.9286803489731, 951.6098399656108, 952.7332346942867, 952.8332541805156, 692.7194486233084, 695.8851789454734, 697.5152269172927, 697.6407150317591, 699.1854489519703, 14277.928610356985, 14673.0, 14758.114513129247, 14933.850661493354, 15034.924825375912, 14986.925065374713, 15090.17004064776, 15375.154366509838, 15873.0, 16165.272562734704, 12230.14388992771, 12409.937950310281, 12455.439505222195, 12534.185277956904, 12586.685332866751, 3060.4032213718333, 3076.7077127672837, 3078.8768449262, 3082.475979083561, 3090.98454507726, 71511.0, 71697.28302716959, 71842.2815771846, 72697.63651181763, 73364.63317683377, 12007.639770806889, 12469.127161098817, 12629.494820207088, 12629.74740505203, 12641.43113559892, 21070.683939740917, 22514.774852251594, 22707.88646056759, 22844.200452984398, 22896.7710322898, 6359.491240700733, 6377.7130029147875, 6612.07430959666, 6613.4709223262025, 6619.635920024349, 3066.7699922505903, 3099.4575949208797, 3125.281185327342, 3128.9687103128676, 3138.1370123216298, 3623.1123374772824, 3651.7626354287418, 3655.1958569114754, 3694.963050369462, 3752.62473752628, 734.2363941500886, 747.5178509861217, 755.1089714137371, 756.0322786832862, 757.473555878659, 613.6900865063114, 618.1068356225211, 628.2586547873553, 631.958922670025, 647.7247169952846, 9587.856182157273, 10170.288079834489, 10497.842532362021, 10711.25021248505, 11143.442827858575, 568.46848196936, 573.5812856614695, 577.0910815465659, 577.5754820207144, 578.8292453726077, 4478.2386994211065, 4598.954010459853, 4600.700954437951, 4776.235802271689, 4798.928016079762, 59635.0, 59802.0, 60810.0, 63449.0, 63604.0, 52557.47442525602, 56326.0, 57079.71460142673, 57303.42696572981, 57854.7107264461, 46844.0, 46990.29514557285, 47314.52685473101, 48326.03347933092, 48899.75550122298, 10530.0, 11118.110551156049, 11169.553217871195, 11234.0, 11349.943250284026, 24596.139135130186, 24796.884140213373, 25108.372290692878, 25316.367090822878, 25644.61533076968, 42155.3676694856, 43129.13741725211, 44011.0, 44341.33487997747, 45208.0, 14063.718725625225, 14080.366383512972, 14337.06809057408, 14551.563453096423, 14561.781573276197, 14190.645233869236, 14434.206118663575, 14449.711005780036, 14565.053271537316, 14820.03669761462, 12947.093703440669, 13104.541341053398, 13130.080894337305, 13133.540326088541, 13365.131266467648, 14120.78818817698, 14336.71326573442, 14374.856251437352, 14478.27608619586, 14522.419103235752, 14002.929985350009, 14292.785608216092, 14335.641608959859, 14393.568192954228, 14636.634084147981, 9023.639054437748, 9084.772880678036, 9223.86164207524, 9237.584308706259, 9486.715398538056, 10326.48367581633, 10428.0, 10681.359118452918, 10948.56205751793, 10999.780004400027], "value": 6872.0006354594525, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 110.0, 111.0, 113.0, 111.0, 111.0, 112.0, 113.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 131.0, 180.0, 124.0, 123.0, 123.0, 129.0, 160.0, 125.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 164.0, 162.0, 163.0, 165.0, 166.0, 166.0, 164.0, 165.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 104.0, 75.0, 75.0, 75.0, 77.0, 104.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 107.0, 83.0, 85.0, 85.0, 98.0, 83.0, 83.0, 108.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 117.0, 113.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 153.0, 150.0, 153.0, 152.0, 150.0, 152.0, 151.0, 152.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 97.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 54.0, 57.0, 54.0, 54.0, 56.0, 55.0, 54.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 57.0, 57.0, 57.0, 56.0, 56.0, 57.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 83.0, 93.0, 83.0, 82.0, 83.0, 84.0, 84.0, 87.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 134.0, 135.0, 139.0, 137.0, 135.0, 137.0, 185.0, 141.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 193.0, 194.0, 200.0, 191.0, 190.0, 195.0, 187.0, 198.0, 190.0], "value": 192.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 73.0, 75.0, 76.0, 73.0, 74.0, 73.0, 73.0], "value": 74.1, "unit": "score"}]}]} 22:33:50 INFO - Return code: 0 22:33:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:33:50 INFO - # TBPL SUCCESS # 22:33:50 INFO - Running post-action listener: _resource_record_post_action 22:33:50 INFO - [mozharness: 2017-05-18 05:33:50.707434Z] Finished run-tests step (success) 22:33:50 INFO - Running post-run listener: _resource_record_post_run 22:33:50 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 221184; Write bytes: 423776256; Read time: 52; Write time: 292556 22:33:50 INFO - TinderboxPrint: CPU usage
13.3% 22:33:50 INFO - TinderboxPrint: I/O read bytes / time
221,184 / 52 22:33:50 INFO - TinderboxPrint: I/O write bytes / time
423,776,256 / 292,556 22:33:50 INFO - TinderboxPrint: CPU idle
8,286.5 (86.7%) 22:33:50 INFO - TinderboxPrint: CPU user
1,218.7 (12.7%) 22:33:50 INFO - TinderboxPrint: Swap in / out
0 / 0 22:33:50 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 101257216; Read time: 0; Write time: 99140 22:33:50 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 221184; Write bytes: 322519040; Read time: 52; Write time: 193416 22:33:51 INFO - Running post-run listener: _upload_blobber_files 22:33:51 INFO - Blob upload gear active. 22:33:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:33:51 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 22:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:33:51 INFO - (blobuploader) - INFO - Open directory for files ... 22:33:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:33:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:33:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:52 INFO - (blobuploader) - INFO - Done attempting. 22:33:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:33:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:33:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:53 INFO - (blobuploader) - INFO - Done attempting. 22:33:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:33:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:33:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:56 INFO - (blobuploader) - INFO - Done attempting. 22:33:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:33:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:33:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:57 INFO - (blobuploader) - INFO - Done attempting. 22:33:57 INFO - (blobuploader) - INFO - Iteration through files over. 22:33:57 INFO - Return code: 0 22:33:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:33:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:33:57 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/039d37b7b6454d2b5022ad74ab77591e4da5b4100d0253dbf2fe8a6fc4ff386e9b9c5166156bf27593ed1c12687ae9950b3f4890e5082dae471978763c76697e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adcdec0ab21f08bcdfd9463adf757fb3c92e5bb035226b3b7483e8a13f6a83fc1f927400ac59707ae78bf66118e119edc033524fabce9efff562a6bf0aa9ca52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df65d8d3f197886cc5515a6421ebad3a09dbbbf260338022fa3f9b25ab9e01cfb2ebd0f9b6a559315df1e22a8a36a0c20342b1b88f2d641a6f4c751ad62c1a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aba7750b33ef41363efeed5e4d9eab593d3719db977b8439d430dfbe5d19d641f2971bd785ece0a7217279948973071e44e14c2e8e38b8e75a6e847c45f123f3"} 22:33:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:33:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:33:57 INFO - Contents: 22:33:57 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/039d37b7b6454d2b5022ad74ab77591e4da5b4100d0253dbf2fe8a6fc4ff386e9b9c5166156bf27593ed1c12687ae9950b3f4890e5082dae471978763c76697e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adcdec0ab21f08bcdfd9463adf757fb3c92e5bb035226b3b7483e8a13f6a83fc1f927400ac59707ae78bf66118e119edc033524fabce9efff562a6bf0aa9ca52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df65d8d3f197886cc5515a6421ebad3a09dbbbf260338022fa3f9b25ab9e01cfb2ebd0f9b6a559315df1e22a8a36a0c20342b1b88f2d641a6f4c751ad62c1a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aba7750b33ef41363efeed5e4d9eab593d3719db977b8439d430dfbe5d19d641f2971bd785ece0a7217279948973071e44e14c2e8e38b8e75a6e847c45f123f3"} 22:33:57 INFO - Running post-run listener: copy_logs_to_upload_dir 22:33:57 INFO - Copying logs to upload dir... 22:33:57 INFO - mkdir: /builds/slave/test/build/upload/logs 22:33:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.168061 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-05-17 22:33:57.280460) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 22:33:57.284040) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/039d37b7b6454d2b5022ad74ab77591e4da5b4100d0253dbf2fe8a6fc4ff386e9b9c5166156bf27593ed1c12687ae9950b3f4890e5082dae471978763c76697e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adcdec0ab21f08bcdfd9463adf757fb3c92e5bb035226b3b7483e8a13f6a83fc1f927400ac59707ae78bf66118e119edc033524fabce9efff562a6bf0aa9ca52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df65d8d3f197886cc5515a6421ebad3a09dbbbf260338022fa3f9b25ab9e01cfb2ebd0f9b6a559315df1e22a8a36a0c20342b1b88f2d641a6f4c751ad62c1a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aba7750b33ef41363efeed5e4d9eab593d3719db977b8439d430dfbe5d19d641f2971bd785ece0a7217279948973071e44e14c2e8e38b8e75a6e847c45f123f3"} build_url:https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/PgcfRhxQQ_aS-nMtQEMpNw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/039d37b7b6454d2b5022ad74ab77591e4da5b4100d0253dbf2fe8a6fc4ff386e9b9c5166156bf27593ed1c12687ae9950b3f4890e5082dae471978763c76697e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adcdec0ab21f08bcdfd9463adf757fb3c92e5bb035226b3b7483e8a13f6a83fc1f927400ac59707ae78bf66118e119edc033524fabce9efff562a6bf0aa9ca52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df65d8d3f197886cc5515a6421ebad3a09dbbbf260338022fa3f9b25ab9e01cfb2ebd0f9b6a559315df1e22a8a36a0c20342b1b88f2d641a6f4c751ad62c1a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aba7750b33ef41363efeed5e4d9eab593d3719db977b8439d430dfbe5d19d641f2971bd785ece0a7217279948973071e44e14c2e8e38b8e75a6e847c45f123f3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 22:33:57.309257) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:33:57.309867) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1495077154.220235-1278839784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:33:57.396698) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 22:33:57.397092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 22:33:57.397473) ========= ========= Total master_lag: 0.15 =========