builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-087 starttime: 1494982401.99 results: success (0) revision: 41958333867b0f537271dbd4cb4ba9e8a67a85a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:21.989980) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:21.990491) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:21.990848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.024546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.024865) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-16 17:53:22-- 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% 40.7M=0s 2017-05-16 17:53:22 (40.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128088 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.166226) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.166639) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017954 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.216444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.216818) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 41958333867b0f537271dbd4cb4ba9e8a67a85a8 --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 41958333867b0f537271dbd4cb4ba9e8a67a85a8 --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=ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-16 17:53:22,325 truncating revision to first 12 chars 2017-05-16 17:53:22,326 Setting DEBUG logging. 2017-05-16 17:53:22,326 attempt 1/10 2017-05-16 17:53:22,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/41958333867b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-16 17:53:22,674 unpacking tar archive at: mozilla-central-41958333867b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653094 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.890386) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.890706) ========= script_repo_revision: 41958333867b0f537271dbd4cb4ba9e8a67a85a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.891090) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.891409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 17:53:22.906773) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-05-16 17:53:22.907083) ========= /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=ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:53:23 INFO - MultiFileLogger online at 20170516 17:53:23 in /builds/slave/test 17:53:23 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 17:53:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:53:23 INFO - {'append_to_log': False, 17:53:23 INFO - 'base_work_dir': '/builds/slave/test', 17:53:23 INFO - 'blob_upload_branch': 'Firefox', 17:53:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:53:23 INFO - 'branch': 'Firefox', 17:53:23 INFO - 'buildbot_json_path': 'buildprops.json', 17:53:23 INFO - 'config_files': ('talos/linux_config.py',), 17:53:23 INFO - 'default_actions': ('clobber', 17:53:23 INFO - 'read-buildbot-config', 17:53:23 INFO - 'download-and-extract', 17:53:23 INFO - 'populate-webroot', 17:53:23 INFO - 'create-virtualenv', 17:53:23 INFO - 'install', 17:53:23 INFO - 'run-tests'), 17:53:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:53:23 INFO - 'download_minidump_stackwalk': True, 17:53:23 INFO - 'download_symbols': 'ondemand', 17:53:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:53:23 INFO - 'tooltool.py': '/tools/tooltool.py', 17:53:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:53:23 INFO - '/tools/misc-python/virtualenv.py')}, 17:53:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:53:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:53:23 INFO - 'gecko_profile': False, 17:53:23 INFO - 'gecko_profile_interval': 0, 17:53:23 INFO - 'installer_path': 'installer.exe', 17:53:23 INFO - 'log_level': 'info', 17:53:23 INFO - 'log_name': 'talos', 17:53:23 INFO - 'log_to_console': True, 17:53:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:53:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:53:23 INFO - 'opt_config_files': (), 17:53:23 INFO - 'pip_index': False, 17:53:23 INFO - 'suite': 'dromaeojs-e10s', 17:53:23 INFO - 'system_bits': '32', 17:53:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:53:23 INFO - 'title': 'talos-linux64-ix-087', 17:53:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:53:23 INFO - 'use_talos_json': True, 17:53:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:53:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:53:23 INFO - 'work_dir': 'build'} 17:53:23 INFO - [mozharness: 2017-05-17 00:53:23.123265Z] Running clobber step. 17:53:23 INFO - Running pre-action listener: _resource_record_pre_action 17:53:23 INFO - Running main action method: clobber 17:53:23 INFO - rmtree: /builds/slave/test/build 17:53:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:53:24 INFO - Running post-action listener: _resource_record_post_action 17:53:24 INFO - [mozharness: 2017-05-17 00:53:24.048400Z] Finished clobber step (success) 17:53:24 INFO - [mozharness: 2017-05-17 00:53:24.048500Z] Running read-buildbot-config step. 17:53:24 INFO - Running pre-action listener: _resource_record_pre_action 17:53:24 INFO - Running main action method: read_buildbot_config 17:53:24 INFO - Using buildbot properties: 17:53:24 INFO - { 17:53:24 INFO - "project": "", 17:53:24 INFO - "product": "firefox", 17:53:24 INFO - "who": "ryanvm@gmail.com", 17:53:24 INFO - "installer_path": "public/build/target.tar.bz2", 17:53:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:53:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:53:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:53:24 INFO - "stage_platform": "linux64-stylo", 17:53:24 INFO - "basedir": "/builds/slave/test", 17:53:24 INFO - "buildnumber": 92, 17:53:24 INFO - "platform": "ubuntu64_hw_stylo", 17:53:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:53:24 INFO - "slavebuilddir": "test", 17:53:24 INFO - "taskId": "QltLxxptRc6kV5AHtYOKQA", 17:53:24 INFO - "branch": "mozilla-central", 17:53:24 INFO - "script_repo_revision": "production", 17:53:24 INFO - "revision": "41958333867b0f537271dbd4cb4ba9e8a67a85a8", 17:53:24 INFO - "slavename": "talos-linux64-ix-087", 17:53:24 INFO - "repo_path": "mozilla-central" 17:53:24 INFO - } 17:53:24 INFO - Finding installer, test and symbols from parent task. 17:53:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QltLxxptRc6kV5AHtYOKQA'}, attempt #1 17:53:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QltLxxptRc6kV5AHtYOKQA'}, attempt #1 17:53:24 INFO - Task dependencies: ZnMw7_PfQZmCuXgwMjPBEQ 17:53:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ'}, attempt #1 17:53:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.tar.bz2 17:53:25 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/test_packages.json 17:53:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.crashreporter-symbols.zip 17:53:25 INFO - Running post-action listener: _resource_record_post_action 17:53:25 INFO - [mozharness: 2017-05-17 00:53:25.386822Z] Finished read-buildbot-config step (success) 17:53:25 INFO - [mozharness: 2017-05-17 00:53:25.387043Z] Running download-and-extract step. 17:53:25 INFO - Running pre-action listener: _resource_record_pre_action 17:53:25 INFO - Running main action method: download_and_extract 17:53:25 INFO - mkdir: /builds/slave/test/build/tests 17:53:25 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')]} 17:53:25 INFO - trying https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.test_packages.json 17:53:25 INFO - Downloading https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:53:25 INFO - Downloaded 986 bytes. 17:53:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:53:25 INFO - Using the following test package requirements: 17:53:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:53:25 INFO - u'common': [u'target.common.tests.zip'], 17:53:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:53:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:53:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:53:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:53:25 INFO - u'mozbase': [u'target.common.tests.zip'], 17:53:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:53:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:53:25 INFO - u'web-platform': [u'target.common.tests.zip', 17:53:25 INFO - u'target.web-platform.tests.zip'], 17:53:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:53:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:53:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.common.tests.zip 17:53:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:53:25 INFO - Fetch https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.common.tests.zip into memory 17:53:29 INFO - Content-Length response header: 62450170 17:53:29 INFO - Bytes received: 62450170 17:53:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:53:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.common.tests.zip 17:53:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:53:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.common.tests.zip into memory 17:53:43 INFO - Content-Length response header: 62450170 17:53:43 INFO - Bytes received: 62450170 17:53:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.talos.tests.zip 17:53:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:53:54 INFO - Fetch https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.talos.tests.zip into memory 17:53:55 INFO - Content-Length response header: 14410069 17:53:55 INFO - Bytes received: 14410069 17:53:56 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')]} 17:53:56 INFO - trying https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.tar.bz2 17:53:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:53:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:53:59 INFO - Downloaded 64899567 bytes. 17:53:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.tar.bz2 17:53:59 INFO - mkdir: /builds/slave/test/properties 17:53:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:53:59 INFO - Writing to file /builds/slave/test/properties/build_url 17:53:59 INFO - Contents: 17:53:59 INFO - build_url:https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.tar.bz2 17:53:59 INFO - Running post-action listener: _resource_record_post_action 17:53:59 INFO - Running post-action listener: set_extra_try_arguments 17:53:59 INFO - [mozharness: 2017-05-17 00:53:59.982788Z] Finished download-and-extract step (success) 17:53:59 INFO - [mozharness: 2017-05-17 00:53:59.983018Z] Running populate-webroot step. 17:53:59 INFO - Running pre-action listener: _resource_record_pre_action 17:53:59 INFO - Running main action method: populate_webroot 17:53:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:53:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:53:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:53:59 INFO - '--tppagecycles', 17:53:59 INFO - '7'], 17:53:59 INFO - 'tests': ['tsvgm']}}, 17:53:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:53:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:53:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:53:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:53:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:53:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:53:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:53:59 INFO - 'talos_options': ['--disable-e10s'], 17:53:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:53:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:53:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:53:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:53:59 INFO - 'talos_options': ['--disable-e10s'], 17:53:59 INFO - 'tests': ['damp', 'tps']}, 17:53:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:53:59 INFO - 'tests': ['damp', 'tps']}, 17:53:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:53:59 INFO - 'tests': ['dromaeo_dom']}, 17:53:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:53:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:53:59 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:53:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:53:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:53:59 INFO - 'tests': ['ts_paint', 'tp5o']}, 17:53:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:53:59 INFO - 'tests': ['a11yr', 17:53:59 INFO - 'ts_paint', 17:53:59 INFO - 'tpaint', 17:53:59 INFO - 'sessionrestore', 17:53:59 INFO - 'sessionrestore_no_auto_restore', 17:53:59 INFO - 'tabpaint']}, 17:53:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:53:59 INFO - 'ts_paint', 17:53:59 INFO - 'tpaint', 17:53:59 INFO - 'sessionrestore', 17:53:59 INFO - 'sessionrestore_no_auto_restore', 17:53:59 INFO - 'tabpaint']}, 17:53:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:53:59 INFO - 'ts_paint', 17:53:59 INFO - 'tpaint', 17:53:59 INFO - 'sessionrestore', 17:53:59 INFO - 'sessionrestore_no_auto_restore', 17:53:59 INFO - 'tabpaint']}, 17:53:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:53:59 INFO - 'ts_paint', 17:53:59 INFO - 'tpaint', 17:53:59 INFO - 'sessionrestore', 17:53:59 INFO - 'sessionrestore_no_auto_restore', 17:54:00 INFO - 'tabpaint']}, 17:54:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['a11yr', 17:54:00 INFO - 'ts_paint', 17:54:00 INFO - 'tpaint', 17:54:00 INFO - 'sessionrestore', 17:54:00 INFO - 'sessionrestore_no_auto_restore', 17:54:00 INFO - 'tabpaint']}, 17:54:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['a11yr', 17:54:00 INFO - 'ts_paint', 17:54:00 INFO - 'tpaint', 17:54:00 INFO - 'sessionrestore', 17:54:00 INFO - 'sessionrestore_no_auto_restore', 17:54:00 INFO - 'tabpaint']}, 17:54:00 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:54:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:54:00 INFO - 'bloom_basic_ref']}, 17:54:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['tsvgx', 17:54:00 INFO - 'tsvgr_opacity', 17:54:00 INFO - 'tart', 17:54:00 INFO - 'tscrollx', 17:54:00 INFO - 'cart', 17:54:00 INFO - 'tsvg_static']}, 17:54:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:54:00 INFO - 'tsvgr_opacity', 17:54:00 INFO - 'tart', 17:54:00 INFO - 'tscrollx', 17:54:00 INFO - 'cart', 17:54:00 INFO - 'tsvg_static']}, 17:54:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:54:00 INFO - 'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['tp5o']}, 17:54:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:54:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:54:00 INFO - 'talos_options': ['--disable-e10s', 17:54:00 INFO - '--xperf_path', 17:54:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:54:00 INFO - 'tests': ['tp5n']}, 17:54:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:54:00 INFO - 'talos_options': ['--xperf_path', 17:54:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:54:00 INFO - 'tests': ['tp5n']}}, 17:54:00 INFO - 'talos.zip': {'path': '', 17:54:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:54:00 INFO - Running post-action listener: _resource_record_post_action 17:54:00 INFO - [mozharness: 2017-05-17 00:54:00.003527Z] Finished populate-webroot step (success) 17:54:00 INFO - [mozharness: 2017-05-17 00:54:00.003616Z] Running create-virtualenv step. 17:54:00 INFO - Running pre-action listener: _resource_record_pre_action 17:54:00 INFO - Running main action method: create_virtualenv 17:54:00 INFO - Creating virtualenv /builds/slave/test/build/venv 17:54:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:54:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:54:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:54:00 INFO - Using real prefix '/usr' 17:54:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:54:00 INFO - Installing distribute.............................................................................................................................................................................................done. 17:54:02 INFO - Installing pip.................done. 17:54:02 INFO - Return code: 0 17:54:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:54:02 INFO - Reading from file tmpfile_stdout 17:54:02 INFO - Output received: 17:54:02 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) 17:54:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:54:02 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')]} 17:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:02 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')]} 17:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:02 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 0x13081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', '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 17:54:02 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 17:54:02 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 17:54:02 INFO - Using env: {'DISPLAY': ':0', 17:54:02 INFO - 'HOME': '/home/cltbld', 17:54:02 INFO - 'LANG': 'en_US.UTF-8', 17:54:02 INFO - 'LANGUAGE': 'en_US:en', 17:54:02 INFO - 'LOGNAME': 'cltbld', 17:54:02 INFO - 'MAIL': '/var/mail/cltbld', 17:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:02 INFO - 'MOZ_NO_REMOTE': '1', 17:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:02 INFO - 'NO_EM_RESTART': '1', 17:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:02 INFO - 'PWD': '/builds/slave/test', 17:54:02 INFO - 'SHELL': '/bin/bash', 17:54:02 INFO - 'SHLVL': '1', 17:54:02 INFO - 'TERM': 'linux', 17:54:02 INFO - 'TMOUT': '86400', 17:54:02 INFO - 'USER': 'cltbld', 17:54:02 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:02 INFO - '_': '/tools/buildbot/bin/python'} 17:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:02 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 17:54:02 INFO - Cleaning up... 17:54:03 INFO - Return code: 0 17:54:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:54:03 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')]} 17:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:03 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')]} 17:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', '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 17:54:03 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 17:54:03 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 17:54:03 INFO - Using env: {'DISPLAY': ':0', 17:54:03 INFO - 'HOME': '/home/cltbld', 17:54:03 INFO - 'LANG': 'en_US.UTF-8', 17:54:03 INFO - 'LANGUAGE': 'en_US:en', 17:54:03 INFO - 'LOGNAME': 'cltbld', 17:54:03 INFO - 'MAIL': '/var/mail/cltbld', 17:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:03 INFO - 'MOZ_NO_REMOTE': '1', 17:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:03 INFO - 'NO_EM_RESTART': '1', 17:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:03 INFO - 'PWD': '/builds/slave/test', 17:54:03 INFO - 'SHELL': '/bin/bash', 17:54:03 INFO - 'SHLVL': '1', 17:54:03 INFO - 'TERM': 'linux', 17:54:03 INFO - 'TMOUT': '86400', 17:54:03 INFO - 'USER': 'cltbld', 17:54:03 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:03 INFO - '_': '/tools/buildbot/bin/python'} 17:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:03 INFO - Downloading/unpacking psutil>=3.1.1 17:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:54:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:54:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:54:04 INFO - Installing collected packages: psutil 17:54:04 INFO - Running setup.py install for psutil 17:54:04 INFO - building 'psutil._psutil_linux' extension 17:54:04 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 17:54:04 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 17:54:04 INFO - building 'psutil._psutil_posix' extension 17:54:04 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 17:54:04 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 17:54:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:54:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:54:04 INFO - Successfully installed psutil 17:54:04 INFO - Cleaning up... 17:54:04 INFO - Return code: 0 17:54:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', '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 17:54:04 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 17:54:04 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 17:54:04 INFO - Using env: {'DISPLAY': ':0', 17:54:04 INFO - 'HOME': '/home/cltbld', 17:54:04 INFO - 'LANG': 'en_US.UTF-8', 17:54:04 INFO - 'LANGUAGE': 'en_US:en', 17:54:04 INFO - 'LOGNAME': 'cltbld', 17:54:04 INFO - 'MAIL': '/var/mail/cltbld', 17:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:04 INFO - 'MOZ_NO_REMOTE': '1', 17:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:04 INFO - 'NO_EM_RESTART': '1', 17:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:04 INFO - 'PWD': '/builds/slave/test', 17:54:04 INFO - 'SHELL': '/bin/bash', 17:54:04 INFO - 'SHLVL': '1', 17:54:04 INFO - 'TERM': 'linux', 17:54:04 INFO - 'TMOUT': '86400', 17:54:04 INFO - 'USER': 'cltbld', 17:54:04 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:04 INFO - '_': '/tools/buildbot/bin/python'} 17:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:54:06 INFO - Installing collected packages: mozsystemmonitor 17:54:06 INFO - Running setup.py install for mozsystemmonitor 17:54:06 INFO - Successfully installed mozsystemmonitor 17:54:06 INFO - Cleaning up... 17:54:06 INFO - Return code: 0 17:54:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:54:06 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')]} 17:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:06 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')]} 17:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:06 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 0x13081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', '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 17:54:06 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 17:54:06 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 17:54:06 INFO - Using env: {'DISPLAY': ':0', 17:54:06 INFO - 'HOME': '/home/cltbld', 17:54:06 INFO - 'LANG': 'en_US.UTF-8', 17:54:06 INFO - 'LANGUAGE': 'en_US:en', 17:54:06 INFO - 'LOGNAME': 'cltbld', 17:54:06 INFO - 'MAIL': '/var/mail/cltbld', 17:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:06 INFO - 'MOZ_NO_REMOTE': '1', 17:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:06 INFO - 'NO_EM_RESTART': '1', 17:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:06 INFO - 'PWD': '/builds/slave/test', 17:54:06 INFO - 'SHELL': '/bin/bash', 17:54:06 INFO - 'SHLVL': '1', 17:54:06 INFO - 'TERM': 'linux', 17:54:06 INFO - 'TMOUT': '86400', 17:54:06 INFO - 'USER': 'cltbld', 17:54:06 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:06 INFO - '_': '/tools/buildbot/bin/python'} 17:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:06 INFO - Downloading/unpacking jsonschema==2.5.1 17:54:06 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 17:54:06 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 17:54:06 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 17:54:06 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 17:54:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:54:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:54:07 INFO - warning: no files found matching '*.txt' 17:54:07 INFO - no previously-included directories found matching 'build' 17:54:07 INFO - no previously-included directories found matching 'dist' 17:54:07 INFO - no previously-included directories found matching '.git*' 17:54:07 INFO - Installing collected packages: jsonschema, functools32 17:54:07 INFO - Running setup.py install for functools32 17:54:08 INFO - warning: no files found matching '*.txt' 17:54:08 INFO - no previously-included directories found matching 'build' 17:54:08 INFO - no previously-included directories found matching 'dist' 17:54:08 INFO - no previously-included directories found matching '.git*' 17:54:08 INFO - Successfully installed jsonschema functools32 17:54:08 INFO - Cleaning up... 17:54:08 INFO - Return code: 0 17:54:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:54:08 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')]} 17:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:08 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')]} 17:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', '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 17:54:08 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 17:54:08 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 17:54:08 INFO - Using env: {'DISPLAY': ':0', 17:54:08 INFO - 'HOME': '/home/cltbld', 17:54:08 INFO - 'LANG': 'en_US.UTF-8', 17:54:08 INFO - 'LANGUAGE': 'en_US:en', 17:54:08 INFO - 'LOGNAME': 'cltbld', 17:54:08 INFO - 'MAIL': '/var/mail/cltbld', 17:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:08 INFO - 'MOZ_NO_REMOTE': '1', 17:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:08 INFO - 'NO_EM_RESTART': '1', 17:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:08 INFO - 'PWD': '/builds/slave/test', 17:54:08 INFO - 'SHELL': '/bin/bash', 17:54:08 INFO - 'SHLVL': '1', 17:54:08 INFO - 'TERM': 'linux', 17:54:08 INFO - 'TMOUT': '86400', 17:54:08 INFO - 'USER': 'cltbld', 17:54:08 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:08 INFO - '_': '/tools/buildbot/bin/python'} 17:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:54:08 INFO - Cleaning up... 17:54:08 INFO - Return code: 0 17:54:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:54:08 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')]} 17:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:08 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')]} 17:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', '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 17:54:08 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 17:54:08 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 17:54:08 INFO - Using env: {'DISPLAY': ':0', 17:54:08 INFO - 'HOME': '/home/cltbld', 17:54:08 INFO - 'LANG': 'en_US.UTF-8', 17:54:08 INFO - 'LANGUAGE': 'en_US:en', 17:54:08 INFO - 'LOGNAME': 'cltbld', 17:54:08 INFO - 'MAIL': '/var/mail/cltbld', 17:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:08 INFO - 'MOZ_NO_REMOTE': '1', 17:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:08 INFO - 'NO_EM_RESTART': '1', 17:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:08 INFO - 'PWD': '/builds/slave/test', 17:54:08 INFO - 'SHELL': '/bin/bash', 17:54:08 INFO - 'SHLVL': '1', 17:54:08 INFO - 'TERM': 'linux', 17:54:08 INFO - 'TMOUT': '86400', 17:54:08 INFO - 'USER': 'cltbld', 17:54:08 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:08 INFO - '_': '/tools/buildbot/bin/python'} 17:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:08 INFO - Downloading/unpacking blobuploader==1.2.4 17:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:54:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:54:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:10 INFO - Downloading docopt-0.6.1.tar.gz 17:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:54:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:54:10 INFO - Running setup.py install for blobuploader 17:54:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:54:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:54:10 INFO - Running setup.py install for requests 17:54:10 INFO - Running setup.py install for docopt 17:54:10 INFO - Successfully installed blobuploader requests docopt 17:54:10 INFO - Cleaning up... 17:54:10 INFO - Return code: 0 17:54:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:54: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')]} 17:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54: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')]} 17:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:10 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 0x13081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', '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 17:54:10 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 17:54:10 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 17:54:10 INFO - Using env: {'DISPLAY': ':0', 17:54:10 INFO - 'HOME': '/home/cltbld', 17:54:10 INFO - 'LANG': 'en_US.UTF-8', 17:54:10 INFO - 'LANGUAGE': 'en_US:en', 17:54:10 INFO - 'LOGNAME': 'cltbld', 17:54:10 INFO - 'MAIL': '/var/mail/cltbld', 17:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:10 INFO - 'MOZ_NO_REMOTE': '1', 17:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:10 INFO - 'NO_EM_RESTART': '1', 17:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:10 INFO - 'PWD': '/builds/slave/test', 17:54:10 INFO - 'SHELL': '/bin/bash', 17:54:10 INFO - 'SHLVL': '1', 17:54:10 INFO - 'TERM': 'linux', 17:54:10 INFO - 'TMOUT': '86400', 17:54:10 INFO - 'USER': 'cltbld', 17:54:10 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:10 INFO - '_': '/tools/buildbot/bin/python'} 17:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:54:11 INFO - Running setup.py (path:/tmp/pip-f651VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:54:11 INFO - Running setup.py (path:/tmp/pip-v7euQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:54:11 INFO - Running setup.py (path:/tmp/pip-DgMghV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:54:11 INFO - Running setup.py (path:/tmp/pip-CVunPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:54:11 INFO - Running setup.py (path:/tmp/pip-oEmOCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:54:11 INFO - Running setup.py (path:/tmp/pip-Jo4p2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:54:11 INFO - Running setup.py (path:/tmp/pip-rymBKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:54:11 INFO - Running setup.py (path:/tmp/pip-gfmg1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:54:11 INFO - Running setup.py (path:/tmp/pip-RTtotN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:54:11 INFO - Running setup.py (path:/tmp/pip-Zj7dMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:54:11 INFO - Running setup.py (path:/tmp/pip-EyfesU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:54:11 INFO - Running setup.py (path:/tmp/pip-S2jVcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:54:11 INFO - Running setup.py (path:/tmp/pip-rtnMF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:54:11 INFO - Running setup.py (path:/tmp/pip-Qy1Qg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:12 INFO - Running setup.py (path:/tmp/pip-xzwqUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:54:12 INFO - Running setup.py (path:/tmp/pip-oT5Lji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:54:12 INFO - Running setup.py (path:/tmp/pip-gOe7q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:54:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:54:12 INFO - Running setup.py install for manifestparser 17:54:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:54:12 INFO - Running setup.py install for mozcrash 17:54:12 INFO - Running setup.py install for mozdebug 17:54:12 INFO - Running setup.py install for mozdevice 17:54:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:54:12 INFO - Running setup.py install for mozfile 17:54:12 INFO - Running setup.py install for mozhttpd 17:54:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:54:12 INFO - Running setup.py install for mozinfo 17:54:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:54:12 INFO - Running setup.py install for mozInstall 17:54:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:54:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:54:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:54:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:54:13 INFO - Running setup.py install for mozleak 17:54:13 INFO - Running setup.py install for mozlog 17:54:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:54:13 INFO - Running setup.py install for moznetwork 17:54:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:54:13 INFO - Running setup.py install for mozprocess 17:54:13 INFO - Running setup.py install for mozprofile 17:54:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:54:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:54:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:54:13 INFO - Running setup.py install for mozrunner 17:54:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:54:13 INFO - Running setup.py install for mozscreenshot 17:54:13 INFO - Running setup.py install for moztest 17:54:13 INFO - Running setup.py install for mozversion 17:54:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:54:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:54:14 INFO - Cleaning up... 17:54:14 INFO - Return code: 0 17:54:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', '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 17:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:54:14 INFO - Using env: {'DISPLAY': ':0', 17:54:14 INFO - 'HOME': '/home/cltbld', 17:54:14 INFO - 'LANG': 'en_US.UTF-8', 17:54:14 INFO - 'LANGUAGE': 'en_US:en', 17:54:14 INFO - 'LOGNAME': 'cltbld', 17:54:14 INFO - 'MAIL': '/var/mail/cltbld', 17:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:14 INFO - 'MOZ_NO_REMOTE': '1', 17:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:14 INFO - 'NO_EM_RESTART': '1', 17:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:14 INFO - 'PWD': '/builds/slave/test', 17:54:14 INFO - 'SHELL': '/bin/bash', 17:54:14 INFO - 'SHLVL': '1', 17:54:14 INFO - 'TERM': 'linux', 17:54:14 INFO - 'TMOUT': '86400', 17:54:14 INFO - 'USER': 'cltbld', 17:54:14 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:14 INFO - '_': '/tools/buildbot/bin/python'} 17:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:54:14 INFO - Running setup.py (path:/tmp/pip-PZUKpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:54:14 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)) 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:54:14 INFO - Running setup.py (path:/tmp/pip-CkXcoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:54:14 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)) 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:54:14 INFO - Running setup.py (path:/tmp/pip-ns4Jcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:54:14 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)) 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:54:14 INFO - Running setup.py (path:/tmp/pip-4QeCQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:54:14 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)) 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:54:14 INFO - Running setup.py (path:/tmp/pip-FnZoH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:54:14 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)) 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:54:14 INFO - Running setup.py (path:/tmp/pip-hlbBqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:54:14 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)) 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:54:14 INFO - Running setup.py (path:/tmp/pip-LYql3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:54:14 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)) 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:54:14 INFO - Running setup.py (path:/tmp/pip-C2JIUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:54:14 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)) 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:54:14 INFO - Running setup.py (path:/tmp/pip-d8JmJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:54:14 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)) 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:54:14 INFO - Running setup.py (path:/tmp/pip-cRk2O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:54:14 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)) 17:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:54:14 INFO - Running setup.py (path:/tmp/pip-V8HRr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:54:15 INFO - Running setup.py (path:/tmp/pip-eLXKoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:54:15 INFO - Running setup.py (path:/tmp/pip-lvmD_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:54:15 INFO - Running setup.py (path:/tmp/pip-KudJBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:54:15 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)) 17:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:15 INFO - Running setup.py (path:/tmp/pip-Vnu4kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:15 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)) 17:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:54:15 INFO - Running setup.py (path:/tmp/pip-aTnI2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:54:15 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)) 17:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:54:15 INFO - Running setup.py (path:/tmp/pip-jIQ8CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:54:15 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)) 17:54:15 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)) 17:54:15 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)) 17:54:15 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)) 17:54:15 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)) 17:54:15 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)) 17:54:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:16 INFO - Downloading blessings-1.6.tar.gz 17:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:54:16 INFO - Installing collected packages: blessings 17:54:16 INFO - Running setup.py install for blessings 17:54:16 INFO - Successfully installed blessings 17:54:16 INFO - Cleaning up... 17:54:16 INFO - Return code: 0 17:54:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:54:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:54:16 INFO - Reading from file tmpfile_stdout 17:54:16 INFO - Current package versions: 17:54:16 INFO - argparse == 1.2.1 17:54:16 INFO - blessings == 1.6 17:54:16 INFO - blobuploader == 1.2.4 17:54:16 INFO - docopt == 0.6.1 17:54:16 INFO - functools32 == 3.2.3-2 17:54:16 INFO - jsonschema == 2.5.1 17:54:16 INFO - manifestparser == 1.1 17:54:16 INFO - mozInstall == 1.12 17:54:16 INFO - mozcrash == 1.0 17:54:16 INFO - mozdebug == 0.1 17:54:16 INFO - mozdevice == 0.50 17:54:16 INFO - mozfile == 1.2 17:54:16 INFO - mozhttpd == 0.7 17:54:16 INFO - mozinfo == 0.9 17:54:16 INFO - mozleak == 0.1 17:54:16 INFO - mozlog == 3.4 17:54:16 INFO - moznetwork == 0.27 17:54:16 INFO - mozprocess == 0.25 17:54:16 INFO - mozprofile == 0.28 17:54:16 INFO - mozrunner == 6.13 17:54:16 INFO - mozscreenshot == 0.1 17:54:16 INFO - mozsystemmonitor == 0.3 17:54:16 INFO - moztest == 0.8 17:54:16 INFO - mozversion == 1.4 17:54:16 INFO - psutil == 3.1.1 17:54:16 INFO - requests == 1.2.3 17:54:16 INFO - wsgiref == 0.1.2 17:54:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:54:16 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')]} 17:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:16 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')]} 17:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:16 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 0x13081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', '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 17:54:16 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 17:54:16 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 17:54:16 INFO - Using env: {'DISPLAY': ':0', 17:54:16 INFO - 'HOME': '/home/cltbld', 17:54:16 INFO - 'LANG': 'en_US.UTF-8', 17:54:16 INFO - 'LANGUAGE': 'en_US:en', 17:54:16 INFO - 'LOGNAME': 'cltbld', 17:54:16 INFO - 'MAIL': '/var/mail/cltbld', 17:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:16 INFO - 'MOZ_NO_REMOTE': '1', 17:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:16 INFO - 'NO_EM_RESTART': '1', 17:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:16 INFO - 'PWD': '/builds/slave/test', 17:54:16 INFO - 'SHELL': '/bin/bash', 17:54:16 INFO - 'SHLVL': '1', 17:54:16 INFO - 'TERM': 'linux', 17:54:16 INFO - 'TMOUT': '86400', 17:54:16 INFO - 'USER': 'cltbld', 17:54:16 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:16 INFO - '_': '/tools/buildbot/bin/python'} 17:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:17 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)) 17:54:17 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)) 17:54:17 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)) 17:54:17 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)) 17:54:17 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)) 17:54:17 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)) 17:54:17 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)) 17:54:17 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)) 17:54:17 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)) 17:54:17 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)) 17:54:17 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)) 17:54:17 INFO - Cleaning up... 17:54:17 INFO - Return code: 0 17:54:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:17 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 0x13081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', '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 17:54:17 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 17:54:17 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 17:54:17 INFO - Using env: {'DISPLAY': ':0', 17:54:17 INFO - 'HOME': '/home/cltbld', 17:54:17 INFO - 'LANG': 'en_US.UTF-8', 17:54:17 INFO - 'LANGUAGE': 'en_US:en', 17:54:17 INFO - 'LOGNAME': 'cltbld', 17:54:17 INFO - 'MAIL': '/var/mail/cltbld', 17:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:17 INFO - 'MOZ_NO_REMOTE': '1', 17:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:17 INFO - 'NO_EM_RESTART': '1', 17:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:17 INFO - 'PWD': '/builds/slave/test', 17:54:17 INFO - 'SHELL': '/bin/bash', 17:54:17 INFO - 'SHLVL': '1', 17:54:17 INFO - 'TERM': 'linux', 17:54:17 INFO - 'TMOUT': '86400', 17:54:17 INFO - 'USER': 'cltbld', 17:54:17 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:17 INFO - '_': '/tools/buildbot/bin/python'} 17:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:54:17 INFO - Cleaning up... 17:54:17 INFO - Return code: 0 17:54:17 INFO - Running post-action listener: _resource_record_post_action 17:54:17 INFO - Running post-action listener: _start_resource_monitoring 17:54:17 INFO - Starting resource monitoring. 17:54:17 INFO - [mozharness: 2017-05-17 00:54:17.454806Z] Finished create-virtualenv step (success) 17:54:17 INFO - [mozharness: 2017-05-17 00:54:17.455301Z] Running install step. 17:54:17 INFO - Running pre-action listener: _resource_record_pre_action 17:54:17 INFO - Running main action method: install 17:54:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:54:17 INFO - Reading from file tmpfile_stdout 17:54:17 INFO - Detecting whether we're running mozinstall >=1.0... 17:54:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:54:17 INFO - Reading from file tmpfile_stdout 17:54:17 INFO - Output received: 17:54:17 INFO - Usage: mozinstall [options] installer 17:54:17 INFO - Options: 17:54:17 INFO - -h, --help show this help message and exit 17:54:17 INFO - -d DEST, --destination=DEST 17:54:17 INFO - Directory to install application into. [default: 17:54:17 INFO - "/builds/slave/test"] 17:54:17 INFO - --app=APP Application being installed. [default: firefox] 17:54:17 INFO - mkdir: /builds/slave/test/build/application 17:54:17 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'] 17:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:54:34 INFO - Reading from file tmpfile_stdout 17:54:34 INFO - Output received: 17:54:34 INFO - /builds/slave/test/build/application/firefox/firefox 17:54:34 INFO - Running post-action listener: _resource_record_post_action 17:54:34 INFO - [mozharness: 2017-05-17 00:54:34.050372Z] Finished install step (success) 17:54:34 INFO - [mozharness: 2017-05-17 00:54:34.050654Z] Running run-tests step. 17:54:34 INFO - Running pre-action listener: _resource_record_pre_action 17:54:34 INFO - Running main action method: run_tests 17:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:54:34 INFO - Python 2.7.3 17:54:34 INFO - Return code: 0 17:54:34 INFO - grabbing minidump binary from tooltool 17:54:34 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')]} 17:54:34 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 0x16787a0>, '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 0x16796a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1679b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:54:34 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 17:54:34 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 17:54:34 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 17:54:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:54:34 INFO - Return code: 0 17:54:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:54:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:54:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:54:34 INFO - ENV: RUST_BACKTRACE is now 1 17:54:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:54:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:54:34 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/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 17:54:34 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/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --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 17:54:34 INFO - Using env: {'DISPLAY': ':0', 17:54:34 INFO - 'HOME': '/home/cltbld', 17:54:34 INFO - 'LANG': 'en_US.UTF-8', 17:54:34 INFO - 'LANGUAGE': 'en_US:en', 17:54:34 INFO - 'LOGNAME': 'cltbld', 17:54:34 INFO - 'MAIL': '/var/mail/cltbld', 17:54:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:54:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:34 INFO - 'MOZ_NO_REMOTE': '1', 17:54:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:54:34 INFO - 'NO_EM_RESTART': '1', 17:54:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:34 INFO - 'PWD': '/builds/slave/test', 17:54:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:54:34 INFO - 'RUST_BACKTRACE': '1', 17:54:34 INFO - 'SHELL': '/bin/bash', 17:54:34 INFO - 'SHLVL': '1', 17:54:34 INFO - 'TERM': 'linux', 17:54:34 INFO - 'TMOUT': '86400', 17:54:34 INFO - 'USER': 'cltbld', 17:54:34 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918', 17:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:34 INFO - '_': '/tools/buildbot/bin/python'} 17:54:34 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/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 17:54:34 INFO - mozversion application_buildid: 20170517001032 17:54:34 INFO - mozversion application_changeset: 41958333867b0f537271dbd4cb4ba9e8a67a85a8 17:54:34 INFO - mozversion application_display_name: Nightly 17:54:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:54:34 INFO - mozversion application_name: Firefox 17:54:34 INFO - mozversion application_remotingname: firefox 17:54:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:54:34 INFO - mozversion application_vendor: Mozilla 17:54:34 INFO - mozversion application_version: 55.0a1 17:54:34 INFO - mozversion platform_buildid: 20170517001032 17:54:34 INFO - mozversion platform_changeset: 41958333867b0f537271dbd4cb4ba9e8a67a85a8 17:54:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:54:34 INFO - mozversion platform_version: 55.0a1 17:54:34 INFO - using testdate: 1494982474 17:54:34 INFO - actual date: 1494982474 17:54:34 INFO - starting webserver on 'localhost:34370' 17:54:34 INFO - SUITE-START | Running 2 tests 17:54:34 INFO - TEST-START | dromaeo_css 17:54:34 INFO - operating with platform_type : linux_ 17:54:34 INFO - Initialising browser for dromaeo_css test... 17:54:34 INFO - TEST-INFO | started process 17161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXUz9da/profile http://localhost:34370/getInfo.html) 17:54:34 INFO - PID 17161 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 17:54:38 INFO - PID 17161 | __metrics Screen width/height:1600/1200 17:54:38 INFO - PID 17161 | colorDepth:24 17:54:38 INFO - PID 17161 | Browser inner width/height: 1024/695 17:54:38 INFO - PID 17161 | __metrics 17:54:40 INFO - TEST-INFO | 17161: exit 0 17:54:40 INFO - Browser initialized. 17:54:40 INFO - Running cycle 1/1 for dromaeo_css test... 17:54:40 INFO - TEST-INFO | started process 17350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXUz9da/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:52 INFO - PID 17350 | RSS: Main: 165916672 17:54:52 INFO - PID 17350 | 17:57:56 INFO - PID 17350 | Cycle 1(1): loaded http://localhost:34370/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34370/tests/dromaeo/cssquery-ext.html) 17:57:59 INFO - PID 17350 | RSS: Main: 172433408 17:57:59 INFO - PID 17350 | 18:01:01 INFO - PID 17350 | Cycle 1(1): loaded http://localhost:34370/tests/dromaeo/cssquery-ext.html (next: http://localhost:34370/tests/dromaeo/cssquery-jquery.html) 18:01:02 INFO - PID 17350 | RSS: Main: 170844160 18:01:02 INFO - PID 17350 | 18:04:04 INFO - PID 17350 | Cycle 1(1): loaded http://localhost:34370/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34370/tests/dromaeo/cssquery-mootools.html) 18:04:04 INFO - PID 17350 | RSS: Main: 173465600 18:04:04 INFO - PID 17350 | 18:07:06 INFO - PID 17350 | Cycle 1(1): loaded http://localhost:34370/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34370/tests/dromaeo/cssquery-prototype.html) 18:07:07 INFO - PID 17350 | RSS: Main: 170512384 18:07:07 INFO - PID 17350 | 18:10:10 INFO - PID 17350 | Cycle 1(1): loaded http://localhost:34370/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34370/tests/dromaeo/cssquery-yui.html) 18:10:10 INFO - PID 17350 | RSS: Main: 171876352 18:10:10 INFO - PID 17350 | 18:13:12 INFO - PID 17350 | Cycle 1(1): loaded http://localhost:34370/tests/dromaeo/cssquery-yui.html (next: http://localhost:34370/tests/dromaeo/cssquery-dojo.html) 18:13:12 INFO - PID 17350 | RSS: Main: 177061888 18:13:12 INFO - PID 17350 | 18:13:12 INFO - PID 17350 | __start_tp_report 18:13:12 INFO - PID 17350 | _x_x_mozilla_page_load 18:13:12 INFO - PID 17350 | _x_x_mozilla_page_load_details 18:13:12 INFO - PID 17350 | |i|pagename|runs| 18:13:12 INFO - PID 17350 | |0;dojo.html;2689.932751681209;2698.177055997921;2709.187243826852;2728.549789284768;2742.862856857158;5118.564921981631;5119.513646203614;5153.278541004253;5162;5184.948150518499;5136.794528218867;5157.664751791131;5207.791688332462;5233.1103712368895;5255.448177941318;4628.953710462886;4637.327587499811;4648.628109751228;4693.624510039189;4697.835575754849;4651.581357677808;4693.084848454536;4736.644751643623;4754.78603462845;4787.994521150563;4626.560476754703;4646.256598944186;4671.04243630055;4678.672492925497;4707.411573553306;4628.375169352128;4643.930341044887;4650.18621741194;4668.043051174501;4695.413073365829;4616.146012987574;4621.884452888671;4630.374899388573;4635.814567417299;4662.440507139131;5111.7699703513435;5121.7439128043825;5166.896662066775;5168.457311982225;5181.04150732112;5602.13166959122;5604.3835178130375;5612.522935550483;5613.07384281593;5616.859578510529;5641.153826925994;5652.208690783294;5653.1520271959125;5661.66030038199;5665.12190610456;5210;5264.394594621591;5272.525472707436;5276.419593844674;5277.630565860353;5700.059490184156;5771.797987070432;5774.971125144348;5782.59521833476;5783.421657834183;5428.945710542844;5442.91835622466;5445.782168713207;5501.449855014466;5505.03661859173;5527;5540.722963851791;5556.86107847299;5578.693171875505;5644.74598643062;5472.5621950243885;5548.306461692288;5572;5590.5527557796095;5597.8600534986135;5516.979358818631;5517.944820551743;5534.861628459321;5537.837054218659;5546.029444847136;4569.977150114228;4588.898664320539;4591.517890621503;4596.908061838744;4628.83799067031;3943.467631869661;3983.0241590809856;3991.720579559461;3995.62041606047;4077.1641813428178;4729.905401891943;4786.928196077061;4788.4253889533475;4799.352087468217;4837.2260438329695;5529.391766905637;5560.749766260528;5563.443655634485;5597.74810133545;5630.324361076697;4715.858524244278;4725.220338644154;4771.928421073687;4772.570468657837;4777.713337199779;4931.5315045070665;4957.851264462072;4960.206366981266;4969.552740253394;4976.0794253063295;5200.271961925409;5204.271402003798;5204.531592156724;5217.834089649686;5255.816046438356;5534.916976245279;5539.030669632879;5558.972205138948;5580.35825880029;5592.972035139798;5190.506901844319;5194.870128246824;5210.0621888058995;5232.26748255237;5260.158374660189;5543.223948647274;5547.694876781816;5548.306461692288;5548.472895074961;5558.583106266965;5602.327720673546;5656.604037717485;5662.178984047372;5662.971685141548;5673.744681489426;5387.892242155213;5479.917801232905;5486.1222204448695;5486.725663716878;5495.505404513613;5426.484483974016;5456.563474921917;5457.072297709478;5459.481349271813;5461.754221059982;5299.4700529946695;5312.070387682063;5342.278792363137;5343.3587969443915;5395.784168633368;5419.268398766116;5440.020796256712;5445.373782014961;5446.972765136149;5453.26380938584;5307.310049693515;5308.681479111266;5310.203469479609;5312.282841816305;5385.461453854583 18:13:12 INFO - PID 17350 | |1;ext.html;724.3082855872642;746.402877697842;1028.639976008397;1050.2228351020242;1096.50657204258;31039.2240193995;31653;31767.205819854516;31771.68228317716;31793;29658.55512167319;29970.400591988146;29977.400451990947;29996.25009374767;30048.54927176094;5026.547610715035;5166.17341225404;6238.126662267275;6368.713407896633;6531.60810351378;6658.966705166467;6777.288384719607;6783.898241526381;6798;6811.284815094418;6730.49521285903;6753.898691519631;6771.356721111487;6815.42068924142;6826.4538836892925;6772.390484856362;6776.220734615533;6777.728890844361;6801.625910574917;6805.421539169177;6617;6638.867222655568;6640.601563906181;6647.66761661915;6654.26803051664;30011.699883001107;30155;30158.547621785692;30227.395452091056;30367;2958.600588920511;2992.3716019635904;2994.1766014346013;3000.3099287164073;3007.774416918718;22889.42776430586;23408.765912340998;23545.175918842928;23547.411314717097;23550.29349119529;3043.6651968283472;3062.8774849006013;3083.4758091124563;3083.691630836921;3084.2443601317595;140421;141254;141669.2916535421;141975;142364;36488;38316.23367532634;38365;38583.42124868129;39147.60852391497;39368.60631393707;39424.2115157701;39439;39525.80237098796;39554.208915821524;11582.594609188807;11637.592684256011;11698.06415486759;11703.122265830098;11704.35626040559;9157.31320150978;9158.267338612895;9163.770905727277;9213.262938964866;9490.383125096847;12081.939590301992;12211.328376939353;12249.816252756216;12293.569725059759;12394.380280985915;5100.413452452941;5205.843824685266;5261.4738526147075;5273.1035723927025;5280.313559237275;866.3545658484469;888.3515034025069;904.2404380320562;906.1120102299651;929.2612373163352;20322.59354812925;21100.894495527424;21135.894320528605;21420.892895535424;21470.248541300978;941.3269512298739;950.5627411390699;956.0917128727598;959.491469521155;977.3061126600052;10592.629257975934;10641.095506882002;10877.945610271898;10990.725231869268;11172.385518796382;174855;176355.11822441063;176422;177452.11273943548;178328.10835945737;38062;38290.808545957094;38293.617063829006;38369.80815095906;38416.80791596024;1191.4111702206364;1220.2922305063041;1228.8033914573625;1240.2682417373792;1240.9069319801051;19152.904235478734;19297.51756206106;19996.100175491847;20092.39722808318;20266.79733202649;28182.85908570444;28453.146405607866;28463.43073138567;28464.288392790346;28509.287267818472;153658;153664.23167884088;153842.23078884982;153873;153880;26688;27269.86365068162;28448.146555603365;29192;29537.852310738308;34677.13307167341;35281.647183527835;35297.64702352943;35595.46606800952;35925.82037089798;26605.600915986663;27210.31974200661;27386;27482;27612;26155.869220653774;26746.924103727542;27232.455350892476;27525.862370688017;27574;28659.426811464073;29565.85217073987;29829.254268643457;30223.395532089675;30239;25880.741192587833;25974.402559743874;26055.739442605332;26561;27730.86134569314;20058.498537536678;21875.67186492236;21974.340769776933;21991;22197.334079977627 18:13:12 INFO - PID 17350 | |2;jquery.html;403.8990252436891;411.2474172264756;416.7561976243898;432.60200615433797;438.6731884745865;13139.474421023147;16168.919155404206;16778.560395119002;17672.646547069067;17714.91142544287;18077;18350.35773747919;18461.35385261516;19145.234190632393;19153.904230478864;5425.104857698475;5427.6472029318065;5591.608587398884;5625.746841392127;5626.381098079229;5503.944960550383;5594.216809646653;5600.467955544237;5603.775848966036;5607.57943154263;5253.159494480884;5428.267183930178;5449.455054494539;5572.721363931808;5581.134924086773;5424.105022671254;5435.565154787627;5457.645253058538;5473.890522189554;5485.807996720116;4797.424309082898;4920.286558449041;4938.333325001115;4962.801487940478;4965.205567109245;21017;21120.683189752166;21246.15015399382;22392.664110038364;22410.103595856148;1626.1462732065643;1640.2454870759466;1681.159420289855;1685.7302831546895;1689.341156948791;14992.925035374863;15088.24558772068;15320;15390.692186156215;15425.845741542553;2005.7793642699291;2064.3290930447665;2065.783092775252;2066.4007437843006;2102.2326850699537;87823.56088219582;89007;92205;93618.99999999932;93847.53076234643;10847.186461015297;11194.290911635124;11267.774644507228;11546.653600392001;11596.536138554364;15791.631255311566;15826.208689565476;15875.444359447594;15920.681586368439;34698.96864954568;8472.406931514735;8526.658933642584;8674.262687671493;8862.512561809033;8883.644654213758;6411.967940160363;6504.414602685781;6542.738290468423;6898;7017.649117544102;9479.620815167316;9602.32783705148;9787.168090712226;10040.949795250977;10215.438150901771;4014.9197016059516;4082.2856000199845;4101.094424029388;4182.979085104555;4198.475190601175;827.3753316246195;855.0551640437352;857.3055824781947;859.1451505751817;882.9823403531893;17341.566460838327;17354.479365619052;17477.825221747873;17679.116044197737;18288.08559572016;865.0570877743164;867.9479231246146;872.241150199318;878.9780255493664;892.0767006148606;9405.905940940504;9769.388050971653;9805.509724513746;9813.55838987233;9814.46020468881;341650;344952;346664;349374;350571;72586.27413725901;72993.6350318245;73102;74398.6280068607;75221.6238918802;1020.6886899495726;1032.99483502582;1044.6709286574705;1052.7157667429751;1055.4247934875511;14814.62963425923;15007;15134.545963620669;15212.543623691306;15459.922700386425;37909.81045094757;37991.43012854754;38301.61698383092;38611;39401.211975760896;46723.532764671916;47125.764371177924;47131.764341178074;47498.52501474941;47575.762121189175;11265.310203469546;11480.425978701198;11797.941010294893;11825.290482571074;11874.881251187378;12802.423890924745;12864.099513034373;13113.541026064042;13160.736785264433;13391.196528208338;11210.55157793679;11314.264572803071;11713.88286117128;11760.470778814803;11919.463624137108;10524.631637892637;10634.73413164646;10638.255322127377;10682.305650132717;10714.410707410856;10804.945975270073;10858.2399232053;10895;11097.33415995043;11222.607208747655;11633.360165190996;11638.476268568103;11741.412929353328;11982.161248712506;12193.634190974284;10880.67357979262;10887;11020.338779673246;11110.222284440335;11394.373309467726 18:13:12 INFO - PID 17350 | |3;mootools.html;1194.0805579703629;1224.7856625090608;1245.122188856856;1248.5442813373118;1250.3560666256874;10063.698089057321;10274.486275686224;10573.84139237911;10579.576816927323;10583.417912014836;10198.796024079515;10335.069843714064;10376.896231037706;10400.21998350123;10424.426656533888;2155.2025750472308;2172.7827217278223;2180.7819218078143;2202.570498752744;2206.8344874134423;2122.5754849030177;2175.9129634814667;2183.737951445829;2184.3446965910243;2190.11300423328;2116.7248257726474;2144.4746037220903;2152.698622192894;2167.6206663833846;2176.455886028493;2144.592527419793;2183.5196256823474;2188.5075857931997;2192.6930229767845;2194.6378847490146;2010.9597808043757;2066.2871309398233;2108.5677436125557;2117.947051323714;2196.033745152128;10271.691849244535;10291.691249262534;10374.585016599327;10393.06462418386;10402.895971040269;5359.705216213107;5528.336599608033;5548.889022219573;5559.555235581144;5566.4990150886615;3302.5871766029245;3308.15642011288;3432.056184549244;3485.7037151842123;3506.1059429845227;1057.8360354145043;1070.4487189097622;1082.6210826210843;1127.9848136677056;1136.1876258475147;14762.261886905719;14876.107433553912;14912.403503859832;14924.925375373163;14967.326470308753;4539.296409056601;4670.719756814602;4854.466008739036;4971.4282857471135;4973.726445045557;10494.212934029978;10526.210534209966;10540.894591054144;10553.84169237462;10568.048875601078;5469;5473.480019398151;5489.780408783684;5496.120620700669;5517.806876759374;4943.110240156806;5040.924386134211;5047.268146118866;5066.594672426197;5197.038547868657;3677.558692956862;3784.4890939722786;3800.771953682788;3852;3879.980600097038;1134.750354921916;1135.4039129456935;1138.869030061537;1153.7115721069733;1165.2891736041008;671.9865602687919;708.2174197511675;715.9606221657755;728.7813655903208;732.0556482137982;5437.782488700487;5465.234867118606;5539.224508568804;5676.659400435905;5697.686627235459;522.6419902366891;529.3066083430718;539.1939051118603;543.8796080075058;545.3673738463364;3326.234965957843;3458.066322093021;3595.676389124991;3598;3905.33609286422;12459.439325230387;13430.127041742451;13441.731165376637;13443.193408395528;13450.865491345157;12813.487460501476;13067.673308167181;13331.200127992352;13400.128991615515;13412.061155719006;7188.712451501881;7270.709171633075;7355.5954422507275;7380.852382952418;7407.481476296715;5688.431156884279;5739.770409183586;5781.103928891029;5969.552283578662;5990.700464976647;11538.538458461568;11596;11707.531698731955;11888.108391870817;12065.939670301592;12159.209651372632;12246.755064898474;12378.81431778542;12409.379531023593;12620.242785432903;8033.357331413356;8280.668773249243;8288.50268983863;8288.792780180544;8302.460340077876;9474.38416502925;9652.710418687451;9747.853782193131;9773.609055637695;9776.9022309776;7983.760487185394;8017.8396432072195;8060.516369017878;8084.555349455602;8190.631421585924;7796.649150788115;7856.84286314282;7872.370210383041;7919.524828510308;7943.880841787262;7357.1907090218965;7415.2214017527385;7469;7488.8876666848955;7502;5102.668326558762;5139.897202056013;5189.481051894781;5191.402988656353;5443.918341224964;5194.428612852507;5196.844094677014;5291.550218231493;5299.152135658276;5473.917891231715 18:13:12 INFO - PID 17350 | |4;prototype.html;378.08692008798755;392.1177350960339;397.8508059477696;400.1017715229311;401.4660501532961;5316.308879845615;5502.2296878437055;5616.185653080301;5670.234518340023;5672.517835983941;5331.733413329328;5471.316085489304;5475.260839786628;5485.670859748418;5527.806526771564;4346.41323421338;4349.934750978738;4357.825686972517;4362.803673834669;4368.628666563346;4292.570742925714;4366.8034938427845;4366.956330436703;4372.956270437303;4377.47470303564;4285;4286.335617979203;4300.80646370914;4307;4337.306031035035;4317.784110794463;4350.78246087696;4357.063231405263;4367.45406824147;4374.49693285273;3891.630295121959;3899.2396482685886;3912.4913761211146;3965.1276719122034;3970.722049456539;5331.813386531491;5393.433689462589;5409.675419474844;5413.133898576249;5440.83677489672;5149.922751158736;5152.6650767699975;5161.354830646169;5185.55922746567;5210.609204309692;5716.256886604757;5834.883302333972;5911.940880591182;5936.97031514844;5945.554083443716;4429.645628349725;4449.510553839075;4452.195117076221;4460.353248778909;4467.731936083813;5992;6105.908411373788;6138.17134686816;6144.385561443864;6160.429090581918;4114.300568903293;4114.588541145861;4122.40225167349;4122.42286079949;4127.318992366226;4168.374743788456;4181.456410666655;4183.435236243129;4193.182329445729;4195.58044195578;4749.216379297446;4817.807287708522;4845.297431872429;4855.5387238212315;4859.611231101503;5853.356130825606;5869.178315035813;5873.706314684248;5892;5915.935131676253;1403.6631208509884;1403.8736513713816;1411.8305803303465;1414.6251243420502;1431.1270125223605;932.421898422982;961.4087336288133;969.5103972493987;973.9026097390205;983.4148681534475;5045.293658887758;5053.140966035783;5079.5428411443145;5085.491450854959;5090.618203634742;5940.732667029994;5975.4024597540765;5987.491063259585;6021.668808215591;6046.546509011754;4857.344258525054;5014.89970200594;5056.494350564914;5079.577718238899;5092.8472145835685;3182.236263296792;3231.5475833383343;3243.8053716777067;3247.7401807855313;3249.415105281072;5486.670799752028;5680.289963754531;5684.687342196219;5694.629849059798;5698.515626171739;6217.937820621826;6249.812505624838;6262.843428914313;6264.310925798159;6268.717907694165;5638;5654.604177707603;5673.631213971079;5679.517241034476;5682.602217844794;5827.329857066492;5982.756466325128;6041.667708276087;6055.636661800306;6122.969385153046;6038.758449661965;6043.909341359795;6044.607100538627;6047.909281360871;6050.30421501533;5460.836174914759;5558.304222452189;5605.467480589337;5621.578381621476;5689.2319536862;4625.768711564341;4695.835645752382;4711.175544279668;4712.929306060343;4714.976425117852;5806.854828629318;6026.397360263939;6108.938910610837;6117.938820611737;6118.235220597426;5861.413858614104;5866.706664666664;5871.383504731942;5871.823845284648;5881.705914704333;5831.154482599914;5864.794732184353;5881.588288819741;5891.49922256613;5904.5866789326055;5593.244911936837;5717.742701578522;5792.9710351447975;5793.102069179284;5806.764395707599;5852.239208902815;5901.085331773582;5931.347551769216;5956.583039187215;5959.1657167995645;5560.02699527573;5715.199872018004;5734.311882574118;5742.511886489695;5764.452377024176 18:13:12 INFO - PID 17350 | |5;yui.html;727.679820878813;752.1688534169743;753.4575105923733;765.9310662040418;778.5212094561842;12908.225506469607;13360.064795464321;13833.17000979942;13847.584572462816;13907.374168162432;14382.568522944328;15491.457798977039;15535.844641553582;15687.529374118767;15699.764503532428;857.1813917708589;882.0650110882453;882.1927935938609;886.3263919421222;887.560657474551;879.1823604048233;879.8592225243963;884.0982198157875;884.5842454046588;885.663447889801;927.0960813207137;930.2743859789341;934.313279739391;934.4066517761203;935.7473482159813;923.7875288683607;923.8198551282503;926.0091701878993;927.1562877781221;927.235031099339;672.6300534705941;678.762433148399;680.9523333366666;681.4276008153175;682.5972676121112;14248.145111293356;14397.064190827667;14782.778258326134;14818.703625927421;14924;15922.20388980558;15935.92032039844;16263.918680406641;16276.75584866228;16304.836951630568;12245.204061735958;12245.204061736047;12327.383630818513;12401.25592464455;12525.248485090924;2930.7069293070736;2961.540961151025;2964.5108557088056;2967.109867039879;2982.209714425679;74022.62988685076;74142.62928685376;74715;75190;75783.62108189423;12713.427895744713;12724.236545807282;12959.287239201934;12976.286304253168;13017.609471715863;21264;21577.24479643205;21631;21844.672329915065;21883;6401.55189136756;6677.499187560952;6722.9663851680425;6735.191776986793;6758.459323254128;2915.6063931368994;2949.0710426215674;3002.0993701889784;3005.594244776927;3013.789034767545;3517.525134106863;3527.276908233806;3578.5169002184894;3608.855645774192;3617.04148400674;724.199759266014;728.6393235348536;728.7376544443996;730.3499885102264;731.2760367236503;564.8333741546171;603.4930658247093;605.3462260758371;610.8503416662946;615.2739767074805;9370.203532699661;9618.951905240428;9900.801983960424;9935.304528682922;10146.594136234615;571.1889117453227;571.911353740171;578.8957987562195;586.4077281945266;599.0385431382655;3900.726949113535;4053.0677944073027;4085.22380747657;4140.544540100586;4186.874393768192;63207.367926321065;63440.68279658665;64248.67875660685;65548.67225663841;66065.33934660688;55217;55900.440995589524;56636.43363566394;57123;58270;51965.7401712989;51984;52343.21485177725;52345;53492.197617034995;8557.700480483154;8749.343799214957;8839.071897450674;8921.375503714678;9192.908070919206;26708.599371009062;26807.597886031333;27183.45633087367;27632;27947.301317467227;32506;32564.51153232751;32691.673083268863;32701.672983270815;33292.167695807795;11427.885721143015;11582.331395811754;11609.129315301218;11633.941830290794;11705.297682139098;12657.493700251887;12667.80998285008;13067.34663266852;13249.536266230636;13282.203067815575;11488.080953523866;11604;11631.302121872715;11736.647900562997;11859.05127589808;11730.824037639613;11730.941345293219;11833.585824496446;11970.76058478808;12134.211276267015;11502.597409090642;11796.646100616996;11971.221870578385;12005.339706315886;12040.397980101136;8488.278496327881;8564.828703426021;8613.22480976715;8694.782630434289;8748.357309535188;9190.035046320307;9316.673916412892;9331.346805723806;9366.718998430058;9472.57373418184 18:13:12 INFO - PID 17350 | __end_tp_report 18:13:12 INFO - PID 17350 | __start_cc_report 18:13:12 INFO - PID 17350 | _x_x_mozilla_cycle_collect,300 18:13:12 INFO - PID 17350 | __end_cc_report 18:13:12 INFO - PID 17350 | __startTimestamp1494983592959__endTimestamp 18:13:12 INFO - PID 17350 | 18:13:12 INFO - PID 17350 | ------- Summary: start ------- 18:13:12 INFO - PID 17350 | Number of tests: 6 18:13:12 INFO - PID 17350 | 18:13:12 INFO - PID 17350 | [#0] dojo.html Cycles:165 Average:5116.69 Median:5272.53 stddev:594.78 (11.3%) stddev-sans-first:565.32 18:13:12 INFO - PID 17350 | Values: 2689.9 2698.2 2709.2 2728.5 2742.9 5118.6 5119.5 5153.3 5162.0 5184.9 5136.8 5157.7 5207.8 5233.1 5255.4 4629.0 4637.3 4648.6 4693.6 4697.8 4651.6 4693.1 4736.6 4754.8 4788.0 4626.6 4646.3 4671.0 4678.7 4707.4 4628.4 4643.9 4650.2 4668.0 4695.4 4616.1 4621.9 4630.4 4635.8 4662.4 5111.8 5121.7 5166.9 5168.5 5181.0 5602.1 5604.4 5612.5 5613.1 5616.9 5641.2 5652.2 5653.2 5661.7 5665.1 5210.0 5264.4 5272.5 5276.4 5277.6 5700.1 5771.8 5775.0 5782.6 5783.4 5428.9 5442.9 5445.8 5501.4 5505.0 5527.0 5540.7 5556.9 5578.7 5644.7 5472.6 5548.3 5572.0 5590.6 5597.9 5517.0 5517.9 5534.9 5537.8 5546.0 4570.0 4588.9 4591.5 4596.9 4628.8 3943.5 3983.0 3991.7 3995.6 4077.2 4729.9 4786.9 4788.4 4799.4 4837.2 5529.4 5560.7 5563.4 5597.7 5630.3 4715.9 4725.2 4771.9 4772.6 4777.7 4931.5 4957.9 4960.2 4969.6 4976.1 5200.3 5204.3 5204.5 5217.8 5255.8 5534.9 5539.0 5559.0 5580.4 5593.0 5190.5 5194.9 5210.1 5232.3 5260.2 5543.2 5547.7 5548.3 5548.5 5558.6 5602.3 5656.6 5662.2 5663.0 5673.7 5387.9 5479.9 5486.1 5486.7 5495.5 5426.5 5456.6 5457.1 5459.5 5461.8 5299.5 5312.1 5342.3 5343.4 5395.8 5419.3 5440.0 5445.4 5447.0 5453.3 5307.3 5308.7 5310.2 5312.3 5385.5 18:13:12 INFO - PID 17350 | 18:13:12 INFO - PID 17350 | [#1] ext.html Cycles:180 Average:29447.05 Median:29973.90 stddev:40764.59 (136.0%) stddev-sans-first:40821.89 18:13:12 INFO - PID 17350 | Values: 724.3 746.4 1028.6 1050.2 1096.5 31039.2 31653.0 31767.2 31771.7 31793.0 29658.6 29970.4 29977.4 29996.3 30048.5 5026.5 5166.2 6238.1 6368.7 6531.6 6659.0 6777.3 6783.9 6798.0 6811.3 6730.5 6753.9 6771.4 6815.4 6826.5 6772.4 6776.2 6777.7 6801.6 6805.4 6617.0 6638.9 6640.6 6647.7 6654.3 30011.7 30155.0 30158.5 30227.4 30367.0 2958.6 2992.4 2994.2 3000.3 3007.8 22889.4 23408.8 23545.2 23547.4 23550.3 3043.7 3062.9 3083.5 3083.7 3084.2 140421.0 141254.0 141669.3 141975.0 142364.0 36488.0 38316.2 38365.0 38583.4 39147.6 39368.6 39424.2 39439.0 39525.8 39554.2 11582.6 11637.6 11698.1 11703.1 11704.4 9157.3 9158.3 9163.8 9213.3 9490.4 12081.9 12211.3 12249.8 12293.6 12394.4 5100.4 5205.8 5261.5 5273.1 5280.3 866.4 888.4 904.2 906.1 929.3 20322.6 21100.9 21135.9 21420.9 21470.2 941.3 950.6 956.1 959.5 977.3 10592.6 10641.1 10877.9 10990.7 11172.4 174855.0 176355.1 176422.0 177452.1 178328.1 38062.0 38290.8 38293.6 38369.8 38416.8 1191.4 1220.3 1228.8 1240.3 1240.9 19152.9 19297.5 19996.1 20092.4 20266.8 28182.9 28453.1 28463.4 28464.3 28509.3 153658.0 153664.2 153842.2 153873.0 153880.0 26688.0 27269.9 28448.1 29192.0 29537.9 34677.1 35281.6 35297.6 35595.5 35925.8 26605.6 27210.3 27386.0 27482.0 27612.0 26155.9 26746.9 27232.5 27525.9 27574.0 28659.4 29565.9 29829.3 30223.4 30239.0 25880.7 25974.4 26055.7 26561.0 27730.9 20058.5 21875.7 21974.3 21991.0 22197.3 18:13:12 INFO - PID 17350 | 18:13:12 INFO - PID 17350 | [#2] jquery.html Cycles:180 Average:24623.29 Median:182030.05 stddev:57815.48 (31.8%) stddev-sans-first:57949.07 18:13:12 INFO - PID 17350 | Values: 403.9 411.2 416.8 432.6 438.7 13139.5 16168.9 16778.6 17672.6 17714.9 18077.0 18350.4 18461.4 19145.2 19153.9 5425.1 5427.6 5591.6 5625.7 5626.4 5503.9 5594.2 5600.5 5603.8 5607.6 5253.2 5428.3 5449.5 5572.7 5581.1 5424.1 5435.6 5457.6 5473.9 5485.8 4797.4 4920.3 4938.3 4962.8 4965.2 21017.0 21120.7 21246.2 22392.7 22410.1 1626.1 1640.2 1681.2 1685.7 1689.3 14992.9 15088.2 15320.0 15390.7 15425.8 2005.8 2064.3 2065.8 2066.4 2102.2 87823.6 89007.0 92205.0 93619.0 93847.5 10847.2 11194.3 11267.8 11546.7 11596.5 15791.6 15826.2 15875.4 15920.7 34699.0 8472.4 8526.7 8674.3 8862.5 8883.6 6412.0 6504.4 6542.7 6898.0 7017.6 9479.6 9602.3 9787.2 10040.9 10215.4 4014.9 4082.3 4101.1 4183.0 4198.5 827.4 855.1 857.3 859.1 883.0 17341.6 17354.5 17477.8 17679.1 18288.1 865.1 867.9 872.2 879.0 892.1 9405.9 9769.4 9805.5 9813.6 9814.5 341650.0 344952.0 346664.0 349374.0 350571.0 72586.3 72993.6 73102.0 74398.6 75221.6 1020.7 1033.0 1044.7 1052.7 1055.4 14814.6 15007.0 15134.5 15212.5 15459.9 37909.8 37991.4 38301.6 38611.0 39401.2 46723.5 47125.8 47131.8 47498.5 47575.8 11265.3 11480.4 11797.9 11825.3 11874.9 12802.4 12864.1 13113.5 13160.7 13391.2 11210.6 11314.3 11713.9 11760.5 11919.5 10524.6 10634.7 10638.3 10682.3 10714.4 10804.9 10858.2 10895.0 11097.3 11222.6 11633.4 11638.5 11741.4 11982.2 12193.6 10880.7 10887.0 11020.3 11110.2 11394.4 18:13:12 INFO - PID 17350 | 18:13:12 INFO - PID 17350 | [#3] mootools.html Cycles:180 Average:6244.38 Median:3495.90 stddev:4049.75 (115.8%) stddev-sans-first:4043.33 18:13:12 INFO - PID 17350 | Values: 1194.1 1224.8 1245.1 1248.5 1250.4 10063.7 10274.5 10573.8 10579.6 10583.4 10198.8 10335.1 10376.9 10400.2 10424.4 2155.2 2172.8 2180.8 2202.6 2206.8 2122.6 2175.9 2183.7 2184.3 2190.1 2116.7 2144.5 2152.7 2167.6 2176.5 2144.6 2183.5 2188.5 2192.7 2194.6 2011.0 2066.3 2108.6 2117.9 2196.0 10271.7 10291.7 10374.6 10393.1 10402.9 5359.7 5528.3 5548.9 5559.6 5566.5 3302.6 3308.2 3432.1 3485.7 3506.1 1057.8 1070.4 1082.6 1128.0 1136.2 14762.3 14876.1 14912.4 14924.9 14967.3 4539.3 4670.7 4854.5 4971.4 4973.7 10494.2 10526.2 10540.9 10553.8 10568.0 5469.0 5473.5 5489.8 5496.1 5517.8 4943.1 5040.9 5047.3 5066.6 5197.0 3677.6 3784.5 3800.8 3852.0 3880.0 1134.8 1135.4 1138.9 1153.7 1165.3 672.0 708.2 716.0 728.8 732.1 5437.8 5465.2 5539.2 5676.7 5697.7 522.6 529.3 539.2 543.9 545.4 3326.2 3458.1 3595.7 3598.0 3905.3 12459.4 13430.1 13441.7 13443.2 13450.9 12813.5 13067.7 13331.2 13400.1 13412.1 7188.7 7270.7 7355.6 7380.9 7407.5 5688.4 5739.8 5781.1 5969.6 5990.7 11538.5 11596.0 11707.5 11888.1 12065.9 12159.2 12246.8 12378.8 12409.4 12620.2 8033.4 8280.7 8288.5 8288.8 8302.5 9474.4 9652.7 9747.9 9773.6 9776.9 7983.8 8017.8 8060.5 8084.6 8190.6 7796.6 7856.8 7872.4 7919.5 7943.9 7357.2 7415.2 7469.0 7488.9 7502.0 5102.7 5139.9 5189.5 5191.4 5443.9 5194.4 5196.8 5291.6 5299.2 5473.9 18:13:12 INFO - PID 17350 | 18:13:12 INFO - PID 17350 | [#4] prototype.html Cycles:180 Average:4873.65 Median:5486.17 stddev:1414.25 (25.8%) stddev-sans-first:1377.38 18:13:12 INFO - PID 17350 | Values: 378.1 392.1 397.9 400.1 401.5 5316.3 5502.2 5616.2 5670.2 5672.5 5331.7 5471.3 5475.3 5485.7 5527.8 4346.4 4349.9 4357.8 4362.8 4368.6 4292.6 4366.8 4367.0 4373.0 4377.5 4285.0 4286.3 4300.8 4307.0 4337.3 4317.8 4350.8 4357.1 4367.5 4374.5 3891.6 3899.2 3912.5 3965.1 3970.7 5331.8 5393.4 5409.7 5413.1 5440.8 5149.9 5152.7 5161.4 5185.6 5210.6 5716.3 5834.9 5911.9 5937.0 5945.6 4429.6 4449.5 4452.2 4460.4 4467.7 5992.0 6105.9 6138.2 6144.4 6160.4 4114.3 4114.6 4122.4 4122.4 4127.3 4168.4 4181.5 4183.4 4193.2 4195.6 4749.2 4817.8 4845.3 4855.5 4859.6 5853.4 5869.2 5873.7 5892.0 5915.9 1403.7 1403.9 1411.8 1414.6 1431.1 932.4 961.4 969.5 973.9 983.4 5045.3 5053.1 5079.5 5085.5 5090.6 5940.7 5975.4 5987.5 6021.7 6046.5 4857.3 5014.9 5056.5 5079.6 5092.8 3182.2 3231.5 3243.8 3247.7 3249.4 5486.7 5680.3 5684.7 5694.6 5698.5 6217.9 6249.8 6262.8 6264.3 6268.7 5638.0 5654.6 5673.6 5679.5 5682.6 5827.3 5982.8 6041.7 6055.6 6123.0 6038.8 6043.9 6044.6 6047.9 6050.3 5460.8 5558.3 5605.5 5621.6 5689.2 4625.8 4695.8 4711.2 4712.9 4715.0 5806.9 6026.4 6108.9 6117.9 6118.2 5861.4 5866.7 5871.4 5871.8 5881.7 5831.2 5864.8 5881.6 5891.5 5904.6 5593.2 5717.7 5793.0 5793.1 5806.8 5852.2 5901.1 5931.3 5956.6 5959.2 5560.0 5715.2 5734.3 5742.5 5764.5 18:13:12 INFO - PID 17350 | 18:13:12 INFO - PID 17350 | [#5] yui.html Cycles:180 Average:14963.91 Median:28076.31 stddev:18535.98 (66.0%) stddev-sans-first:18557.16 18:13:12 INFO - PID 17350 | Values: 727.7 752.2 753.5 765.9 778.5 12908.2 13360.1 13833.2 13847.6 13907.4 14382.6 15491.5 15535.8 15687.5 15699.8 857.2 882.1 882.2 886.3 887.6 879.2 879.9 884.1 884.6 885.7 927.1 930.3 934.3 934.4 935.7 923.8 923.8 926.0 927.2 927.2 672.6 678.8 681.0 681.4 682.6 14248.1 14397.1 14782.8 14818.7 14924.0 15922.2 15935.9 16263.9 16276.8 16304.8 12245.2 12245.2 12327.4 12401.3 12525.2 2930.7 2961.5 2964.5 2967.1 2982.2 74022.6 74142.6 74715.0 75190.0 75783.6 12713.4 12724.2 12959.3 12976.3 13017.6 21264.0 21577.2 21631.0 21844.7 21883.0 6401.6 6677.5 6723.0 6735.2 6758.5 2915.6 2949.1 3002.1 3005.6 3013.8 3517.5 3527.3 3578.5 3608.9 3617.0 724.2 728.6 728.7 730.3 731.3 564.8 603.5 605.3 610.9 615.3 9370.2 9619.0 9900.8 9935.3 10146.6 571.2 571.9 578.9 586.4 599.0 3900.7 4053.1 4085.2 4140.5 4186.9 63207.4 63440.7 64248.7 65548.7 66065.3 55217.0 55900.4 56636.4 57123.0 58270.0 51965.7 51984.0 52343.2 52345.0 53492.2 8557.7 8749.3 8839.1 8921.4 9192.9 26708.6 26807.6 27183.5 27632.0 27947.3 32506.0 32564.5 32691.7 32701.7 33292.2 11427.9 11582.3 11609.1 11633.9 11705.3 12657.5 12667.8 13067.3 13249.5 13282.2 11488.1 11604.0 11631.3 11736.6 11859.1 11730.8 11730.9 11833.6 11970.8 12134.2 11502.6 11796.6 11971.2 12005.3 12040.4 8488.3 8564.8 8613.2 8694.8 8748.4 9190.0 9316.7 9331.3 9366.7 9472.6 18:13:12 INFO - PID 17350 | -------- Summary: end -------- 18:13:12 INFO - PID 17350 | 18:13:13 INFO - TEST-INFO | 17350: exit 0 18:13:13 INFO - TEST-OK | dromaeo_css | took 1119506ms 18:13:13 INFO - TEST-START | kraken 18:13:13 INFO - operating with platform_type : linux_ 18:13:13 INFO - Initialising browser for kraken test... 18:13:13 INFO - TEST-INFO | started process 17780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR76gsS/profile http://localhost:34370/getInfo.html) 18:13:14 INFO - PID 17780 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 18:13:17 INFO - PID 17780 | __metrics Screen width/height:1600/1200 18:13:17 INFO - PID 17780 | colorDepth:24 18:13:17 INFO - PID 17780 | Browser inner width/height: 1024/695 18:13:17 INFO - PID 17780 | __metrics 18:13:19 INFO - TEST-INFO | 17780: exit 0 18:13:19 INFO - Browser initialized. 18:13:19 INFO - Running cycle 1/1 for kraken test... 18:13:19 INFO - TEST-INFO | started process 17965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR76gsS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:31 INFO - PID 17965 | RSS: Main: 165781504 18:13:31 INFO - PID 17965 | 18:13:34 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34370/tests/kraken/driver.html?testName=audio-beat-detection) 18:13:35 INFO - PID 17965 | RSS: Main: 170905600 18:13:35 INFO - PID 17965 | 18:13:37 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34370/tests/kraken/driver.html?testName=audio-dft) 18:13:38 INFO - PID 17965 | RSS: Main: 170590208 18:13:38 INFO - PID 17965 | 18:13:41 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34370/tests/kraken/driver.html?testName=audio-fft) 18:13:41 INFO - PID 17965 | RSS: Main: 165437440 18:13:41 INFO - PID 17965 | 18:13:44 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34370/tests/kraken/driver.html?testName=audio-oscillator) 18:13:44 INFO - PID 17965 | RSS: Main: 165912576 18:13:44 INFO - PID 17965 | 18:13:46 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34370/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:13:47 INFO - PID 17965 | RSS: Main: 166342656 18:13:47 INFO - PID 17965 | 18:13:50 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34370/tests/kraken/driver.html?testName=imaging-darkroom) 18:13:51 INFO - PID 17965 | RSS: Main: 169979904 18:13:51 INFO - PID 17965 | 18:13:54 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34370/tests/kraken/driver.html?testName=imaging-desaturate) 18:13:55 INFO - PID 17965 | RSS: Main: 168124416 18:13:55 INFO - PID 17965 | 18:13:58 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34370/tests/kraken/driver.html?testName=json-parse-financial) 18:13:58 INFO - PID 17965 | RSS: Main: 168787968 18:13:58 INFO - PID 17965 | 18:14:00 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34370/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:14:01 INFO - PID 17965 | RSS: Main: 169185280 18:14:01 INFO - PID 17965 | 18:14:03 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34370/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:14:03 INFO - PID 17965 | RSS: Main: 168976384 18:14:03 INFO - PID 17965 | 18:14:05 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34370/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:14:06 INFO - PID 17965 | RSS: Main: 168792064 18:14:06 INFO - PID 17965 | 18:14:09 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:14:10 INFO - PID 17965 | RSS: Main: 169431040 18:14:10 INFO - PID 17965 | 18:14:13 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:14:13 INFO - PID 17965 | RSS: Main: 169074688 18:14:13 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | Cycle 1(1): loaded http://localhost:34370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34370/tests/kraken/driver.html?testName=ai-astar) 18:14:15 INFO - PID 17965 | RSS: Main: 170876928 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | __start_tp_report 18:14:15 INFO - PID 17965 | _x_x_mozilla_page_load 18:14:15 INFO - PID 17965 | _x_x_mozilla_page_load_details 18:14:15 INFO - PID 17965 | |i|pagename|runs| 18:14:15 INFO - PID 17965 | |0;ai-astar;105;111;112;113;112;112;113;114;112;114 18:14:15 INFO - PID 17965 | |1;audio-beat-detection;159;124;127;165;132;133;130;124;149;123 18:14:15 INFO - PID 17965 | |2;audio-dft;165;163;167;162;162;166;172;166;165;166 18:14:15 INFO - PID 17965 | |3;audio-fft;75;76;75;108;76;78;76;75;94;75 18:14:15 INFO - PID 17965 | |4;audio-oscillator;84;83;104;83;83;87;95;84;84;108 18:14:15 INFO - PID 17965 | |5;imaging-gaussian-blur;114;114;115;114;115;115;120;116;117;114 18:14:15 INFO - PID 17965 | |6;imaging-darkroom;150;150;153;150;151;151;151;152;151;150 18:14:15 INFO - PID 17965 | |7;imaging-desaturate;96;95;94;94;95;94;95;95;95;94 18:14:15 INFO - PID 17965 | |8;json-parse-financial;60;59;54;55;57;56;56;61;57;57 18:14:15 INFO - PID 17965 | |9;json-stringify-tinderbox;55;56;55;58;56;55;56;55;56;56 18:14:15 INFO - PID 17965 | |10;stanford-crypto-aes;85;84;83;84;83;83;92;83;82;81 18:14:15 INFO - PID 17965 | |11;stanford-crypto-ccm;148;143;133;135;141;140;136;140;183;132 18:14:15 INFO - PID 17965 | |12;stanford-crypto-pbkdf2;201;202;198;202;195;195;197;195;195;194 18:14:15 INFO - PID 17965 | |13;stanford-crypto-sha256-iterative;77;74;72;77;79;76;77;72;74;71 18:14:15 INFO - PID 17965 | __end_tp_report 18:14:15 INFO - PID 17965 | __start_cc_report 18:14:15 INFO - PID 17965 | _x_x_mozilla_cycle_collect,785 18:14:15 INFO - PID 17965 | __end_cc_report 18:14:15 INFO - PID 17965 | __startTimestamp1494983655980__endTimestamp 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | ------- Summary: start ------- 18:14:15 INFO - PID 17965 | Number of tests: 14 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:2.57 (2.3%) stddev-sans-first:1.01 18:14:15 INFO - PID 17965 | Values: 105.0 111.0 112.0 113.0 112.0 112.0 113.0 114.0 112.0 114.0 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:132.50 stddev:15.40 (11.6%) stddev-sans-first:14.04 18:14:15 INFO - PID 17965 | Values: 159.0 124.0 127.0 165.0 132.0 133.0 130.0 124.0 149.0 123.0 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | [#2] audio-dft Cycles:10 Average:165.40 Median:166.00 stddev:2.91 (1.8%) stddev-sans-first:3.09 18:14:15 INFO - PID 17965 | Values: 165.0 163.0 167.0 162.0 162.0 166.0 172.0 166.0 165.0 166.0 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:11.18 (14.7%) stddev-sans-first:11.66 18:14:15 INFO - PID 17965 | Values: 75.0 76.0 75.0 108.0 76.0 78.0 76.0 75.0 94.0 75.0 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:84.00 stddev:9.47 (11.3%) stddev-sans-first:9.83 18:14:15 INFO - PID 17965 | Values: 84.0 83.0 104.0 83.0 83.0 87.0 95.0 84.0 84.0 108.0 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.90 (1.6%) stddev-sans-first:1.94 18:14:15 INFO - PID 17965 | Values: 114.0 114.0 115.0 114.0 115.0 115.0 120.0 116.0 117.0 114.0 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 18:14:15 INFO - PID 17965 | Values: 150.0 150.0 153.0 150.0 151.0 151.0 151.0 152.0 151.0 150.0 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 18:14:15 INFO - PID 17965 | Values: 96.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:2.20 (3.9%) stddev-sans-first:2.09 18:14:15 INFO - PID 17965 | Values: 60.0 59.0 54.0 55.0 57.0 56.0 56.0 61.0 57.0 57.0 18:14:15 INFO - PID 17965 | 18:14:15 INFO - PID 17965 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 18:14:15 INFO - PID 17965 | Values: 55.0 56.0 55.0 58.0 56.0 55.0 56.0 55.0 56.0 56.0 18:14:15 INFO - PID 17965 | 18:14:16 INFO - PID 17965 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.50 stddev:3.02 (3.6%) stddev-sans-first:3.18 18:14:16 INFO - PID 17965 | Values: 85.0 84.0 83.0 84.0 83.0 83.0 92.0 83.0 82.0 81.0 18:14:16 INFO - PID 17965 | 18:14:16 INFO - PID 17965 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:140.50 stddev:14.84 (10.6%) stddev-sans-first:15.63 18:14:16 INFO - PID 17965 | Values: 148.0 143.0 133.0 135.0 141.0 140.0 136.0 140.0 183.0 132.0 18:14:16 INFO - PID 17965 | 18:14:16 INFO - PID 17965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.40 Median:197.50 stddev:3.17 (1.6%) stddev-sans-first:3.08 18:14:16 INFO - PID 17965 | Values: 201.0 202.0 198.0 202.0 195.0 195.0 197.0 195.0 195.0 194.0 18:14:16 INFO - PID 17965 | 18:14:16 INFO - PID 17965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:76.50 stddev:2.69 (3.5%) stddev-sans-first:2.74 18:14:16 INFO - PID 17965 | Values: 77.0 74.0 72.0 77.0 79.0 76.0 77.0 72.0 74.0 71.0 18:14:16 INFO - PID 17965 | -------- Summary: end -------- 18:14:16 INFO - PID 17965 | 18:14:17 INFO - TEST-INFO | 17965: exit 0 18:14:17 INFO - TEST-OK | kraken | took 63407ms 18:14:17 INFO - SUITE-END | took 1182s 18:14:17 INFO - Completed test suite (00:19:43) 18:14:17 INFO - javascript benchmark 18:14:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6689.376561207481, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2689.932751681209, 2698.177055997921, 2709.187243826852, 2728.549789284768, 2742.862856857158, 5118.564921981631, 5119.513646203614, 5153.278541004253, 5162.0, 5184.948150518499, 5136.794528218867, 5157.664751791131, 5207.791688332462, 5233.1103712368895, 5255.448177941318, 4628.953710462886, 4637.327587499811, 4648.628109751228, 4693.624510039189, 4697.835575754849, 4651.581357677808, 4693.084848454536, 4736.644751643623, 4754.78603462845, 4787.994521150563, 4626.560476754703, 4646.256598944186, 4671.04243630055, 4678.672492925497, 4707.411573553306, 4628.375169352128, 4643.930341044887, 4650.18621741194, 4668.043051174501, 4695.413073365829, 4616.146012987574, 4621.884452888671, 4630.374899388573, 4635.814567417299, 4662.440507139131, 5111.7699703513435, 5121.7439128043825, 5166.896662066775, 5168.457311982225, 5181.04150732112, 5602.13166959122, 5604.3835178130375, 5612.522935550483, 5613.07384281593, 5616.859578510529, 5641.153826925994, 5652.208690783294, 5653.1520271959125, 5661.66030038199, 5665.12190610456, 5210.0, 5264.394594621591, 5272.525472707436, 5276.419593844674, 5277.630565860353, 5700.059490184156, 5771.797987070432, 5774.971125144348, 5782.59521833476, 5783.421657834183, 5428.945710542844, 5442.91835622466, 5445.782168713207, 5501.449855014466, 5505.03661859173, 5527.0, 5540.722963851791, 5556.86107847299, 5578.693171875505, 5644.74598643062, 5472.5621950243885, 5548.306461692288, 5572.0, 5590.5527557796095, 5597.8600534986135, 5516.979358818631, 5517.944820551743, 5534.861628459321, 5537.837054218659, 5546.029444847136, 4569.977150114228, 4588.898664320539, 4591.517890621503, 4596.908061838744, 4628.83799067031, 3943.467631869661, 3983.0241590809856, 3991.720579559461, 3995.62041606047, 4077.1641813428178, 4729.905401891943, 4786.928196077061, 4788.4253889533475, 4799.352087468217, 4837.2260438329695, 5529.391766905637, 5560.749766260528, 5563.443655634485, 5597.74810133545, 5630.324361076697, 4715.858524244278, 4725.220338644154, 4771.928421073687, 4772.570468657837, 4777.713337199779, 4931.5315045070665, 4957.851264462072, 4960.206366981266, 4969.552740253394, 4976.0794253063295, 5200.271961925409, 5204.271402003798, 5204.531592156724, 5217.834089649686, 5255.816046438356, 5534.916976245279, 5539.030669632879, 5558.972205138948, 5580.35825880029, 5592.972035139798, 5190.506901844319, 5194.870128246824, 5210.0621888058995, 5232.26748255237, 5260.158374660189, 5543.223948647274, 5547.694876781816, 5548.306461692288, 5548.472895074961, 5558.583106266965, 5602.327720673546, 5656.604037717485, 5662.178984047372, 5662.971685141548, 5673.744681489426, 5387.892242155213, 5479.917801232905, 5486.1222204448695, 5486.725663716878, 5495.505404513613, 5426.484483974016, 5456.563474921917, 5457.072297709478, 5459.481349271813, 5461.754221059982, 5299.4700529946695, 5312.070387682063, 5342.278792363137, 5343.3587969443915, 5395.784168633368, 5419.268398766116, 5440.020796256712, 5445.373782014961, 5446.972765136149, 5453.26380938584, 5307.310049693515, 5308.681479111266, 5310.203469479609, 5312.282841816305, 5385.461453854583], "value": 5073.755108026248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.3082855872642, 746.402877697842, 1028.639976008397, 1050.2228351020242, 1096.50657204258, 31039.2240193995, 31653.0, 31767.205819854516, 31771.68228317716, 31793.0, 29658.55512167319, 29970.400591988146, 29977.400451990947, 29996.25009374767, 30048.54927176094, 5026.547610715035, 5166.17341225404, 6238.126662267275, 6368.713407896633, 6531.60810351378, 6658.966705166467, 6777.288384719607, 6783.898241526381, 6798.0, 6811.284815094418, 6730.49521285903, 6753.898691519631, 6771.356721111487, 6815.42068924142, 6826.4538836892925, 6772.390484856362, 6776.220734615533, 6777.728890844361, 6801.625910574917, 6805.421539169177, 6617.0, 6638.867222655568, 6640.601563906181, 6647.66761661915, 6654.26803051664, 30011.699883001107, 30155.0, 30158.547621785692, 30227.395452091056, 30367.0, 2958.600588920511, 2992.3716019635904, 2994.1766014346013, 3000.3099287164073, 3007.774416918718, 22889.42776430586, 23408.765912340998, 23545.175918842928, 23547.411314717097, 23550.29349119529, 3043.6651968283472, 3062.8774849006013, 3083.4758091124563, 3083.691630836921, 3084.2443601317595, 140421.0, 141254.0, 141669.2916535421, 141975.0, 142364.0, 36488.0, 38316.23367532634, 38365.0, 38583.42124868129, 39147.60852391497, 39368.60631393707, 39424.2115157701, 39439.0, 39525.80237098796, 39554.208915821524, 11582.594609188807, 11637.592684256011, 11698.06415486759, 11703.122265830098, 11704.35626040559, 9157.31320150978, 9158.267338612895, 9163.770905727277, 9213.262938964866, 9490.383125096847, 12081.939590301992, 12211.328376939353, 12249.816252756216, 12293.569725059759, 12394.380280985915, 5100.413452452941, 5205.843824685266, 5261.4738526147075, 5273.1035723927025, 5280.313559237275, 866.3545658484469, 888.3515034025069, 904.2404380320562, 906.1120102299651, 929.2612373163352, 20322.59354812925, 21100.894495527424, 21135.894320528605, 21420.892895535424, 21470.248541300978, 941.3269512298739, 950.5627411390699, 956.0917128727598, 959.491469521155, 977.3061126600052, 10592.629257975934, 10641.095506882002, 10877.945610271898, 10990.725231869268, 11172.385518796382, 174855.0, 176355.11822441063, 176422.0, 177452.11273943548, 178328.10835945737, 38062.0, 38290.808545957094, 38293.617063829006, 38369.80815095906, 38416.80791596024, 1191.4111702206364, 1220.2922305063041, 1228.8033914573625, 1240.2682417373792, 1240.9069319801051, 19152.904235478734, 19297.51756206106, 19996.100175491847, 20092.39722808318, 20266.79733202649, 28182.85908570444, 28453.146405607866, 28463.43073138567, 28464.288392790346, 28509.287267818472, 153658.0, 153664.23167884088, 153842.23078884982, 153873.0, 153880.0, 26688.0, 27269.86365068162, 28448.146555603365, 29192.0, 29537.852310738308, 34677.13307167341, 35281.647183527835, 35297.64702352943, 35595.46606800952, 35925.82037089798, 26605.600915986663, 27210.31974200661, 27386.0, 27482.0, 27612.0, 26155.869220653774, 26746.924103727542, 27232.455350892476, 27525.862370688017, 27574.0, 28659.426811464073, 29565.85217073987, 29829.254268643457, 30223.395532089675, 30239.0, 25880.741192587833, 25974.402559743874, 26055.739442605332, 26561.0, 27730.86134569314, 20058.498537536678, 21875.67186492236, 21974.340769776933, 21991.0, 22197.334079977627], "value": 13994.111409051282, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.8990252436891, 411.2474172264756, 416.7561976243898, 432.60200615433797, 438.6731884745865, 13139.474421023147, 16168.919155404206, 16778.560395119002, 17672.646547069067, 17714.91142544287, 18077.0, 18350.35773747919, 18461.35385261516, 19145.234190632393, 19153.904230478864, 5425.104857698475, 5427.6472029318065, 5591.608587398884, 5625.746841392127, 5626.381098079229, 5503.944960550383, 5594.216809646653, 5600.467955544237, 5603.775848966036, 5607.57943154263, 5253.159494480884, 5428.267183930178, 5449.455054494539, 5572.721363931808, 5581.134924086773, 5424.105022671254, 5435.565154787627, 5457.645253058538, 5473.890522189554, 5485.807996720116, 4797.424309082898, 4920.286558449041, 4938.333325001115, 4962.801487940478, 4965.205567109245, 21017.0, 21120.683189752166, 21246.15015399382, 22392.664110038364, 22410.103595856148, 1626.1462732065643, 1640.2454870759466, 1681.159420289855, 1685.7302831546895, 1689.341156948791, 14992.925035374863, 15088.24558772068, 15320.0, 15390.692186156215, 15425.845741542553, 2005.7793642699291, 2064.3290930447665, 2065.783092775252, 2066.4007437843006, 2102.2326850699537, 87823.56088219582, 89007.0, 92205.0, 93618.99999999932, 93847.53076234643, 10847.186461015297, 11194.290911635124, 11267.774644507228, 11546.653600392001, 11596.536138554364, 15791.631255311566, 15826.208689565476, 15875.444359447594, 15920.681586368439, 34698.96864954568, 8472.406931514735, 8526.658933642584, 8674.262687671493, 8862.512561809033, 8883.644654213758, 6411.967940160363, 6504.414602685781, 6542.738290468423, 6898.0, 7017.649117544102, 9479.620815167316, 9602.32783705148, 9787.168090712226, 10040.949795250977, 10215.438150901771, 4014.9197016059516, 4082.2856000199845, 4101.094424029388, 4182.979085104555, 4198.475190601175, 827.3753316246195, 855.0551640437352, 857.3055824781947, 859.1451505751817, 882.9823403531893, 17341.566460838327, 17354.479365619052, 17477.825221747873, 17679.116044197737, 18288.08559572016, 865.0570877743164, 867.9479231246146, 872.241150199318, 878.9780255493664, 892.0767006148606, 9405.905940940504, 9769.388050971653, 9805.509724513746, 9813.55838987233, 9814.46020468881, 341650.0, 344952.0, 346664.0, 349374.0, 350571.0, 72586.27413725901, 72993.6350318245, 73102.0, 74398.6280068607, 75221.6238918802, 1020.6886899495726, 1032.99483502582, 1044.6709286574705, 1052.7157667429751, 1055.4247934875511, 14814.62963425923, 15007.0, 15134.545963620669, 15212.543623691306, 15459.922700386425, 37909.81045094757, 37991.43012854754, 38301.61698383092, 38611.0, 39401.211975760896, 46723.532764671916, 47125.764371177924, 47131.764341178074, 47498.52501474941, 47575.762121189175, 11265.310203469546, 11480.425978701198, 11797.941010294893, 11825.290482571074, 11874.881251187378, 12802.423890924745, 12864.099513034373, 13113.541026064042, 13160.736785264433, 13391.196528208338, 11210.55157793679, 11314.264572803071, 11713.88286117128, 11760.470778814803, 11919.463624137108, 10524.631637892637, 10634.73413164646, 10638.255322127377, 10682.305650132717, 10714.410707410856, 10804.945975270073, 10858.2399232053, 10895.0, 11097.33415995043, 11222.607208747655, 11633.360165190996, 11638.476268568103, 11741.412929353328, 11982.161248712506, 12193.634190974284, 10880.67357979262, 10887.0, 11020.338779673246, 11110.222284440335, 11394.373309467726], "value": 9318.625762486754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1194.0805579703629, 1224.7856625090608, 1245.122188856856, 1248.5442813373118, 1250.3560666256874, 10063.698089057321, 10274.486275686224, 10573.84139237911, 10579.576816927323, 10583.417912014836, 10198.796024079515, 10335.069843714064, 10376.896231037706, 10400.21998350123, 10424.426656533888, 2155.2025750472308, 2172.7827217278223, 2180.7819218078143, 2202.570498752744, 2206.8344874134423, 2122.5754849030177, 2175.9129634814667, 2183.737951445829, 2184.3446965910243, 2190.11300423328, 2116.7248257726474, 2144.4746037220903, 2152.698622192894, 2167.6206663833846, 2176.455886028493, 2144.592527419793, 2183.5196256823474, 2188.5075857931997, 2192.6930229767845, 2194.6378847490146, 2010.9597808043757, 2066.2871309398233, 2108.5677436125557, 2117.947051323714, 2196.033745152128, 10271.691849244535, 10291.691249262534, 10374.585016599327, 10393.06462418386, 10402.895971040269, 5359.705216213107, 5528.336599608033, 5548.889022219573, 5559.555235581144, 5566.4990150886615, 3302.5871766029245, 3308.15642011288, 3432.056184549244, 3485.7037151842123, 3506.1059429845227, 1057.8360354145043, 1070.4487189097622, 1082.6210826210843, 1127.9848136677056, 1136.1876258475147, 14762.261886905719, 14876.107433553912, 14912.403503859832, 14924.925375373163, 14967.326470308753, 4539.296409056601, 4670.719756814602, 4854.466008739036, 4971.4282857471135, 4973.726445045557, 10494.212934029978, 10526.210534209966, 10540.894591054144, 10553.84169237462, 10568.048875601078, 5469.0, 5473.480019398151, 5489.780408783684, 5496.120620700669, 5517.806876759374, 4943.110240156806, 5040.924386134211, 5047.268146118866, 5066.594672426197, 5197.038547868657, 3677.558692956862, 3784.4890939722786, 3800.771953682788, 3852.0, 3879.980600097038, 1134.750354921916, 1135.4039129456935, 1138.869030061537, 1153.7115721069733, 1165.2891736041008, 671.9865602687919, 708.2174197511675, 715.9606221657755, 728.7813655903208, 732.0556482137982, 5437.782488700487, 5465.234867118606, 5539.224508568804, 5676.659400435905, 5697.686627235459, 522.6419902366891, 529.3066083430718, 539.1939051118603, 543.8796080075058, 545.3673738463364, 3326.234965957843, 3458.066322093021, 3595.676389124991, 3598.0, 3905.33609286422, 12459.439325230387, 13430.127041742451, 13441.731165376637, 13443.193408395528, 13450.865491345157, 12813.487460501476, 13067.673308167181, 13331.200127992352, 13400.128991615515, 13412.061155719006, 7188.712451501881, 7270.709171633075, 7355.5954422507275, 7380.852382952418, 7407.481476296715, 5688.431156884279, 5739.770409183586, 5781.103928891029, 5969.552283578662, 5990.700464976647, 11538.538458461568, 11596.0, 11707.531698731955, 11888.108391870817, 12065.939670301592, 12159.209651372632, 12246.755064898474, 12378.81431778542, 12409.379531023593, 12620.242785432903, 8033.357331413356, 8280.668773249243, 8288.50268983863, 8288.792780180544, 8302.460340077876, 9474.38416502925, 9652.710418687451, 9747.853782193131, 9773.609055637695, 9776.9022309776, 7983.760487185394, 8017.8396432072195, 8060.516369017878, 8084.555349455602, 8190.631421585924, 7796.649150788115, 7856.84286314282, 7872.370210383041, 7919.524828510308, 7943.880841787262, 7357.1907090218965, 7415.2214017527385, 7469.0, 7488.8876666848955, 7502.0, 5102.668326558762, 5139.897202056013, 5189.481051894781, 5191.402988656353, 5443.918341224964, 5194.428612852507, 5196.844094677014, 5291.550218231493, 5299.152135658276, 5473.917891231715], "value": 4646.201432758722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.08692008798755, 392.1177350960339, 397.8508059477696, 400.1017715229311, 401.4660501532961, 5316.308879845615, 5502.2296878437055, 5616.185653080301, 5670.234518340023, 5672.517835983941, 5331.733413329328, 5471.316085489304, 5475.260839786628, 5485.670859748418, 5527.806526771564, 4346.41323421338, 4349.934750978738, 4357.825686972517, 4362.803673834669, 4368.628666563346, 4292.570742925714, 4366.8034938427845, 4366.956330436703, 4372.956270437303, 4377.47470303564, 4285.0, 4286.335617979203, 4300.80646370914, 4307.0, 4337.306031035035, 4317.784110794463, 4350.78246087696, 4357.063231405263, 4367.45406824147, 4374.49693285273, 3891.630295121959, 3899.2396482685886, 3912.4913761211146, 3965.1276719122034, 3970.722049456539, 5331.813386531491, 5393.433689462589, 5409.675419474844, 5413.133898576249, 5440.83677489672, 5149.922751158736, 5152.6650767699975, 5161.354830646169, 5185.55922746567, 5210.609204309692, 5716.256886604757, 5834.883302333972, 5911.940880591182, 5936.97031514844, 5945.554083443716, 4429.645628349725, 4449.510553839075, 4452.195117076221, 4460.353248778909, 4467.731936083813, 5992.0, 6105.908411373788, 6138.17134686816, 6144.385561443864, 6160.429090581918, 4114.300568903293, 4114.588541145861, 4122.40225167349, 4122.42286079949, 4127.318992366226, 4168.374743788456, 4181.456410666655, 4183.435236243129, 4193.182329445729, 4195.58044195578, 4749.216379297446, 4817.807287708522, 4845.297431872429, 4855.5387238212315, 4859.611231101503, 5853.356130825606, 5869.178315035813, 5873.706314684248, 5892.0, 5915.935131676253, 1403.6631208509884, 1403.8736513713816, 1411.8305803303465, 1414.6251243420502, 1431.1270125223605, 932.421898422982, 961.4087336288133, 969.5103972493987, 973.9026097390205, 983.4148681534475, 5045.293658887758, 5053.140966035783, 5079.5428411443145, 5085.491450854959, 5090.618203634742, 5940.732667029994, 5975.4024597540765, 5987.491063259585, 6021.668808215591, 6046.546509011754, 4857.344258525054, 5014.89970200594, 5056.494350564914, 5079.577718238899, 5092.8472145835685, 3182.236263296792, 3231.5475833383343, 3243.8053716777067, 3247.7401807855313, 3249.415105281072, 5486.670799752028, 5680.289963754531, 5684.687342196219, 5694.629849059798, 5698.515626171739, 6217.937820621826, 6249.812505624838, 6262.843428914313, 6264.310925798159, 6268.717907694165, 5638.0, 5654.604177707603, 5673.631213971079, 5679.517241034476, 5682.602217844794, 5827.329857066492, 5982.756466325128, 6041.667708276087, 6055.636661800306, 6122.969385153046, 6038.758449661965, 6043.909341359795, 6044.607100538627, 6047.909281360871, 6050.30421501533, 5460.836174914759, 5558.304222452189, 5605.467480589337, 5621.578381621476, 5689.2319536862, 4625.768711564341, 4695.835645752382, 4711.175544279668, 4712.929306060343, 4714.976425117852, 5806.854828629318, 6026.397360263939, 6108.938910610837, 6117.938820611737, 6118.235220597426, 5861.413858614104, 5866.706664666664, 5871.383504731942, 5871.823845284648, 5881.705914704333, 5831.154482599914, 5864.794732184353, 5881.588288819741, 5891.49922256613, 5904.5866789326055, 5593.244911936837, 5717.742701578522, 5792.9710351447975, 5793.102069179284, 5806.764395707599, 5852.239208902815, 5901.085331773582, 5931.347551769216, 5956.583039187215, 5959.1657167995645, 5560.02699527573, 5715.199872018004, 5734.311882574118, 5742.511886489695, 5764.452377024176], "value": 4431.156178239472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.679820878813, 752.1688534169743, 753.4575105923733, 765.9310662040418, 778.5212094561842, 12908.225506469607, 13360.064795464321, 13833.17000979942, 13847.584572462816, 13907.374168162432, 14382.568522944328, 15491.457798977039, 15535.844641553582, 15687.529374118767, 15699.764503532428, 857.1813917708589, 882.0650110882453, 882.1927935938609, 886.3263919421222, 887.560657474551, 879.1823604048233, 879.8592225243963, 884.0982198157875, 884.5842454046588, 885.663447889801, 927.0960813207137, 930.2743859789341, 934.313279739391, 934.4066517761203, 935.7473482159813, 923.7875288683607, 923.8198551282503, 926.0091701878993, 927.1562877781221, 927.235031099339, 672.6300534705941, 678.762433148399, 680.9523333366666, 681.4276008153175, 682.5972676121112, 14248.145111293356, 14397.064190827667, 14782.778258326134, 14818.703625927421, 14924.0, 15922.20388980558, 15935.92032039844, 16263.918680406641, 16276.75584866228, 16304.836951630568, 12245.204061735958, 12245.204061736047, 12327.383630818513, 12401.25592464455, 12525.248485090924, 2930.7069293070736, 2961.540961151025, 2964.5108557088056, 2967.109867039879, 2982.209714425679, 74022.62988685076, 74142.62928685376, 74715.0, 75190.0, 75783.62108189423, 12713.427895744713, 12724.236545807282, 12959.287239201934, 12976.286304253168, 13017.609471715863, 21264.0, 21577.24479643205, 21631.0, 21844.672329915065, 21883.0, 6401.55189136756, 6677.499187560952, 6722.9663851680425, 6735.191776986793, 6758.459323254128, 2915.6063931368994, 2949.0710426215674, 3002.0993701889784, 3005.594244776927, 3013.789034767545, 3517.525134106863, 3527.276908233806, 3578.5169002184894, 3608.855645774192, 3617.04148400674, 724.199759266014, 728.6393235348536, 728.7376544443996, 730.3499885102264, 731.2760367236503, 564.8333741546171, 603.4930658247093, 605.3462260758371, 610.8503416662946, 615.2739767074805, 9370.203532699661, 9618.951905240428, 9900.801983960424, 9935.304528682922, 10146.594136234615, 571.1889117453227, 571.911353740171, 578.8957987562195, 586.4077281945266, 599.0385431382655, 3900.726949113535, 4053.0677944073027, 4085.22380747657, 4140.544540100586, 4186.874393768192, 63207.367926321065, 63440.68279658665, 64248.67875660685, 65548.67225663841, 66065.33934660688, 55217.0, 55900.440995589524, 56636.43363566394, 57123.0, 58270.0, 51965.7401712989, 51984.0, 52343.21485177725, 52345.0, 53492.197617034995, 8557.700480483154, 8749.343799214957, 8839.071897450674, 8921.375503714678, 9192.908070919206, 26708.599371009062, 26807.597886031333, 27183.45633087367, 27632.0, 27947.301317467227, 32506.0, 32564.51153232751, 32691.673083268863, 32701.672983270815, 33292.167695807795, 11427.885721143015, 11582.331395811754, 11609.129315301218, 11633.941830290794, 11705.297682139098, 12657.493700251887, 12667.80998285008, 13067.34663266852, 13249.536266230636, 13282.203067815575, 11488.080953523866, 11604.0, 11631.302121872715, 11736.647900562997, 11859.05127589808, 11730.824037639613, 11730.941345293219, 11833.585824496446, 11970.76058478808, 12134.211276267015, 11502.597409090642, 11796.646100616996, 11971.221870578385, 12005.339706315886, 12040.397980101136, 8488.278496327881, 8564.828703426021, 8613.22480976715, 8694.782630434289, 8748.357309535188, 9190.035046320307, 9316.673916412892, 9331.346805723806, 9366.718998430058, 9472.57373418184], "value": 6577.197347037212, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 112.0, 113.0, 112.0, 112.0, 113.0, 114.0, 112.0, 114.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 127.0, 165.0, 132.0, 133.0, 130.0, 124.0, 149.0, 123.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 167.0, 162.0, 162.0, 166.0, 172.0, 166.0, 165.0, 166.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 108.0, 76.0, 78.0, 76.0, 75.0, 94.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 104.0, 83.0, 83.0, 87.0, 95.0, 84.0, 84.0, 108.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 115.0, 115.0, 120.0, 116.0, 117.0, 114.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 153.0, 150.0, 151.0, 151.0, 151.0, 152.0, 151.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 54.0, 55.0, 57.0, 56.0, 56.0, 61.0, 57.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 58.0, 56.0, 55.0, 56.0, 55.0, 56.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 84.0, 83.0, 83.0, 92.0, 83.0, 82.0, 81.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 143.0, 133.0, 135.0, 141.0, 140.0, 136.0, 140.0, 183.0, 132.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 202.0, 198.0, 202.0, 195.0, 195.0, 197.0, 195.0, 195.0, 194.0], "value": 197.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 72.0, 77.0, 79.0, 76.0, 77.0, 72.0, 74.0, 71.0], "value": 74.9, "unit": "score"}]}]} 18:14:17 INFO - Return code: 0 18:14:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:14:17 INFO - # TBPL SUCCESS # 18:14:17 INFO - Running post-action listener: _resource_record_post_action 18:14:17 INFO - [mozharness: 2017-05-17 01:14:17.797838Z] Finished run-tests step (success) 18:14:17 INFO - Running post-run listener: _resource_record_post_run 18:14:17 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 335872; Write bytes: 391761920; Read time: 104; Write time: 240208 18:14:17 INFO - TinderboxPrint: CPU usage
13.3% 18:14:17 INFO - TinderboxPrint: I/O read bytes / time
335,872 / 104 18:14:17 INFO - TinderboxPrint: I/O write bytes / time
391,761,920 / 240,208 18:14:17 INFO - TinderboxPrint: CPU idle
8,298.4 (86.6%) 18:14:17 INFO - TinderboxPrint: CPU user
1,220.3 (12.7%) 18:14:17 INFO - TinderboxPrint: Swap in / out
0 / 0 18:14:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108396544; Read time: 0; Write time: 77984 18:14:17 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 335872; Write bytes: 283365376; Read time: 104; Write time: 162224 18:14:18 INFO - Running post-run listener: _upload_blobber_files 18:14:18 INFO - Blob upload gear active. 18:14:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:14:18 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 18:14:18 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'] 18:14:18 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 18:14:18 INFO - (blobuploader) - INFO - Open directory for files ... 18:14:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:14:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:14:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:19 INFO - (blobuploader) - INFO - Done attempting. 18:14:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:14:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:14:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:20 INFO - (blobuploader) - INFO - Done attempting. 18:14:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:14:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:14:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:23 INFO - (blobuploader) - INFO - Done attempting. 18:14:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:14:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:14:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:24 INFO - (blobuploader) - INFO - Done attempting. 18:14:24 INFO - (blobuploader) - INFO - Iteration through files over. 18:14:24 INFO - Return code: 0 18:14:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:14:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:14:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/315383b9d6c3104b0595c5817cf44cf38b3925bb5fb53c1bf3d2c282850f52db4c464e53dcc1b5b89e1ebe8157621842ab282bf533c81735b21404cc8877428f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc681067e713bf103200dc70a3ee74ff77c8684aeb3032158df0b186dab60c3755bc089f55cc52742a11c7e6138456672343b8e8968efd3d769a91ef14285c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42adce61ef83c2182e49fc5c602cd14253f743407d3262e7166e5088491ebfc2f23ed9033d9f72a75f1c14d7d1d35fa3030d08b9c647b6a410bce966146fae5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de29c6eae07eb938813993298c1bf44152c1ef35de5f88cbedb4c9d7a606df74097b8f2a6012a88dac199a95e1d257074297a2caef148176ebbf990e38eea02"} 18:14:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:14:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:14:24 INFO - Contents: 18:14:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/315383b9d6c3104b0595c5817cf44cf38b3925bb5fb53c1bf3d2c282850f52db4c464e53dcc1b5b89e1ebe8157621842ab282bf533c81735b21404cc8877428f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc681067e713bf103200dc70a3ee74ff77c8684aeb3032158df0b186dab60c3755bc089f55cc52742a11c7e6138456672343b8e8968efd3d769a91ef14285c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42adce61ef83c2182e49fc5c602cd14253f743407d3262e7166e5088491ebfc2f23ed9033d9f72a75f1c14d7d1d35fa3030d08b9c647b6a410bce966146fae5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de29c6eae07eb938813993298c1bf44152c1ef35de5f88cbedb4c9d7a606df74097b8f2a6012a88dac199a95e1d257074297a2caef148176ebbf990e38eea02"} 18:14:24 INFO - Running post-run listener: copy_logs_to_upload_dir 18:14:24 INFO - Copying logs to upload dir... 18:14:24 INFO - mkdir: /builds/slave/test/build/upload/logs 18:14:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.163007 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-05-16 18:14:24.121552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 18:14:24.124942) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/315383b9d6c3104b0595c5817cf44cf38b3925bb5fb53c1bf3d2c282850f52db4c464e53dcc1b5b89e1ebe8157621842ab282bf533c81735b21404cc8877428f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc681067e713bf103200dc70a3ee74ff77c8684aeb3032158df0b186dab60c3755bc089f55cc52742a11c7e6138456672343b8e8968efd3d769a91ef14285c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42adce61ef83c2182e49fc5c602cd14253f743407d3262e7166e5088491ebfc2f23ed9033d9f72a75f1c14d7d1d35fa3030d08b9c647b6a410bce966146fae5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de29c6eae07eb938813993298c1bf44152c1ef35de5f88cbedb4c9d7a606df74097b8f2a6012a88dac199a95e1d257074297a2caef148176ebbf990e38eea02"} build_url:https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/ZnMw7_PfQZmCuXgwMjPBEQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/315383b9d6c3104b0595c5817cf44cf38b3925bb5fb53c1bf3d2c282850f52db4c464e53dcc1b5b89e1ebe8157621842ab282bf533c81735b21404cc8877428f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc681067e713bf103200dc70a3ee74ff77c8684aeb3032158df0b186dab60c3755bc089f55cc52742a11c7e6138456672343b8e8968efd3d769a91ef14285c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42adce61ef83c2182e49fc5c602cd14253f743407d3262e7166e5088491ebfc2f23ed9033d9f72a75f1c14d7d1d35fa3030d08b9c647b6a410bce966146fae5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de29c6eae07eb938813993298c1bf44152c1ef35de5f88cbedb4c9d7a606df74097b8f2a6012a88dac199a95e1d257074297a2caef148176ebbf990e38eea02"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 18:14:24.149508) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 18:14:24.149863) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494974334.965063-1152989918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 18:14:24.232520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 18:14:24.232870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 18:14:24.233198) ========= ========= Total master_lag: 0.21 =========