builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1495210443.35 results: success (0) revision: 1ea1b40c2679da341d50d27226c61033bac06711 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:03.348477) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:03.348897) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:03.350167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:03.366231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:03.366571) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-19 09:14:03-- 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% 37.5M=0s 2017-05-19 09:14:03 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153570 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:03.642644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:03.642930) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022933 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:03.684957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:03.685248) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1ea1b40c2679da341d50d27226c61033bac06711 --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 1ea1b40c2679da341d50d27226c61033bac06711 --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=a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-19 09:14:03,963 truncating revision to first 12 chars 2017-05-19 09:14:03,963 Setting DEBUG logging. 2017-05-19 09:14:03,963 attempt 1/10 2017-05-19 09:14:03,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1ea1b40c2679?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 09:14:04,269 unpacking tar archive at: mozilla-central-1ea1b40c2679/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634181 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:04.331843) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:04.332211) ========= script_repo_revision: 1ea1b40c2679da341d50d27226c61033bac06711 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:04.332661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:04.333109) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 09:14:04.341500) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-19 09:14:04.341842) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:14:04 INFO - MultiFileLogger online at 20170519 09:14:04 in /builds/slave/test 09:14:04 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 09:14:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:04 INFO - {'append_to_log': False, 09:14:04 INFO - 'base_work_dir': '/builds/slave/test', 09:14:04 INFO - 'blob_upload_branch': 'Firefox', 09:14:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:04 INFO - 'branch': 'Firefox', 09:14:04 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:04 INFO - 'config_files': ('talos/linux_config.py',), 09:14:04 INFO - 'default_actions': ('clobber', 09:14:04 INFO - 'read-buildbot-config', 09:14:04 INFO - 'download-and-extract', 09:14:04 INFO - 'populate-webroot', 09:14:04 INFO - 'create-virtualenv', 09:14:04 INFO - 'install', 09:14:04 INFO - 'run-tests'), 09:14:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:04 INFO - 'download_minidump_stackwalk': True, 09:14:04 INFO - 'download_symbols': 'ondemand', 09:14:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:04 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:04 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:04 INFO - 'gecko_profile': False, 09:14:04 INFO - 'gecko_profile_interval': 0, 09:14:04 INFO - 'installer_path': 'installer.exe', 09:14:04 INFO - 'log_level': 'info', 09:14:04 INFO - 'log_name': 'talos', 09:14:04 INFO - 'log_to_console': True, 09:14:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:14:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:14:04 INFO - 'opt_config_files': (), 09:14:04 INFO - 'pip_index': False, 09:14:04 INFO - 'suite': 'dromaeojs-e10s', 09:14:04 INFO - 'system_bits': '32', 09:14:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:04 INFO - 'title': 'talos-linux64-ix-064', 09:14:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:04 INFO - 'use_talos_json': True, 09:14:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:04 INFO - 'work_dir': 'build'} 09:14:04 INFO - [mozharness: 2017-05-19 16:14:04.721931Z] Running clobber step. 09:14:04 INFO - Running pre-action listener: _resource_record_pre_action 09:14:04 INFO - Running main action method: clobber 09:14:04 INFO - rmtree: /builds/slave/test/build 09:14:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:06 INFO - Running post-action listener: _resource_record_post_action 09:14:06 INFO - [mozharness: 2017-05-19 16:14:06.239247Z] Finished clobber step (success) 09:14:06 INFO - [mozharness: 2017-05-19 16:14:06.239346Z] Running read-buildbot-config step. 09:14:06 INFO - Running pre-action listener: _resource_record_pre_action 09:14:06 INFO - Running main action method: read_buildbot_config 09:14:06 INFO - Using buildbot properties: 09:14:06 INFO - { 09:14:06 INFO - "project": "", 09:14:06 INFO - "product": "firefox", 09:14:06 INFO - "who": "ffxbld@noreply.mozilla.org", 09:14:06 INFO - "installer_path": "public/build/target.tar.bz2", 09:14:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:14:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:14:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:14:06 INFO - "stage_platform": "linux64-stylosequential", 09:14:06 INFO - "basedir": "/builds/slave/test", 09:14:06 INFO - "buildnumber": 5, 09:14:06 INFO - "platform": "ubuntu64_hw_styloseq", 09:14:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:14:06 INFO - "slavebuilddir": "test", 09:14:06 INFO - "taskId": "DwLu4REAS3y47HP_PRDsiw", 09:14:06 INFO - "branch": "mozilla-central", 09:14:06 INFO - "script_repo_revision": "production", 09:14:06 INFO - "revision": "1ea1b40c2679da341d50d27226c61033bac06711", 09:14:06 INFO - "slavename": "talos-linux64-ix-064", 09:14:06 INFO - "repo_path": "mozilla-central" 09:14:06 INFO - } 09:14:06 INFO - Finding installer, test and symbols from parent task. 09:14:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwLu4REAS3y47HP_PRDsiw'}, attempt #1 09:14:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwLu4REAS3y47HP_PRDsiw'}, attempt #1 09:14:07 INFO - Task dependencies: Vy_hf-shQ-mdsWttWHqW9g 09:14:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g'}, attempt #1 09:14:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.tar.bz2 09:14:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/test_packages.json 09:14:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.crashreporter-symbols.zip 09:14:07 INFO - Running post-action listener: _resource_record_post_action 09:14:07 INFO - [mozharness: 2017-05-19 16:14:07.607208Z] Finished read-buildbot-config step (success) 09:14:07 INFO - [mozharness: 2017-05-19 16:14:07.607428Z] Running download-and-extract step. 09:14:07 INFO - Running pre-action listener: _resource_record_pre_action 09:14:07 INFO - Running main action method: download_and_extract 09:14:07 INFO - mkdir: /builds/slave/test/build/tests 09:14:07 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')]} 09:14:07 INFO - trying https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.test_packages.json 09:14:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:14:08 INFO - Downloaded 986 bytes. 09:14:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:14:08 INFO - Using the following test package requirements: 09:14:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:14:08 INFO - u'common': [u'target.common.tests.zip'], 09:14:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:14:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:14:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:14:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:14:08 INFO - u'mozbase': [u'target.common.tests.zip'], 09:14:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:14:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:14:08 INFO - u'web-platform': [u'target.common.tests.zip', 09:14:08 INFO - u'target.web-platform.tests.zip'], 09:14:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:14:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:14:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.common.tests.zip 09:14:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:14:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.common.tests.zip into memory 09:14:10 INFO - Content-Length response header: 62465443 09:14:10 INFO - Bytes received: 62465443 09:14:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:14:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.common.tests.zip 09:14:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:14:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.common.tests.zip into memory 09:14:22 INFO - Content-Length response header: 62465443 09:14:22 INFO - Bytes received: 62465443 09:14:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.talos.tests.zip 09:14:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:14:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.talos.tests.zip into memory 09:14:34 INFO - Content-Length response header: 14410001 09:14:34 INFO - Bytes received: 14410001 09:14: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')]} 09:14:34 INFO - trying https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.tar.bz2 09:14:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:14:36 INFO - Downloaded 59802747 bytes. 09:14:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.tar.bz2 09:14:36 INFO - mkdir: /builds/slave/test/properties 09:14:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:14:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:14:36 INFO - Contents: 09:14:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.tar.bz2 09:14:36 INFO - Running post-action listener: _resource_record_post_action 09:14:36 INFO - Running post-action listener: set_extra_try_arguments 09:14:36 INFO - [mozharness: 2017-05-19 16:14:36.421333Z] Finished download-and-extract step (success) 09:14:36 INFO - [mozharness: 2017-05-19 16:14:36.421560Z] Running populate-webroot step. 09:14:36 INFO - Running pre-action listener: _resource_record_pre_action 09:14:36 INFO - Running main action method: populate_webroot 09:14:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:36 INFO - '--tppagecycles', 09:14:36 INFO - '7'], 09:14:36 INFO - 'tests': ['tsvgm']}}, 09:14:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:14:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:14:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:14:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:14:36 INFO - 'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:14:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:14:36 INFO - 'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['damp', 'tps']}, 09:14:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:14:36 INFO - 'tests': ['damp', 'tps']}, 09:14:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['dromaeo_dom']}, 09:14:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:14:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:14:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:14:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:14:36 INFO - 'tests': ['ts_paint', 'tp5o']}, 09:14:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['a11yr', 09:14:36 INFO - 'ts_paint', 09:14:36 INFO - 'tpaint', 09:14:36 INFO - 'sessionrestore', 09:14:36 INFO - 'sessionrestore_no_auto_restore', 09:14:36 INFO - 'tabpaint']}, 09:14:36 INFO - 'other-e10s': {'tests': ['a11yr', 09:14:36 INFO - 'ts_paint', 09:14:36 INFO - 'tpaint', 09:14:36 INFO - 'sessionrestore', 09:14:36 INFO - 'sessionrestore_no_auto_restore', 09:14:36 INFO - 'tabpaint']}, 09:14:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:14:36 INFO - 'ts_paint', 09:14:36 INFO - 'tpaint', 09:14:36 INFO - 'sessionrestore', 09:14:36 INFO - 'sessionrestore_no_auto_restore', 09:14:36 INFO - 'tabpaint']}, 09:14:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:14:36 INFO - 'ts_paint', 09:14:36 INFO - 'tpaint', 09:14:36 INFO - 'sessionrestore', 09:14:36 INFO - 'sessionrestore_no_auto_restore', 09:14:36 INFO - 'tabpaint']}, 09:14:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['a11yr', 09:14:36 INFO - 'ts_paint', 09:14:36 INFO - 'tpaint', 09:14:36 INFO - 'sessionrestore', 09:14:36 INFO - 'sessionrestore_no_auto_restore', 09:14:36 INFO - 'tabpaint']}, 09:14:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['a11yr', 09:14:36 INFO - 'ts_paint', 09:14:36 INFO - 'tpaint', 09:14:36 INFO - 'sessionrestore', 09:14:36 INFO - 'sessionrestore_no_auto_restore', 09:14:36 INFO - 'tabpaint']}, 09:14:36 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:14:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:14:36 INFO - 'bloom_basic_ref']}, 09:14:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['tsvgx', 09:14:36 INFO - 'tsvgr_opacity', 09:14:36 INFO - 'tart', 09:14:36 INFO - 'tscrollx', 09:14:36 INFO - 'cart', 09:14:36 INFO - 'tsvg_static']}, 09:14:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:14:36 INFO - 'tsvgr_opacity', 09:14:36 INFO - 'tart', 09:14:36 INFO - 'tscrollx', 09:14:36 INFO - 'cart', 09:14:36 INFO - 'tsvg_static']}, 09:14:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:14:36 INFO - 'talos_options': ['--disable-e10s'], 09:14:36 INFO - 'tests': ['tp5o']}, 09:14:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:14:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:14:36 INFO - 'talos_options': ['--disable-e10s', 09:14:36 INFO - '--xperf_path', 09:14:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:36 INFO - 'tests': ['tp5n']}, 09:14:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:14:36 INFO - 'talos_options': ['--xperf_path', 09:14:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:36 INFO - 'tests': ['tp5n']}}, 09:14:36 INFO - 'talos.zip': {'path': '', 09:14:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:36 INFO - Running post-action listener: _resource_record_post_action 09:14:36 INFO - [mozharness: 2017-05-19 16:14:36.438483Z] Finished populate-webroot step (success) 09:14:36 INFO - [mozharness: 2017-05-19 16:14:36.438572Z] Running create-virtualenv step. 09:14:36 INFO - Running pre-action listener: _resource_record_pre_action 09:14:36 INFO - Running main action method: create_virtualenv 09:14:36 INFO - Creating virtualenv /builds/slave/test/build/venv 09:14:36 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 09:14:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:14:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:36 INFO - Using real prefix '/usr' 09:14:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:14:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:14:39 INFO - Installing pip.................done. 09:14:39 INFO - Return code: 0 09:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:14:39 INFO - Reading from file tmpfile_stdout 09:14:39 INFO - Output received: 09:14:39 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) 09:14:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', '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 09:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:14:39 INFO - Using env: {'DISPLAY': ':0', 09:14:39 INFO - 'HOME': '/home/cltbld', 09:14:39 INFO - 'LANG': 'en_US.UTF-8', 09:14:39 INFO - 'LANGUAGE': 'en_US:en', 09:14:39 INFO - 'LOGNAME': 'cltbld', 09:14:39 INFO - 'MAIL': '/var/mail/cltbld', 09:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:39 INFO - 'MOZ_NO_REMOTE': '1', 09:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:39 INFO - 'NO_EM_RESTART': '1', 09:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:39 INFO - 'PWD': '/builds/slave/test', 09:14:39 INFO - 'SHELL': '/bin/bash', 09:14:39 INFO - 'SHLVL': '1', 09:14:39 INFO - 'TERM': 'linux', 09:14:39 INFO - 'TMOUT': '86400', 09:14:39 INFO - 'USER': 'cltbld', 09:14:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:39 INFO - '_': '/tools/buildbot/bin/python'} 09:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:39 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 09:14:39 INFO - Cleaning up... 09:14:39 INFO - Return code: 0 09:14:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', '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 09:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:14:39 INFO - Using env: {'DISPLAY': ':0', 09:14:39 INFO - 'HOME': '/home/cltbld', 09:14:39 INFO - 'LANG': 'en_US.UTF-8', 09:14:39 INFO - 'LANGUAGE': 'en_US:en', 09:14:39 INFO - 'LOGNAME': 'cltbld', 09:14:39 INFO - 'MAIL': '/var/mail/cltbld', 09:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:39 INFO - 'MOZ_NO_REMOTE': '1', 09:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:39 INFO - 'NO_EM_RESTART': '1', 09:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:39 INFO - 'PWD': '/builds/slave/test', 09:14:39 INFO - 'SHELL': '/bin/bash', 09:14:39 INFO - 'SHLVL': '1', 09:14:39 INFO - 'TERM': 'linux', 09:14:39 INFO - 'TMOUT': '86400', 09:14:39 INFO - 'USER': 'cltbld', 09:14:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:39 INFO - '_': '/tools/buildbot/bin/python'} 09:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:39 INFO - Downloading/unpacking psutil>=3.1.1 09:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:14:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:40 INFO - Installing collected packages: psutil 09:14:40 INFO - Running setup.py install for psutil 09:14:40 INFO - building 'psutil._psutil_linux' extension 09:14:40 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 09:14:41 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 09:14:41 INFO - building 'psutil._psutil_posix' extension 09:14:41 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 09:14:41 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 09:14:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:41 INFO - Successfully installed psutil 09:14:41 INFO - Cleaning up... 09:14:41 INFO - Return code: 0 09:14:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', '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 09:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:14:41 INFO - Using env: {'DISPLAY': ':0', 09:14:41 INFO - 'HOME': '/home/cltbld', 09:14:41 INFO - 'LANG': 'en_US.UTF-8', 09:14:41 INFO - 'LANGUAGE': 'en_US:en', 09:14:41 INFO - 'LOGNAME': 'cltbld', 09:14:41 INFO - 'MAIL': '/var/mail/cltbld', 09:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:41 INFO - 'MOZ_NO_REMOTE': '1', 09:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:41 INFO - 'NO_EM_RESTART': '1', 09:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:41 INFO - 'PWD': '/builds/slave/test', 09:14:41 INFO - 'SHELL': '/bin/bash', 09:14:41 INFO - 'SHLVL': '1', 09:14:41 INFO - 'TERM': 'linux', 09:14:41 INFO - 'TMOUT': '86400', 09:14:41 INFO - 'USER': 'cltbld', 09:14:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:41 INFO - '_': '/tools/buildbot/bin/python'} 09:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:14:42 INFO - Installing collected packages: mozsystemmonitor 09:14:42 INFO - Running setup.py install for mozsystemmonitor 09:14:42 INFO - Successfully installed mozsystemmonitor 09:14:42 INFO - Cleaning up... 09:14:42 INFO - Return code: 0 09:14:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', '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 09:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:14:42 INFO - Using env: {'DISPLAY': ':0', 09:14:42 INFO - 'HOME': '/home/cltbld', 09:14:42 INFO - 'LANG': 'en_US.UTF-8', 09:14:42 INFO - 'LANGUAGE': 'en_US:en', 09:14:42 INFO - 'LOGNAME': 'cltbld', 09:14:42 INFO - 'MAIL': '/var/mail/cltbld', 09:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:42 INFO - 'MOZ_NO_REMOTE': '1', 09:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:42 INFO - 'NO_EM_RESTART': '1', 09:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:42 INFO - 'PWD': '/builds/slave/test', 09:14:42 INFO - 'SHELL': '/bin/bash', 09:14:42 INFO - 'SHLVL': '1', 09:14:42 INFO - 'TERM': 'linux', 09:14:42 INFO - 'TMOUT': '86400', 09:14:42 INFO - 'USER': 'cltbld', 09:14:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:42 INFO - '_': '/tools/buildbot/bin/python'} 09:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:43 INFO - Downloading/unpacking jsonschema==2.5.1 09:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:14:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:44 INFO - Downloading functools32-3.2.3-2.tar.gz 09:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:14:44 INFO - warning: no files found matching '*.txt' 09:14:44 INFO - no previously-included directories found matching 'build' 09:14:44 INFO - no previously-included directories found matching 'dist' 09:14:44 INFO - no previously-included directories found matching '.git*' 09:14:44 INFO - Installing collected packages: jsonschema, functools32 09:14:44 INFO - Running setup.py install for functools32 09:14:44 INFO - warning: no files found matching '*.txt' 09:14:44 INFO - no previously-included directories found matching 'build' 09:14:44 INFO - no previously-included directories found matching 'dist' 09:14:44 INFO - no previously-included directories found matching '.git*' 09:14:44 INFO - Successfully installed jsonschema functools32 09:14:44 INFO - Cleaning up... 09:14:44 INFO - Return code: 0 09:14:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:14:44 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')]} 09:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:44 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')]} 09:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:44 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 0x1d4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', '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 09:14:44 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 09:14:44 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 09:14:44 INFO - Using env: {'DISPLAY': ':0', 09:14:44 INFO - 'HOME': '/home/cltbld', 09:14:44 INFO - 'LANG': 'en_US.UTF-8', 09:14:44 INFO - 'LANGUAGE': 'en_US:en', 09:14:44 INFO - 'LOGNAME': 'cltbld', 09:14:44 INFO - 'MAIL': '/var/mail/cltbld', 09:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:44 INFO - 'MOZ_NO_REMOTE': '1', 09:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:44 INFO - 'NO_EM_RESTART': '1', 09:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:44 INFO - 'PWD': '/builds/slave/test', 09:14:44 INFO - 'SHELL': '/bin/bash', 09:14:44 INFO - 'SHLVL': '1', 09:14:44 INFO - 'TERM': 'linux', 09:14:44 INFO - 'TMOUT': '86400', 09:14:44 INFO - 'USER': 'cltbld', 09:14:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:44 INFO - '_': '/tools/buildbot/bin/python'} 09:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:14:44 INFO - Cleaning up... 09:14:44 INFO - Return code: 0 09:14:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:14:44 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')]} 09:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:44 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')]} 09:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:44 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 0x1d4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', '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 09:14:44 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 09:14:44 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 09:14:44 INFO - Using env: {'DISPLAY': ':0', 09:14:44 INFO - 'HOME': '/home/cltbld', 09:14:44 INFO - 'LANG': 'en_US.UTF-8', 09:14:44 INFO - 'LANGUAGE': 'en_US:en', 09:14:44 INFO - 'LOGNAME': 'cltbld', 09:14:44 INFO - 'MAIL': '/var/mail/cltbld', 09:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:44 INFO - 'MOZ_NO_REMOTE': '1', 09:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:44 INFO - 'NO_EM_RESTART': '1', 09:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:44 INFO - 'PWD': '/builds/slave/test', 09:14:44 INFO - 'SHELL': '/bin/bash', 09:14:44 INFO - 'SHLVL': '1', 09:14:44 INFO - 'TERM': 'linux', 09:14:44 INFO - 'TMOUT': '86400', 09:14:44 INFO - 'USER': 'cltbld', 09:14:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:44 INFO - '_': '/tools/buildbot/bin/python'} 09:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:44 INFO - Downloading/unpacking blobuploader==1.2.4 09:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:46 INFO - Downloading blobuploader-1.2.4.tar.gz 09:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:14:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:14:46 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 09:14:46 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 09:14:46 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 09:14:46 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 09:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:14:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:14:46 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 09:14:46 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 09:14:46 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 09:14:46 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 09:14:46 INFO - Downloading docopt-0.6.1.tar.gz 09:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:14:46 INFO - Installing collected packages: blobuploader, requests, docopt 09:14:46 INFO - Running setup.py install for blobuploader 09:14:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:14:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:14:46 INFO - Running setup.py install for requests 09:14:47 INFO - Running setup.py install for docopt 09:14:47 INFO - Successfully installed blobuploader requests docopt 09:14:47 INFO - Cleaning up... 09:14:47 INFO - Return code: 0 09:14:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:47 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 0x1d4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', '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 09:14:47 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 09:14:47 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 09:14:47 INFO - Using env: {'DISPLAY': ':0', 09:14:47 INFO - 'HOME': '/home/cltbld', 09:14:47 INFO - 'LANG': 'en_US.UTF-8', 09:14:47 INFO - 'LANGUAGE': 'en_US:en', 09:14:47 INFO - 'LOGNAME': 'cltbld', 09:14:47 INFO - 'MAIL': '/var/mail/cltbld', 09:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:47 INFO - 'MOZ_NO_REMOTE': '1', 09:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:47 INFO - 'NO_EM_RESTART': '1', 09:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:47 INFO - 'PWD': '/builds/slave/test', 09:14:47 INFO - 'SHELL': '/bin/bash', 09:14:47 INFO - 'SHLVL': '1', 09:14:47 INFO - 'TERM': 'linux', 09:14:47 INFO - 'TMOUT': '86400', 09:14:47 INFO - 'USER': 'cltbld', 09:14:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:47 INFO - '_': '/tools/buildbot/bin/python'} 09:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:47 INFO - Running setup.py (path:/tmp/pip-4pqD1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:47 INFO - Running setup.py (path:/tmp/pip-TyoBTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:47 INFO - Running setup.py (path:/tmp/pip-KHcrBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:47 INFO - Running setup.py (path:/tmp/pip-3tfBIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:47 INFO - Running setup.py (path:/tmp/pip-I_pp_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:47 INFO - Running setup.py (path:/tmp/pip-1GPJNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:47 INFO - Running setup.py (path:/tmp/pip-257zzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:47 INFO - Running setup.py (path:/tmp/pip-NP8Ysx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:48 INFO - Running setup.py (path:/tmp/pip-5WK6HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:48 INFO - Running setup.py (path:/tmp/pip-yvrXzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:48 INFO - Running setup.py (path:/tmp/pip-cETs20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:48 INFO - Running setup.py (path:/tmp/pip-iaxifI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:48 INFO - Running setup.py (path:/tmp/pip-elDh4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:48 INFO - Running setup.py (path:/tmp/pip-ZjGFmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:48 INFO - Running setup.py (path:/tmp/pip-r4Zzvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:48 INFO - Running setup.py (path:/tmp/pip-f_W5R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:48 INFO - Running setup.py (path:/tmp/pip-TVuosu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:14:48 INFO - Running setup.py install for manifestparser 09:14:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:14:48 INFO - Running setup.py install for mozcrash 09:14:48 INFO - Running setup.py install for mozdebug 09:14:48 INFO - Running setup.py install for mozdevice 09:14:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for mozfile 09:14:49 INFO - Running setup.py install for mozhttpd 09:14:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for mozinfo 09:14:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for mozInstall 09:14:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for mozleak 09:14:49 INFO - Running setup.py install for mozlog 09:14:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for moznetwork 09:14:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for mozprocess 09:14:49 INFO - Running setup.py install for mozprofile 09:14:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:14:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:14:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:14:50 INFO - Running setup.py install for mozrunner 09:14:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:14:50 INFO - Running setup.py install for mozscreenshot 09:14:50 INFO - Running setup.py install for moztest 09:14:50 INFO - Running setup.py install for mozversion 09:14:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:14:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:14:50 INFO - Cleaning up... 09:14:50 INFO - Return code: 0 09:14:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:50 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 0x1d4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', '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 09:14:50 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 09:14:50 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 09:14:50 INFO - Using env: {'DISPLAY': ':0', 09:14:50 INFO - 'HOME': '/home/cltbld', 09:14:50 INFO - 'LANG': 'en_US.UTF-8', 09:14:50 INFO - 'LANGUAGE': 'en_US:en', 09:14:50 INFO - 'LOGNAME': 'cltbld', 09:14:50 INFO - 'MAIL': '/var/mail/cltbld', 09:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:50 INFO - 'MOZ_NO_REMOTE': '1', 09:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:50 INFO - 'NO_EM_RESTART': '1', 09:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:50 INFO - 'PWD': '/builds/slave/test', 09:14:50 INFO - 'SHELL': '/bin/bash', 09:14:50 INFO - 'SHLVL': '1', 09:14:50 INFO - 'TERM': 'linux', 09:14:50 INFO - 'TMOUT': '86400', 09:14:50 INFO - 'USER': 'cltbld', 09:14:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:50 INFO - '_': '/tools/buildbot/bin/python'} 09:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:50 INFO - Running setup.py (path:/tmp/pip-Lh20IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:50 INFO - Running setup.py (path:/tmp/pip-hG0RXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:50 INFO - Running setup.py (path:/tmp/pip-oPqKeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:50 INFO - Running setup.py (path:/tmp/pip-6poFDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:50 INFO - Running setup.py (path:/tmp/pip-RtQzSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:51 INFO - Running setup.py (path:/tmp/pip-b3dnUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:51 INFO - Running setup.py (path:/tmp/pip-6OJAYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:51 INFO - Running setup.py (path:/tmp/pip-4sgs7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:51 INFO - Running setup.py (path:/tmp/pip-HYoR4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:51 INFO - Running setup.py (path:/tmp/pip-hRpihb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:51 INFO - Running setup.py (path:/tmp/pip-3knhrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:51 INFO - Running setup.py (path:/tmp/pip-nNmp0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:51 INFO - Running setup.py (path:/tmp/pip-ArxIEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:51 INFO - Running setup.py (path:/tmp/pip-_4BbLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:51 INFO - Running setup.py (path:/tmp/pip-ivNXuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:51 INFO - Running setup.py (path:/tmp/pip-524JVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:51 INFO - Running setup.py (path:/tmp/pip-Y5qB8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:51 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)) 09:14:51 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)) 09:14:51 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)) 09:14:51 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)) 09:14:51 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)) 09:14:51 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)) 09:14:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:51 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 09:14:51 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 09:14:51 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 09:14:51 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 09:14:52 INFO - Downloading blessings-1.6.tar.gz 09:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:14:53 INFO - Installing collected packages: blessings 09:14:53 INFO - Running setup.py install for blessings 09:14:53 INFO - Successfully installed blessings 09:14:53 INFO - Cleaning up... 09:14:53 INFO - Return code: 0 09:14:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:53 INFO - Reading from file tmpfile_stdout 09:14:53 INFO - Current package versions: 09:14:53 INFO - argparse == 1.2.1 09:14:53 INFO - blessings == 1.6 09:14:53 INFO - blobuploader == 1.2.4 09:14:53 INFO - docopt == 0.6.1 09:14:53 INFO - functools32 == 3.2.3-2 09:14:53 INFO - jsonschema == 2.5.1 09:14:53 INFO - manifestparser == 1.1 09:14:53 INFO - mozInstall == 1.12 09:14:53 INFO - mozcrash == 1.0 09:14:53 INFO - mozdebug == 0.1 09:14:53 INFO - mozdevice == 0.50 09:14:53 INFO - mozfile == 1.2 09:14:53 INFO - mozhttpd == 0.7 09:14:53 INFO - mozinfo == 0.9 09:14:53 INFO - mozleak == 0.1 09:14:53 INFO - mozlog == 3.4 09:14:53 INFO - moznetwork == 0.27 09:14:53 INFO - mozprocess == 0.25 09:14:53 INFO - mozprofile == 0.28 09:14:53 INFO - mozrunner == 6.13 09:14:53 INFO - mozscreenshot == 0.1 09:14:53 INFO - mozsystemmonitor == 0.3 09:14:53 INFO - moztest == 0.8 09:14:53 INFO - mozversion == 1.4 09:14:53 INFO - psutil == 3.1.1 09:14:53 INFO - requests == 1.2.3 09:14:53 INFO - wsgiref == 0.1.2 09:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:53 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')]} 09:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:53 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')]} 09:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:53 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 0x1d4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', '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 09:14:53 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 09:14:53 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 09:14:53 INFO - Using env: {'DISPLAY': ':0', 09:14:53 INFO - 'HOME': '/home/cltbld', 09:14:53 INFO - 'LANG': 'en_US.UTF-8', 09:14:53 INFO - 'LANGUAGE': 'en_US:en', 09:14:53 INFO - 'LOGNAME': 'cltbld', 09:14:53 INFO - 'MAIL': '/var/mail/cltbld', 09:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:53 INFO - 'MOZ_NO_REMOTE': '1', 09:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:53 INFO - 'NO_EM_RESTART': '1', 09:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:53 INFO - 'PWD': '/builds/slave/test', 09:14:53 INFO - 'SHELL': '/bin/bash', 09:14:53 INFO - 'SHLVL': '1', 09:14:53 INFO - 'TERM': 'linux', 09:14:53 INFO - 'TMOUT': '86400', 09:14:53 INFO - 'USER': 'cltbld', 09:14:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:53 INFO - '_': '/tools/buildbot/bin/python'} 09:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:53 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)) 09:14:53 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)) 09:14:53 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)) 09:14:53 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)) 09:14:53 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)) 09:14:53 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)) 09:14:53 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)) 09:14:53 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)) 09:14:53 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)) 09:14:53 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)) 09:14:53 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)) 09:14:53 INFO - Cleaning up... 09:14:53 INFO - Return code: 0 09:14:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:14:53 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')]} 09:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:53 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')]} 09:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1d4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', '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 09:14:53 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 09:14:53 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 09:14:53 INFO - Using env: {'DISPLAY': ':0', 09:14:53 INFO - 'HOME': '/home/cltbld', 09:14:53 INFO - 'LANG': 'en_US.UTF-8', 09:14:53 INFO - 'LANGUAGE': 'en_US:en', 09:14:53 INFO - 'LOGNAME': 'cltbld', 09:14:53 INFO - 'MAIL': '/var/mail/cltbld', 09:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:53 INFO - 'MOZ_NO_REMOTE': '1', 09:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:53 INFO - 'NO_EM_RESTART': '1', 09:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:53 INFO - 'PWD': '/builds/slave/test', 09:14:53 INFO - 'SHELL': '/bin/bash', 09:14:53 INFO - 'SHLVL': '1', 09:14:53 INFO - 'TERM': 'linux', 09:14:53 INFO - 'TMOUT': '86400', 09:14:53 INFO - 'USER': 'cltbld', 09:14:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:53 INFO - '_': '/tools/buildbot/bin/python'} 09:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:14:53 INFO - Cleaning up... 09:14:53 INFO - Return code: 0 09:14:53 INFO - Running post-action listener: _resource_record_post_action 09:14:53 INFO - Running post-action listener: _start_resource_monitoring 09:14:53 INFO - Starting resource monitoring. 09:14:53 INFO - [mozharness: 2017-05-19 16:14:53.924402Z] Finished create-virtualenv step (success) 09:14:53 INFO - [mozharness: 2017-05-19 16:14:53.924907Z] Running install step. 09:14:53 INFO - Running pre-action listener: _resource_record_pre_action 09:14:53 INFO - Running main action method: install 09:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:54 INFO - Reading from file tmpfile_stdout 09:14:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:14:54 INFO - Reading from file tmpfile_stdout 09:14:54 INFO - Output received: 09:14:54 INFO - Usage: mozinstall [options] installer 09:14:54 INFO - Options: 09:14:54 INFO - -h, --help show this help message and exit 09:14:54 INFO - -d DEST, --destination=DEST 09:14:54 INFO - Directory to install application into. [default: 09:14:54 INFO - "/builds/slave/test"] 09:14:54 INFO - --app=APP Application being installed. [default: firefox] 09:14:54 INFO - mkdir: /builds/slave/test/build/application 09:14:54 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'] 09:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:15:12 INFO - Reading from file tmpfile_stdout 09:15:12 INFO - Output received: 09:15:12 INFO - /builds/slave/test/build/application/firefox/firefox 09:15:12 INFO - Running post-action listener: _resource_record_post_action 09:15:12 INFO - [mozharness: 2017-05-19 16:15:12.148082Z] Finished install step (success) 09:15:12 INFO - [mozharness: 2017-05-19 16:15:12.148369Z] Running run-tests step. 09:15:12 INFO - Running pre-action listener: _resource_record_pre_action 09:15:12 INFO - Running main action method: run_tests 09:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:15:12 INFO - Python 2.7.3 09:15:12 INFO - Return code: 0 09:15:12 INFO - grabbing minidump binary from tooltool 09:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:12 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 0x20bb7a0>, '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 0x20bc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:15:12 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 09:15:12 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 09:15:12 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 09:15:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:15:12 INFO - Return code: 0 09:15:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:15:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:15:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:15:12 INFO - ENV: RUST_BACKTRACE is now 1 09:15:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:15:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:15:12 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/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 09:15:12 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/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 09:15:12 INFO - Using env: {'DISPLAY': ':0', 09:15:12 INFO - 'HOME': '/home/cltbld', 09:15:12 INFO - 'LANG': 'en_US.UTF-8', 09:15:12 INFO - 'LANGUAGE': 'en_US:en', 09:15:12 INFO - 'LOGNAME': 'cltbld', 09:15:12 INFO - 'MAIL': '/var/mail/cltbld', 09:15:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:15:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:12 INFO - 'MOZ_NO_REMOTE': '1', 09:15:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:12 INFO - 'NO_EM_RESTART': '1', 09:15:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:12 INFO - 'PWD': '/builds/slave/test', 09:15:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:15:12 INFO - 'RUST_BACKTRACE': '1', 09:15:12 INFO - 'SHELL': '/bin/bash', 09:15:12 INFO - 'SHLVL': '1', 09:15:12 INFO - 'TERM': 'linux', 09:15:12 INFO - 'TMOUT': '86400', 09:15:12 INFO - 'USER': 'cltbld', 09:15:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443', 09:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:12 INFO - '_': '/tools/buildbot/bin/python'} 09:15:12 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/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 09:15:12 INFO - mozversion application_buildid: 20170519153622 09:15:12 INFO - mozversion application_changeset: 1ea1b40c2679da341d50d27226c61033bac06711 09:15:12 INFO - mozversion application_display_name: Nightly 09:15:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:15:12 INFO - mozversion application_name: Firefox 09:15:12 INFO - mozversion application_remotingname: firefox 09:15:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:15:12 INFO - mozversion application_vendor: Mozilla 09:15:12 INFO - mozversion application_version: 55.0a1 09:15:12 INFO - mozversion platform_buildid: 20170519153622 09:15:12 INFO - mozversion platform_changeset: 1ea1b40c2679da341d50d27226c61033bac06711 09:15:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:15:12 INFO - mozversion platform_version: 55.0a1 09:15:12 INFO - using testdate: 1495210512 09:15:12 INFO - actual date: 1495210512 09:15:12 INFO - starting webserver on 'localhost:43928' 09:15:12 INFO - SUITE-START | Running 2 tests 09:15:12 INFO - TEST-START | dromaeo_css 09:15:12 INFO - operating with platform_type : linux_ 09:15:12 INFO - Initialising browser for dromaeo_css test... 09:15:12 INFO - TEST-INFO | started process 13149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHz9giR/profile http://localhost:43928/getInfo.html) 09:15:12 INFO - PID 13149 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:15:16 INFO - PID 13149 | __metrics Screen width/height:1600/1200 09:15:16 INFO - PID 13149 | colorDepth:24 09:15:16 INFO - PID 13149 | Browser inner width/height: 1024/695 09:15:16 INFO - PID 13149 | __metrics 09:15:18 INFO - TEST-INFO | 13149: exit 0 09:15:18 INFO - Browser initialized. 09:15:18 INFO - Running cycle 1/1 for dromaeo_css test... 09:15:18 INFO - TEST-INFO | started process 13328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHz9giR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:30 INFO - PID 13328 | RSS: Main: 169070592 09:15:30 INFO - PID 13328 | 09:18:35 INFO - PID 13328 | Cycle 1(1): loaded http://localhost:43928/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43928/tests/dromaeo/cssquery-ext.html) 09:18:36 INFO - PID 13328 | RSS: Main: 175443968 09:18:36 INFO - PID 13328 | 09:21:38 INFO - PID 13328 | Cycle 1(1): loaded http://localhost:43928/tests/dromaeo/cssquery-ext.html (next: http://localhost:43928/tests/dromaeo/cssquery-jquery.html) 09:21:39 INFO - PID 13328 | RSS: Main: 176201728 09:21:39 INFO - PID 13328 | 09:24:41 INFO - PID 13328 | Cycle 1(1): loaded http://localhost:43928/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43928/tests/dromaeo/cssquery-mootools.html) 09:24:41 INFO - PID 13328 | RSS: Main: 176168960 09:24:41 INFO - PID 13328 | 09:27:43 INFO - PID 13328 | Cycle 1(1): loaded http://localhost:43928/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43928/tests/dromaeo/cssquery-prototype.html) 09:27:44 INFO - PID 13328 | RSS: Main: 176168960 09:27:44 INFO - PID 13328 | 09:30:47 INFO - PID 13328 | Cycle 1(1): loaded http://localhost:43928/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43928/tests/dromaeo/cssquery-yui.html) 09:30:48 INFO - PID 13328 | RSS: Main: 174301184 09:30:48 INFO - PID 13328 | 09:33:49 INFO - PID 13328 | Cycle 1(1): loaded http://localhost:43928/tests/dromaeo/cssquery-yui.html (next: http://localhost:43928/tests/dromaeo/cssquery-dojo.html) 09:33:50 INFO - PID 13328 | RSS: Main: 181927936 09:33:50 INFO - PID 13328 | 09:33:50 INFO - PID 13328 | __start_tp_report 09:33:50 INFO - PID 13328 | _x_x_mozilla_page_load 09:33:50 INFO - PID 13328 | _x_x_mozilla_page_load_details 09:33:50 INFO - PID 13328 | |i|pagename|runs| 09:33:50 INFO - PID 13328 | |0;dojo.html;2678.3170291575643;2681.7452342027505;2687.529682305596;2698.7031426543076;2703.21606734047;5175.378954525453;5178.741062946857;5191.610629202811;5203.375594928609;5254.211868219769;5192.480751924805;5299.788008479666;5302.390225124112;5311.176767601028;5318.282031925699;4418.7127836690515;4630.467496237925;4653.115907977482;4657.928676404429;4716.787744551486;4737.194676904917;4773.331733557287;4785.258284965836;4789.640776941726;4810.302506136608;4670.042641258534;4715.1748444022505;4716.985848042687;4733.313669517935;4776.761161941907;4641.721496710208;4665.603423708989;4680.57874791267;4699.365585645963;4714.387129673155;4635.768211589407;4647.976760116211;4661.836835710734;4673.439187297512;4710.128626204163;5218.895622087537;5242.951409718034;5250.133727934886;5275.393329767049;5304.549113325372;5635.971820140914;5668.886622267572;5694.629849059798;5700.802831405368;5725.227094342294;5728.484436400744;5731.197632331477;5733.111367738007;5741.25363702716;5751;5319.0957537218765;5322.2282768998275;5328.92006619901;5330.493603107776;5369.033573956647;5724.398938111522;5787.189793428924;5788.160716696056;5863.091220860773;5869.6771677558145;5582.804601838916;5616.85957851057;5620.747066382022;5621.831345059655;5645.322561292671;5541.944580554143;5608.1587761835235;5608.9439105609235;5666.065099258576;5675.3757086720425;5564.582656300794;5647.830565083054;5662.915056274159;5682;5706.9714651426475;5502.5597952163735;5581.274434323594;5590.776368945197;5645.633033852787;5652.180433837153;4643.721376717408;4678.929816052762;4685.672002959828;4696.319033740088;4733.479317275097;4028.133951200506;4038.374052021941;4040.8181631826637;4067.8372865085066;4070.7964601769795;4727.338172655831;4728.361671174416;4750.548697873696;4777.713337199779;4792.0895029944195;5687.317521897398;5704.372519022904;5726.1410788381245;5767.942320576824;5774.595778295479;4787.760611969387;4797.304390863305;4799.6400269979895;4808.61531077513;4842.539958703917;4992.775325110306;5011.398632164163;5059.848204553796;5059.8988020239385;5066.290719299374;5211.791528338824;5244.711540865136;5280.102382595045;5297.841064768063;5298.231756395378;5655.519280861008;5683.829485115453;5702.05916023868;5712.400197979152;5722.341930678025;5259.47405259471;5273.525382715574;5275.419703832652;5278.181881808326;5332.30680011596;5351.919721204263;5473.863153421196;5525.889482210253;5584.385717570983;5606.299212598426;5733.4266573344;5742.569307301886;5742.856428589152;5775.306963164448;5796.82609521715;5372.113601255749;5428.240046393429;5460.153676180198;5528.91706624409;5539.473749993744;5451.255598208535;5506.366767821592;5552.69460179694;5600.803971860965;5601.187827765033;5377.166539186433;5411.567074633941;5454.754536045808;5460.31746031746;5473.589480789036;5381.19282107687;5516.3380394352935;5528.861778455571;5542.722863856871;5543.750531226024;5389.595780316414;5401.540869026019;5412.702301373305;5428.375736790162;5429.294191755047 09:33:50 INFO - PID 13328 | |1;ext.html;702.2941943346939;739.4564994728875;767.9692812287509;1016.3292227130091;1040.0743338428795;31590.368192636135;33051;33317;33352.166195845115;33360.33279334412;35490.2901941961;35834.64165358346;35916;35954.8202258989;35955.82022089886;6388.073729309247;6449.35506449356;6935.30646935305;7060;7061.89407158893;6722.596644201339;6774.051632771416;6799.626020568867;6808.080909077261;6813.693383797716;6806.4554835613035;6825.249222585511;6863.897041544381;6863.897041544381;6887.48343874209;6819.795406137849;6821.420179284717;6834.9658251708925;6835.521513494057;6838.281980392062;6898.862022759567;6910.723571057151;6924.6537673116645;6932.965335173342;6947.131608548932;31109.688903110906;31421;31457.685423145933;31598.368032639217;31621.683783162105;3094.5048792193143;3132.3578666373337;3136.81179129253;3141.984290078558;3145.496720524728;24223.515529689485;24235.7576424237;24281.814636682608;24372.390690232707;24473.755262447503;3116.236522052089;3202.2154572129743;3202.5036119401298;3209.5346174804754;3242.221866751986;140408;140438.29780851133;144309;149352;149791;38628;38713;38755.22489550193;38787.22425551473;38801;40481.797591011855;40497.79751101285;40530;40621.18757624831;40750.18499629991;12516.561920332744;12596.81104783429;12604.432800523999;12674.366281686063;12695.301758403191;10165.186785057178;10263.74340641475;10264.230182736324;10268.948655256825;10300.22748293881;12475.5009799607;12563.371831408393;12657.303848288433;12659.177153485178;12823.743525129445;5317.41508434072;5335.359756829205;5379.811706590251;5437.184422336682;5524.116141417434;897.6229983406985;930.3627015494408;930.706318217678;933.3979583168818;960.9471479068718;20828.1668733249;21131;21222.25722099719;21228.150873964867;21383.35849924505;1003.1222680154865;1004.7689031522791;1009.3489699144011;1033.9172866170688;1035.7980193862275;11179.429290684104;11427.314361138358;11502.769944601228;11540.653780386434;11555.133364997659;168998.15500922417;171138.14430927765;171360;171378;171737;40293.79853100774;40831.387529187086;40835.591644083775;40839.7958010214;40982.38526422106;1215.2647648172906;1264.3172686749053;1269.2447993443886;1275.1329096214663;1276.208750574631;19840.90079549593;19882.304119355755;20361.49096272605;21330.253441129487;21384.786152138902;29737.851310743306;29774.851125744233;29842.403151936407;29873;29927.401451970403;144275.27862360622;144732;144886;145216;145451;29127;29282.267943301587;29659.555106672986;30722.692773071984;30731.38537229198;36555.45166822553;36759.63240367562;36779.63220367762;37019.25961480809;37180.814095929345;26215.868920655274;27323.453530928873;27754.306142346602;27925.301867453476;28183.43633127367;27684.44631107407;28057.438851222454;28108.578371324038;28957.710422895503;29238.02953497953;31071.378572428875;31093.378132437676;31113.84443077861;31117.377652447278;31166.22084447907;26892.327691807077;26900.865495672395;27814.44371112526;28085.57871631886;28347.716522834507;20239;23041.539169216856;23045.65431518562;23062.654060189445;23140.190093346653 09:33:50 INFO - PID 13328 | |2;jquery.html;413.4439179303835;418.36408658838565;422.57953336430245;437.61271274921694;447.2039769210806;17181.91409042956;18050.90974545127;18097.1856266468;18628.53428664284;19461.124249408775;17557.736633950502;17754.64490710185;17762.555936101573;17784.11079446026;17977;5423.484768946953;5480.890382192374;5614.29821272341;5712.314522257314;5735.770569177228;5639.661620302774;5654.406287339832;5676.205331253628;5685.090385538315;5689.175069614904;5542;5617.775288988436;5640.407757185498;5653.886922261552;5655.462731040565;5559.526725417768;5625.887482250352;5629.549636029149;5674.3190817101795;5698.230738850264;5060.165072762989;5126.128558145124;5130.1791713326065;5130.589552835801;5130.871728206787;21897.890510547506;21973.890130549244;22287.777122228734;22696.659550106597;22827.543449130924;1628.4137710424238;1642.2773979449123;1653.6609994951007;1655.5198992292221;1656.403694669918;14585.19781412022;14778.778318325234;14987.550373488813;15123.924380378137;15200;2032.1363420546356;2064.370367038053;2131.2540610786255;2155.9461013474634;2159.8704077755383;83638;88491.11508884894;88621;89205;92804.07195928022;10750.569977200981;10856.240063195659;11023.669289921316;11116.444177791078;11188.216824822184;14803.629909252355;14837.777433338508;14846.436855154685;14855.48005819791;14918.701625967637;7299.175206198451;7405.481616286808;7477.4391920605085;7640.159582445926;7671.961640191875;6761.0872532208505;6791.408823845672;6984.965075174693;7005.684744186524;7030.472714546429;6888.483363747739;6923.584584924921;7067.328603782633;7072.5402848814665;7079.575225486487;2003.24878170686;2017.1628774058895;2055.660815965349;2074.481379655086;2153.935381938544;863.4560227056913;875.5578432891476;879.1823604048296;885.3979294079959;906.1074841281333;17180.570485737957;17211.139443027798;17466.737998930028;17878.035897589158;17901.283948641907;877.1842186766369;886.9689560865339;887.5251740318898;893.6023469556116;893.8525143351404;9294.953525232331;9398.248140148771;9506.667266645773;9773.21814254858;10008.49957502122;323841;328328;328958;330363;331708;73078.63460682663;73773;74006.62996684982;74710.62644686742;75253.24746752573;1020.153272783573;1028.5114570578914;1062.1874266186373;1071.3357718214756;1074.403705943209;14335.354909029327;14746.483873064391;14921.477748278758;14925.776113358526;15434.691306173589;37271.62728372682;37519.81240093782;38498.80750596229;39270.4109438353;39535.40696889492;44514.3322850164;44881.10237795291;45093;45183;46427.30359044685;8438.620262088098;8536.914630853613;8547.74356769298;8555.914440855511;9046.321525885453;13388.531401400904;13600.251986140462;13616.86383136156;13753.656158596115;13854.515091971733;11032.172587055842;11219.887801121884;11571.537138514364;11645.59240426581;11705.473253703434;10465.581376744845;10575.947120264349;10598.89401105979;10686.786264274826;10923.235373523778;11394.817453428017;11409.201355905006;11551.653450396501;11699.2980421175;11794.52821887115;8163.755087347389;8218.342532597258;8237.95881020615;8353.24820766134;8578.099299573705;10856.13150947938;10905.34567925927;10922.563097476012;10962.616308429167;11155.665330040112 09:33:50 INFO - PID 13328 | |3;mootools.html;1260.8423947006625;1322.2859655785876;1326.8009798530225;1328.1566205459537;1342.2550484481114;9965.402075875452;10155.949220253908;10481.318714283576;10483.790324193511;10527.105196058325;10419.218558608116;10559.26085174038;10592.41741704206;10647.467626618658;10649.20130990175;2176.912923483059;2196.187410658059;2201.2720014788392;2209.767974362685;2213.1589995801573;2137.3908436095717;2182.443476913385;2193.605151072806;2200.2409168836725;2207.426069222006;2213.5683541709373;2225.7662945390744;2253.346529506441;2268.1381075191402;2270.625346817773;2142.335875878475;2160.5138843760187;2161.7622061573215;2187.136081247906;2192.3094225319055;1972.063269946778;2106.947326316839;2197.2968650031994;2197.5385169114506;2209.569134018867;9903.405795652285;10110.646127385506;10164.695059148164;10208.846867296996;10209.591616335338;5590.357108932484;5774.682392468412;5793.5654825887805;5797.884042319172;5808.564357673192;3059.204606802225;3178.475551533994;3219.5814544109116;3329.866805327784;3432.1934345429054;1061.787642471509;1074.3285446595878;1124.2692250037542;1172.1033409441784;1180.3390101543164;15241.390344386211;15498.225088745517;15560;15577.766333505006;15586.454474093352;4921.434035086011;4984.3021976923255;5058.418281897629;5066.341375621219;5069.949300507022;12697.238165709901;12723.936380318224;12726.872731272753;12735.681607959876;12756.55352062692;5709.885802283931;5729.7708091676695;5739.913901291484;5740.339860915965;5747.281589801275;4883.291922671193;5002.274670172877;5111.897762044812;5136.43499215086;5272.077386457355;4230.830766769356;4331.155424692155;4338.501072376717;4381.627561657295;4417.867463976086;1370.3216907630785;1391.8634895435457;1397.1547213935626;1413.2651021468778;1418.5886093032905;701.7543859649082;723.0636325957897;724.2178447276929;725.1986554856912;742.6732237815344;5647.29408823897;5728.77084916607;5744.4829965303325;5827.067669172912;5830.096335068071;547.2038184441628;564.6950646650845;567.222904620664;570.3526497425452;570.6747154122111;3415.7438192135687;3418.8974330770116;3803.657670809585;3819.579846216914;3932.9774258692373;13084.738305234032;13469.932650336686;13678.794818077737;13764.793528097087;13774.380152893144;13119.540816071392;13338.799918001238;13469.797953030713;13631.04582679203;13726.588202353945;6872.209695884937;7240.9862619233345;7320.267973202744;7377.704891804267;7407.740729074564;6195.101710252078;6501.2523559791225;6502.772402965874;6611.272759996493;6640.568363056386;11681.415929203677;12150.392480376122;12209.816852747039;12422.813657794959;12453.813192801934;11989.580364687194;12051.578194763491;12251.203671761306;12357.382130893599;12441.191322564004;8207.302379297827;8265.917340826514;8387.203215694499;8395.538245396561;8406.411551191359;9542.236621070158;9805.607775688892;9809.803803924024;9820.312578119463;9828.164606008284;7904.774759912223;8138.064122625974;8157.551334676413;8294.509729907144;8455.661773529237;8209.096999330188;8231.876521852057;8248.917510825055;8338.207870252316;8353.916460835557;7064;7179.676914538963;7187.8562428752175;7207.71169153228;7213.062301900719;5316.973415132899;5338.599605029561;5425.972870135624;5428.864278393072;5544.3346798384455;5202.2196670499725;5227;5288.894222115613;5330.653507521999;5466.3986961435 09:33:50 INFO - PID 13328 | |4;prototype.html;375.9755615884967;397.6202726396291;400.0937875711512;400.5313782874037;410.42335518596366;5401.351837779472;5508.917366239504;5524.281843360358;5526;5542.334919809624;5373.973130134344;5431.755570999305;5450.809221677242;5451.236826844235;5464.972675136619;4324.589164029412;4333.1117120990275;4352.825886964533;4356.346548017791;4359;4245.724027938174;4318.4170137031415;4338.587834155766;4346.391505189276;4351.977285337943;4311.91376172478;4312.762798046122;4313.374560688699;4314.842578710644;4337.522872484024;4302.440682711243;4320.0711846952745;4329.480462344523;4337.501187363462;4349.412829268072;3865.8260378283044;3939.231849789292;3968.7023473239624;3977.363621820524;4008.67930565557;5352.591333899761;5360.16917377807;5360.839174824722;5364.1149210380245;5384.138537833967;5156.948430515685;5166.302549155854;5180.067587834188;5183;5192.792288308463;5668.291463567054;5733.254676892019;5786.855328616776;5838.883222335572;5848.941510584925;4396.670249731283;4417.116576684676;4419.845305414295;4441.333799930037;4449.621782148522;5825.330087040003;6076.696165191723;6094.481969032638;6096.725647345836;6144.201253837017;4283.635890949242;4327.675424343124;4332.480102387671;4335.934960975588;4352.412424322676;4393.967417656848;4397.142557201379;4406.162829062468;4409.49290831552;4425.424694789721;4943.530364615356;4945.357103576512;4956.207006878954;5091.7016160879475;5142;5759.164921086419;5775;5777.7977770777825;5799.304083509922;5801.3328467225965;1605.2776250687236;1626.5852207686964;1631.4371541818055;1633.3466613354753;1637.6560922206231;1177.6231605886035;1184.2894263442038;1185.3895243949373;1193.26614132308;1209.2744353388073;4929.901401971941;4954.529319714621;4957.925631115536;4970.527799859007;4976.42771081323;5938.61399009063;5942.405759424109;5962.642241465526;5971.611845230046;5977.671228082497;4837.637177211724;4924.630652701062;4926.679765815211;4948;4968.22992436173;3116.626004879429;3124.4063627910623;3139.152428844199;3144.7326977206735;3151.842407879597;5288.471152884757;5473.507384335429;5489.533389661923;5498.1752737089755;5513.476219759116;6120.449159575571;6140.8771824563255;6151.815445536641;6153.753849845956;6154.292256390483;5495.945040549624;5512.9877594676855;5515.200295957064;5517.503424691717;5528.783667593123;5816.534677225727;5906.497947674324;5909.202257695328;5952.5833191676165;5959.821205363846;5668.801591944427;5818.301803783573;5825.271841019872;5855.853603659943;5895.351511333835;5465.863353416196;5478.151361292185;5508.44915508446;5517.337919449692;5517.779288828402;4072.7963601819197;4103.815328310174;4107.630313271819;4108.876733697994;4112.033672087117;5900.881982360414;5974.2830860297045;5990.670513121646;6010.068439391901;6026.427489388501;5786;5790.623609465371;5811.024251754424;5822.097574875901;5823.475887170175;5683.765594632026;5761.942380576141;5770.740316685676;5785.913211301918;5804.622699524517;5688.943110568841;5689.8862022758485;5698.800541981011;5705.771769129188;5735.9139612905;5813.79651712188;5833.4749872511675;5843.8539036522725;5858.853528661647;5874.265716785402;5419.3225846769155;5602.299712535933;5608;5618.353889302783;5657.575681823962 09:33:50 INFO - PID 13328 | |5;yui.html;740.9333160015598;756.5498528375617;765.8736308509096;773.6750564762799;783.1189911349734;11887.583934562292;12425.875741242586;13220.537281195147;14271.500497482602;14282.428702851887;13696.383662735176;14087.436502539886;14145.71708565828;14192.787108193384;14290.214038227894;892.2415946445534;916.6791622931987;920.4247345409119;921.806420651664;924.935254532183;906.8322360363354;912.9452232866049;914.8261830252264;916.3906002508324;919.1865199298602;961.5336561767538;962.4610218277752;963.9228861691048;964.0215181590692;967.6709918627665;955.7085089047838;956.0964888180672;957.042957042957;957.6791774755466;961.0821665309647;699.2168770976539;705.562551218248;706.6608028146519;710.0201721624177;710.6766421278357;13774.311284435838;13803.585892423243;13901.930490347584;14488.927555362261;14735.042222255519;15647;15791.21043947798;15798.60503487422;15950.521484355488;16081.919590401973;12754.298513581842;12780;12835.935820320932;12838.101332906701;12863.935680321538;2947.852607369623;2958.1421387797513;2968.807027543203;2976.1666733314705;2979.06159559738;61159.38840611582;63762;64703;65050;65349.67325163391;12624.747505049847;12897.097203195686;12965.546205882938;12978.935105324601;12979.610611681665;22849.771502284766;22897.656535151986;22927.312180634275;23236;23434.296971090895;6505.21937367519;6520.902186467207;6693.230278518033;6704.497162712719;6726.024726414643;3069.493533566981;3131.5146152346424;3139;3162.652108268089;3166.9366612668077;3265.1184180271193;3328.084776686382;3341.064501939461;3348.196432856097;3439.8968030959113;693.1820451866745;697.3619138488327;700.992990070103;702.3959394920364;703.0543918429704;596.5347029317139;618.8638499530186;619.4672581579838;628.9622622642564;634.0172732264971;9316.48759318244;9986.30095893295;10045.849312260321;10248;10644.733881652866;525.75552368149;527.5357685237044;529.6080900133874;530.3423754544337;538.8625900395452;4448.488423831301;4629.328747331618;4646.697964632288;4697.859064228079;4777.4505931818285;62765.68617156885;63110.68444657747;63713.681431592544;63878.68060659667;64743.35256647468;55871.44128558744;56069.71965140148;56662.433375666544;56814.71592642093;57311.426885731446;49741;51634.22548661773;52023.21965170526;52581.737091315066;53257.2011419829;8819.559022048743;9080.727578172666;9315.72052838416;9554.713358599252;9565.808683826424;27133.321666958484;27372.315692107855;27457;27551.31121721973;27990.160295191177;32158.35683286368;32612.34775304528;32663.346733065682;32684.346313074082;33317.83341083279;11273.830892536454;13460.461581536629;13882.652933676334;13899.16605003703;14096.154230745778;15009.77485337699;15753.606159846095;15851.603709907344;16336.264868080727;16941.407050753165;14522.419103235752;14713.705725885637;14944.476943306932;15180.544583662508;15307.54077377636;14572.198529081003;14893.404263829325;15225.086494810346;15528.611784705472;15702.21488925572;14850.925745371636;14921.179335136672;15475.148866812433;15783.842161578697;16064.67870642604;10040.497975101362;10719.839202411815;10848.132149427869;10939.890601094206;10986.560537578407;11239.157063220127;11978.64064078079;12015.219010764273;12188.756224875275;12264.38678066111 09:33:50 INFO - PID 13328 | __end_tp_report 09:33:50 INFO - PID 13328 | __start_cc_report 09:33:50 INFO - PID 13328 | _x_x_mozilla_cycle_collect,277 09:33:50 INFO - PID 13328 | __end_cc_report 09:33:50 INFO - PID 13328 | __startTimestamp1495211630197__endTimestamp 09:33:50 INFO - PID 13328 | 09:33:50 INFO - PID 13328 | ------- Summary: start ------- 09:33:50 INFO - PID 13328 | Number of tests: 6 09:33:50 INFO - PID 13328 | 09:33:50 INFO - PID 13328 | [#0] dojo.html Cycles:165 Average:5178.32 Median:5330.49 stddev:619.02 (11.6%) stddev-sans-first:589.03 09:33:50 INFO - PID 13328 | Values: 2678.3 2681.7 2687.5 2698.7 2703.2 5175.4 5178.7 5191.6 5203.4 5254.2 5192.5 5299.8 5302.4 5311.2 5318.3 4418.7 4630.5 4653.1 4657.9 4716.8 4737.2 4773.3 4785.3 4789.6 4810.3 4670.0 4715.2 4717.0 4733.3 4776.8 4641.7 4665.6 4680.6 4699.4 4714.4 4635.8 4648.0 4661.8 4673.4 4710.1 5218.9 5243.0 5250.1 5275.4 5304.5 5636.0 5668.9 5694.6 5700.8 5725.2 5728.5 5731.2 5733.1 5741.3 5751.0 5319.1 5322.2 5328.9 5330.5 5369.0 5724.4 5787.2 5788.2 5863.1 5869.7 5582.8 5616.9 5620.7 5621.8 5645.3 5541.9 5608.2 5608.9 5666.1 5675.4 5564.6 5647.8 5662.9 5682.0 5707.0 5502.6 5581.3 5590.8 5645.6 5652.2 4643.7 4678.9 4685.7 4696.3 4733.5 4028.1 4038.4 4040.8 4067.8 4070.8 4727.3 4728.4 4750.5 4777.7 4792.1 5687.3 5704.4 5726.1 5767.9 5774.6 4787.8 4797.3 4799.6 4808.6 4842.5 4992.8 5011.4 5059.8 5059.9 5066.3 5211.8 5244.7 5280.1 5297.8 5298.2 5655.5 5683.8 5702.1 5712.4 5722.3 5259.5 5273.5 5275.4 5278.2 5332.3 5351.9 5473.9 5525.9 5584.4 5606.3 5733.4 5742.6 5742.9 5775.3 5796.8 5372.1 5428.2 5460.2 5528.9 5539.5 5451.3 5506.4 5552.7 5600.8 5601.2 5377.2 5411.6 5454.8 5460.3 5473.6 5381.2 5516.3 5528.9 5542.7 5543.8 5389.6 5401.5 5412.7 5428.4 5429.3 09:33:50 INFO - PID 13328 | 09:33:50 INFO - PID 13328 | [#1] ext.html Cycles:180 Average:29933.70 Median:30727.04 stddev:39682.34 (129.1%) stddev-sans-first:39732.95 09:33:50 INFO - PID 13328 | Values: 702.3 739.5 768.0 1016.3 1040.1 31590.4 33051.0 33317.0 33352.2 33360.3 35490.3 35834.6 35916.0 35954.8 35955.8 6388.1 6449.4 6935.3 7060.0 7061.9 6722.6 6774.1 6799.6 6808.1 6813.7 6806.5 6825.2 6863.9 6863.9 6887.5 6819.8 6821.4 6835.0 6835.5 6838.3 6898.9 6910.7 6924.7 6933.0 6947.1 31109.7 31421.0 31457.7 31598.4 31621.7 3094.5 3132.4 3136.8 3142.0 3145.5 24223.5 24235.8 24281.8 24372.4 24473.8 3116.2 3202.2 3202.5 3209.5 3242.2 140408.0 140438.3 144309.0 149352.0 149791.0 38628.0 38713.0 38755.2 38787.2 38801.0 40481.8 40497.8 40530.0 40621.2 40750.2 12516.6 12596.8 12604.4 12674.4 12695.3 10165.2 10263.7 10264.2 10268.9 10300.2 12475.5 12563.4 12657.3 12659.2 12823.7 5317.4 5335.4 5379.8 5437.2 5524.1 897.6 930.4 930.7 933.4 960.9 20828.2 21131.0 21222.3 21228.2 21383.4 1003.1 1004.8 1009.3 1033.9 1035.8 11179.4 11427.3 11502.8 11540.7 11555.1 168998.2 171138.1 171360.0 171378.0 171737.0 40293.8 40831.4 40835.6 40839.8 40982.4 1215.3 1264.3 1269.2 1275.1 1276.2 19840.9 19882.3 20361.5 21330.3 21384.8 29737.9 29774.9 29842.4 29873.0 29927.4 144275.3 144732.0 144886.0 145216.0 145451.0 29127.0 29282.3 29659.6 30722.7 30731.4 36555.5 36759.6 36779.6 37019.3 37180.8 26215.9 27323.5 27754.3 27925.3 28183.4 27684.4 28057.4 28108.6 28957.7 29238.0 31071.4 31093.4 31113.8 31117.4 31166.2 26892.3 26900.9 27814.4 28085.6 28347.7 20239.0 23041.5 23045.7 23062.7 23140.2 09:33:50 INFO - PID 13328 | 09:33:50 INFO - PID 13328 | [#2] jquery.html Cycles:180 Average:23596.40 Median:184489.81 stddev:55007.09 (29.8%) stddev-sans-first:55133.86 09:33:50 INFO - PID 13328 | Values: 413.4 418.4 422.6 437.6 447.2 17181.9 18050.9 18097.2 18628.5 19461.1 17557.7 17754.6 17762.6 17784.1 17977.0 5423.5 5480.9 5614.3 5712.3 5735.8 5639.7 5654.4 5676.2 5685.1 5689.2 5542.0 5617.8 5640.4 5653.9 5655.5 5559.5 5625.9 5629.5 5674.3 5698.2 5060.2 5126.1 5130.2 5130.6 5130.9 21897.9 21973.9 22287.8 22696.7 22827.5 1628.4 1642.3 1653.7 1655.5 1656.4 14585.2 14778.8 14987.6 15123.9 15200.0 2032.1 2064.4 2131.3 2155.9 2159.9 83638.0 88491.1 88621.0 89205.0 92804.1 10750.6 10856.2 11023.7 11116.4 11188.2 14803.6 14837.8 14846.4 14855.5 14918.7 7299.2 7405.5 7477.4 7640.2 7672.0 6761.1 6791.4 6985.0 7005.7 7030.5 6888.5 6923.6 7067.3 7072.5 7079.6 2003.2 2017.2 2055.7 2074.5 2153.9 863.5 875.6 879.2 885.4 906.1 17180.6 17211.1 17466.7 17878.0 17901.3 877.2 887.0 887.5 893.6 893.9 9295.0 9398.2 9506.7 9773.2 10008.5 323841.0 328328.0 328958.0 330363.0 331708.0 73078.6 73773.0 74006.6 74710.6 75253.2 1020.2 1028.5 1062.2 1071.3 1074.4 14335.4 14746.5 14921.5 14925.8 15434.7 37271.6 37519.8 38498.8 39270.4 39535.4 44514.3 44881.1 45093.0 45183.0 46427.3 8438.6 8536.9 8547.7 8555.9 9046.3 13388.5 13600.3 13616.9 13753.7 13854.5 11032.2 11219.9 11571.5 11645.6 11705.5 10465.6 10575.9 10598.9 10686.8 10923.2 11394.8 11409.2 11551.7 11699.3 11794.5 8163.8 8218.3 8238.0 8353.2 8578.1 10856.1 10905.3 10922.6 10962.6 11155.7 09:33:50 INFO - PID 13328 | 09:33:50 INFO - PID 13328 | [#3] mootools.html Cycles:180 Average:6430.38 Median:3811.62 stddev:4173.99 (109.5%) stddev-sans-first:4167.62 09:33:50 INFO - PID 13328 | Values: 1260.8 1322.3 1326.8 1328.2 1342.3 9965.4 10155.9 10481.3 10483.8 10527.1 10419.2 10559.3 10592.4 10647.5 10649.2 2176.9 2196.2 2201.3 2209.8 2213.2 2137.4 2182.4 2193.6 2200.2 2207.4 2213.6 2225.8 2253.3 2268.1 2270.6 2142.3 2160.5 2161.8 2187.1 2192.3 1972.1 2106.9 2197.3 2197.5 2209.6 9903.4 10110.6 10164.7 10208.8 10209.6 5590.4 5774.7 5793.6 5797.9 5808.6 3059.2 3178.5 3219.6 3329.9 3432.2 1061.8 1074.3 1124.3 1172.1 1180.3 15241.4 15498.2 15560.0 15577.8 15586.5 4921.4 4984.3 5058.4 5066.3 5069.9 12697.2 12723.9 12726.9 12735.7 12756.6 5709.9 5729.8 5739.9 5740.3 5747.3 4883.3 5002.3 5111.9 5136.4 5272.1 4230.8 4331.2 4338.5 4381.6 4417.9 1370.3 1391.9 1397.2 1413.3 1418.6 701.8 723.1 724.2 725.2 742.7 5647.3 5728.8 5744.5 5827.1 5830.1 547.2 564.7 567.2 570.4 570.7 3415.7 3418.9 3803.7 3819.6 3933.0 13084.7 13469.9 13678.8 13764.8 13774.4 13119.5 13338.8 13469.8 13631.0 13726.6 6872.2 7241.0 7320.3 7377.7 7407.7 6195.1 6501.3 6502.8 6611.3 6640.6 11681.4 12150.4 12209.8 12422.8 12453.8 11989.6 12051.6 12251.2 12357.4 12441.2 8207.3 8265.9 8387.2 8395.5 8406.4 9542.2 9805.6 9809.8 9820.3 9828.2 7904.8 8138.1 8157.6 8294.5 8455.7 8209.1 8231.9 8248.9 8338.2 8353.9 7064.0 7179.7 7187.9 7207.7 7213.1 5317.0 5338.6 5426.0 5428.9 5544.3 5202.2 5227.0 5288.9 5330.7 5466.4 09:33:50 INFO - PID 13328 | 09:33:50 INFO - PID 13328 | [#4] prototype.html Cycles:180 Average:4828.15 Median:5379.06 stddev:1352.68 (25.1%) stddev-sans-first:1314.55 09:33:50 INFO - PID 13328 | Values: 376.0 397.6 400.1 400.5 410.4 5401.4 5508.9 5524.3 5526.0 5542.3 5374.0 5431.8 5450.8 5451.2 5465.0 4324.6 4333.1 4352.8 4356.3 4359.0 4245.7 4318.4 4338.6 4346.4 4352.0 4311.9 4312.8 4313.4 4314.8 4337.5 4302.4 4320.1 4329.5 4337.5 4349.4 3865.8 3939.2 3968.7 3977.4 4008.7 5352.6 5360.2 5360.8 5364.1 5384.1 5156.9 5166.3 5180.1 5183.0 5192.8 5668.3 5733.3 5786.9 5838.9 5848.9 4396.7 4417.1 4419.8 4441.3 4449.6 5825.3 6076.7 6094.5 6096.7 6144.2 4283.6 4327.7 4332.5 4335.9 4352.4 4394.0 4397.1 4406.2 4409.5 4425.4 4943.5 4945.4 4956.2 5091.7 5142.0 5759.2 5775.0 5777.8 5799.3 5801.3 1605.3 1626.6 1631.4 1633.3 1637.7 1177.6 1184.3 1185.4 1193.3 1209.3 4929.9 4954.5 4957.9 4970.5 4976.4 5938.6 5942.4 5962.6 5971.6 5977.7 4837.6 4924.6 4926.7 4948.0 4968.2 3116.6 3124.4 3139.2 3144.7 3151.8 5288.5 5473.5 5489.5 5498.2 5513.5 6120.4 6140.9 6151.8 6153.8 6154.3 5495.9 5513.0 5515.2 5517.5 5528.8 5816.5 5906.5 5909.2 5952.6 5959.8 5668.8 5818.3 5825.3 5855.9 5895.4 5465.9 5478.2 5508.4 5517.3 5517.8 4072.8 4103.8 4107.6 4108.9 4112.0 5900.9 5974.3 5990.7 6010.1 6026.4 5786.0 5790.6 5811.0 5822.1 5823.5 5683.8 5761.9 5770.7 5785.9 5804.6 5688.9 5689.9 5698.8 5705.8 5735.9 5813.8 5833.5 5843.9 5858.9 5874.3 5419.3 5602.3 5608.0 5618.4 5657.6 09:33:50 INFO - PID 13328 | 09:33:50 INFO - PID 13328 | [#5] yui.html Cycles:180 Average:15191.08 Median:17964.23 stddev:17460.31 (97.2%) stddev-sans-first:17475.57 09:33:50 INFO - PID 13328 | Values: 740.9 756.5 765.9 773.7 783.1 11887.6 12425.9 13220.5 14271.5 14282.4 13696.4 14087.4 14145.7 14192.8 14290.2 892.2 916.7 920.4 921.8 924.9 906.8 912.9 914.8 916.4 919.2 961.5 962.5 963.9 964.0 967.7 955.7 956.1 957.0 957.7 961.1 699.2 705.6 706.7 710.0 710.7 13774.3 13803.6 13901.9 14488.9 14735.0 15647.0 15791.2 15798.6 15950.5 16081.9 12754.3 12780.0 12835.9 12838.1 12863.9 2947.9 2958.1 2968.8 2976.2 2979.1 61159.4 63762.0 64703.0 65050.0 65349.7 12624.7 12897.1 12965.5 12978.9 12979.6 22849.8 22897.7 22927.3 23236.0 23434.3 6505.2 6520.9 6693.2 6704.5 6726.0 3069.5 3131.5 3139.0 3162.7 3166.9 3265.1 3328.1 3341.1 3348.2 3439.9 693.2 697.4 701.0 702.4 703.1 596.5 618.9 619.5 629.0 634.0 9316.5 9986.3 10045.8 10248.0 10644.7 525.8 527.5 529.6 530.3 538.9 4448.5 4629.3 4646.7 4697.9 4777.5 62765.7 63110.7 63713.7 63878.7 64743.4 55871.4 56069.7 56662.4 56814.7 57311.4 49741.0 51634.2 52023.2 52581.7 53257.2 8819.6 9080.7 9315.7 9554.7 9565.8 27133.3 27372.3 27457.0 27551.3 27990.2 32158.4 32612.3 32663.3 32684.3 33317.8 11273.8 13460.5 13882.7 13899.2 14096.2 15009.8 15753.6 15851.6 16336.3 16941.4 14522.4 14713.7 14944.5 15180.5 15307.5 14572.2 14893.4 15225.1 15528.6 15702.2 14850.9 14921.2 15475.1 15783.8 16064.7 10040.5 10719.8 10848.1 10939.9 10986.6 11239.2 11978.6 12015.2 12188.8 12264.4 09:33:50 INFO - PID 13328 | -------- Summary: end -------- 09:33:50 INFO - PID 13328 | 09:33:51 INFO - TEST-INFO | 13328: exit 0 09:33:51 INFO - TEST-OK | dromaeo_css | took 1118609ms 09:33:51 INFO - TEST-START | kraken 09:33:51 INFO - operating with platform_type : linux_ 09:33:51 INFO - Initialising browser for kraken test... 09:33:51 INFO - TEST-INFO | started process 13747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAeRIsa/profile http://localhost:43928/getInfo.html) 09:33:51 INFO - PID 13747 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:33:55 INFO - PID 13747 | __metrics Screen width/height:1600/1200 09:33:55 INFO - PID 13747 | colorDepth:24 09:33:55 INFO - PID 13747 | Browser inner width/height: 1024/695 09:33:55 INFO - PID 13747 | __metrics 09:33:57 INFO - TEST-INFO | 13747: exit 0 09:33:57 INFO - Browser initialized. 09:33:57 INFO - Running cycle 1/1 for kraken test... 09:33:57 INFO - TEST-INFO | started process 13925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAeRIsa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:08 INFO - PID 13925 | RSS: Main: 168693760 09:34:08 INFO - PID 13925 | 09:34:11 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43928/tests/kraken/driver.html?testName=audio-beat-detection) 09:34:12 INFO - PID 13925 | RSS: Main: 172195840 09:34:12 INFO - PID 13925 | 09:34:15 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43928/tests/kraken/driver.html?testName=audio-dft) 09:34:15 INFO - PID 13925 | RSS: Main: 172306432 09:34:15 INFO - PID 13925 | 09:34:18 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43928/tests/kraken/driver.html?testName=audio-fft) 09:34:19 INFO - PID 13925 | RSS: Main: 168173568 09:34:19 INFO - PID 13925 | 09:34:21 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43928/tests/kraken/driver.html?testName=audio-oscillator) 09:34:22 INFO - PID 13925 | RSS: Main: 168906752 09:34:22 INFO - PID 13925 | 09:34:24 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43928/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:34:24 INFO - PID 13925 | RSS: Main: 169672704 09:34:24 INFO - PID 13925 | 09:34:28 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43928/tests/kraken/driver.html?testName=imaging-darkroom) 09:34:28 INFO - PID 13925 | RSS: Main: 174063616 09:34:28 INFO - PID 13925 | 09:34:32 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43928/tests/kraken/driver.html?testName=imaging-desaturate) 09:34:32 INFO - PID 13925 | RSS: Main: 170897408 09:34:32 INFO - PID 13925 | 09:34:35 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43928/tests/kraken/driver.html?testName=json-parse-financial) 09:34:36 INFO - PID 13925 | RSS: Main: 171814912 09:34:36 INFO - PID 13925 | 09:34:38 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43928/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:34:38 INFO - PID 13925 | RSS: Main: 172658688 09:34:38 INFO - PID 13925 | 09:34:40 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43928/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:34:41 INFO - PID 13925 | RSS: Main: 172089344 09:34:41 INFO - PID 13925 | 09:34:43 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43928/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:43 INFO - PID 13925 | RSS: Main: 172253184 09:34:43 INFO - PID 13925 | 09:34:46 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:47 INFO - PID 13925 | RSS: Main: 172269568 09:34:47 INFO - PID 13925 | 09:34:50 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:34:51 INFO - PID 13925 | RSS: Main: 172036096 09:34:51 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | Cycle 1(1): loaded http://localhost:43928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43928/tests/kraken/driver.html?testName=ai-astar) 09:34:53 INFO - PID 13925 | RSS: Main: 174006272 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | __start_tp_report 09:34:53 INFO - PID 13925 | _x_x_mozilla_page_load 09:34:53 INFO - PID 13925 | _x_x_mozilla_page_load_details 09:34:53 INFO - PID 13925 | |i|pagename|runs| 09:34:53 INFO - PID 13925 | |0;ai-astar;105;114;113;111;111;112;112;114;111;114 09:34:53 INFO - PID 13925 | |1;audio-beat-detection;150;127;125;162;125;124;124;126;157;128 09:34:53 INFO - PID 13925 | |2;audio-dft;164;165;164;164;164;167;169;168;163;168 09:34:53 INFO - PID 13925 | |3;audio-fft;76;78;75;106;76;75;78;75;93;76 09:34:53 INFO - PID 13925 | |4;audio-oscillator;84;83;111;83;84;84;100;84;83;108 09:34:53 INFO - PID 13925 | |5;imaging-gaussian-blur;116;115;115;114;114;117;114;114;117;116 09:34:53 INFO - PID 13925 | |6;imaging-darkroom;151;150;152;151;151;151;153;150;152;151 09:34:53 INFO - PID 13925 | |7;imaging-desaturate;96;95;95;95;95;98;99;101;94;100 09:34:53 INFO - PID 13925 | |8;json-parse-financial;54;56;56;56;56;56;59;61;56;57 09:34:53 INFO - PID 13925 | |9;json-stringify-tinderbox;56;56;55;58;56;56;55;56;60;56 09:34:53 INFO - PID 13925 | |10;stanford-crypto-aes;91;83;82;85;85;83;84;85;91;82 09:34:53 INFO - PID 13925 | |11;stanford-crypto-ccm;138;136;131;142;143;132;133;130;188;146 09:34:53 INFO - PID 13925 | |12;stanford-crypto-pbkdf2;193;190;194;190;186;200;191;193;183;181 09:34:53 INFO - PID 13925 | |13;stanford-crypto-sha256-iterative;76;78;76;74;78;76;79;72;77;76 09:34:53 INFO - PID 13925 | __end_tp_report 09:34:53 INFO - PID 13925 | __start_cc_report 09:34:53 INFO - PID 13925 | _x_x_mozilla_cycle_collect,768 09:34:53 INFO - PID 13925 | __end_cc_report 09:34:53 INFO - PID 13925 | __startTimestamp1495211693452__endTimestamp 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | ------- Summary: start ------- 09:34:53 INFO - PID 13925 | Number of tests: 14 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.67 (2.4%) stddev-sans-first:1.33 09:34:53 INFO - PID 13925 | Values: 105.0 114.0 113.0 111.0 111.0 112.0 112.0 114.0 111.0 114.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:127.50 stddev:15.18 (11.9%) stddev-sans-first:15.07 09:34:53 INFO - PID 13925 | Values: 150.0 127.0 125.0 162.0 125.0 124.0 124.0 126.0 157.0 128.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.00 stddev:2.17 (1.3%) stddev-sans-first:2.22 09:34:53 INFO - PID 13925 | Values: 164.0 165.0 164.0 164.0 164.0 167.0 169.0 168.0 163.0 168.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:10.38 (13.7%) stddev-sans-first:10.86 09:34:53 INFO - PID 13925 | Values: 76.0 78.0 75.0 106.0 76.0 75.0 78.0 75.0 93.0 76.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.50 stddev:11.33 (13.6%) stddev-sans-first:11.77 09:34:53 INFO - PID 13925 | Values: 84.0 83.0 111.0 83.0 84.0 84.0 100.0 84.0 83.0 108.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.50 stddev:1.23 (1.1%) stddev-sans-first:1.27 09:34:53 INFO - PID 13925 | Values: 116.0 115.0 115.0 114.0 114.0 117.0 114.0 114.0 117.0 116.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 09:34:53 INFO - PID 13925 | Values: 151.0 150.0 152.0 151.0 151.0 151.0 153.0 150.0 152.0 151.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:95.00 stddev:2.49 (2.6%) stddev-sans-first:2.62 09:34:53 INFO - PID 13925 | Values: 96.0 95.0 95.0 95.0 95.0 98.0 99.0 101.0 94.0 100.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:1.95 (3.5%) stddev-sans-first:1.80 09:34:53 INFO - PID 13925 | Values: 54.0 56.0 56.0 56.0 56.0 56.0 59.0 61.0 56.0 57.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:1.51 (2.7%) stddev-sans-first:1.59 09:34:53 INFO - PID 13925 | Values: 56.0 56.0 55.0 58.0 56.0 56.0 55.0 56.0 60.0 56.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:3.31 (3.9%) stddev-sans-first:2.74 09:34:53 INFO - PID 13925 | Values: 91.0 83.0 82.0 85.0 85.0 83.0 84.0 85.0 91.0 82.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:140.00 stddev:17.10 (12.2%) stddev-sans-first:18.08 09:34:53 INFO - PID 13925 | Values: 138.0 136.0 131.0 142.0 143.0 132.0 133.0 130.0 188.0 146.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.10 Median:192.00 stddev:5.59 (2.9%) stddev-sans-first:5.83 09:34:53 INFO - PID 13925 | Values: 193.0 190.0 194.0 190.0 186.0 200.0 191.0 193.0 183.0 181.0 09:34:53 INFO - PID 13925 | 09:34:53 INFO - PID 13925 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:76.50 stddev:2.04 (2.7%) stddev-sans-first:2.17 09:34:53 INFO - PID 13925 | Values: 76.0 78.0 76.0 74.0 78.0 76.0 79.0 72.0 77.0 76.0 09:34:53 INFO - PID 13925 | -------- Summary: end -------- 09:34:53 INFO - PID 13925 | 09:34:54 INFO - TEST-INFO | 13925: exit 0 09:34:54 INFO - TEST-OK | kraken | took 63524ms 09:34:54 INFO - SUITE-END | took 1182s 09:34:54 INFO - Completed test suite (00:19:42) 09:34:54 INFO - javascript benchmark 09:34:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6770.82373763049, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2678.3170291575643, 2681.7452342027505, 2687.529682305596, 2698.7031426543076, 2703.21606734047, 5175.378954525453, 5178.741062946857, 5191.610629202811, 5203.375594928609, 5254.211868219769, 5192.480751924805, 5299.788008479666, 5302.390225124112, 5311.176767601028, 5318.282031925699, 4418.7127836690515, 4630.467496237925, 4653.115907977482, 4657.928676404429, 4716.787744551486, 4737.194676904917, 4773.331733557287, 4785.258284965836, 4789.640776941726, 4810.302506136608, 4670.042641258534, 4715.1748444022505, 4716.985848042687, 4733.313669517935, 4776.761161941907, 4641.721496710208, 4665.603423708989, 4680.57874791267, 4699.365585645963, 4714.387129673155, 4635.768211589407, 4647.976760116211, 4661.836835710734, 4673.439187297512, 4710.128626204163, 5218.895622087537, 5242.951409718034, 5250.133727934886, 5275.393329767049, 5304.549113325372, 5635.971820140914, 5668.886622267572, 5694.629849059798, 5700.802831405368, 5725.227094342294, 5728.484436400744, 5731.197632331477, 5733.111367738007, 5741.25363702716, 5751.0, 5319.0957537218765, 5322.2282768998275, 5328.92006619901, 5330.493603107776, 5369.033573956647, 5724.398938111522, 5787.189793428924, 5788.160716696056, 5863.091220860773, 5869.6771677558145, 5582.804601838916, 5616.85957851057, 5620.747066382022, 5621.831345059655, 5645.322561292671, 5541.944580554143, 5608.1587761835235, 5608.9439105609235, 5666.065099258576, 5675.3757086720425, 5564.582656300794, 5647.830565083054, 5662.915056274159, 5682.0, 5706.9714651426475, 5502.5597952163735, 5581.274434323594, 5590.776368945197, 5645.633033852787, 5652.180433837153, 4643.721376717408, 4678.929816052762, 4685.672002959828, 4696.319033740088, 4733.479317275097, 4028.133951200506, 4038.374052021941, 4040.8181631826637, 4067.8372865085066, 4070.7964601769795, 4727.338172655831, 4728.361671174416, 4750.548697873696, 4777.713337199779, 4792.0895029944195, 5687.317521897398, 5704.372519022904, 5726.1410788381245, 5767.942320576824, 5774.595778295479, 4787.760611969387, 4797.304390863305, 4799.6400269979895, 4808.61531077513, 4842.539958703917, 4992.775325110306, 5011.398632164163, 5059.848204553796, 5059.8988020239385, 5066.290719299374, 5211.791528338824, 5244.711540865136, 5280.102382595045, 5297.841064768063, 5298.231756395378, 5655.519280861008, 5683.829485115453, 5702.05916023868, 5712.400197979152, 5722.341930678025, 5259.47405259471, 5273.525382715574, 5275.419703832652, 5278.181881808326, 5332.30680011596, 5351.919721204263, 5473.863153421196, 5525.889482210253, 5584.385717570983, 5606.299212598426, 5733.4266573344, 5742.569307301886, 5742.856428589152, 5775.306963164448, 5796.82609521715, 5372.113601255749, 5428.240046393429, 5460.153676180198, 5528.91706624409, 5539.473749993744, 5451.255598208535, 5506.366767821592, 5552.69460179694, 5600.803971860965, 5601.187827765033, 5377.166539186433, 5411.567074633941, 5454.754536045808, 5460.31746031746, 5473.589480789036, 5381.19282107687, 5516.3380394352935, 5528.861778455571, 5542.722863856871, 5543.750531226024, 5389.595780316414, 5401.540869026019, 5412.702301373305, 5428.375736790162, 5429.294191755047], "value": 5132.2444205351585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.2941943346939, 739.4564994728875, 767.9692812287509, 1016.3292227130091, 1040.0743338428795, 31590.368192636135, 33051.0, 33317.0, 33352.166195845115, 33360.33279334412, 35490.2901941961, 35834.64165358346, 35916.0, 35954.8202258989, 35955.82022089886, 6388.073729309247, 6449.35506449356, 6935.30646935305, 7060.0, 7061.89407158893, 6722.596644201339, 6774.051632771416, 6799.626020568867, 6808.080909077261, 6813.693383797716, 6806.4554835613035, 6825.249222585511, 6863.897041544381, 6863.897041544381, 6887.48343874209, 6819.795406137849, 6821.420179284717, 6834.9658251708925, 6835.521513494057, 6838.281980392062, 6898.862022759567, 6910.723571057151, 6924.6537673116645, 6932.965335173342, 6947.131608548932, 31109.688903110906, 31421.0, 31457.685423145933, 31598.368032639217, 31621.683783162105, 3094.5048792193143, 3132.3578666373337, 3136.81179129253, 3141.984290078558, 3145.496720524728, 24223.515529689485, 24235.7576424237, 24281.814636682608, 24372.390690232707, 24473.755262447503, 3116.236522052089, 3202.2154572129743, 3202.5036119401298, 3209.5346174804754, 3242.221866751986, 140408.0, 140438.29780851133, 144309.0, 149352.0, 149791.0, 38628.0, 38713.0, 38755.22489550193, 38787.22425551473, 38801.0, 40481.797591011855, 40497.79751101285, 40530.0, 40621.18757624831, 40750.18499629991, 12516.561920332744, 12596.81104783429, 12604.432800523999, 12674.366281686063, 12695.301758403191, 10165.186785057178, 10263.74340641475, 10264.230182736324, 10268.948655256825, 10300.22748293881, 12475.5009799607, 12563.371831408393, 12657.303848288433, 12659.177153485178, 12823.743525129445, 5317.41508434072, 5335.359756829205, 5379.811706590251, 5437.184422336682, 5524.116141417434, 897.6229983406985, 930.3627015494408, 930.706318217678, 933.3979583168818, 960.9471479068718, 20828.1668733249, 21131.0, 21222.25722099719, 21228.150873964867, 21383.35849924505, 1003.1222680154865, 1004.7689031522791, 1009.3489699144011, 1033.9172866170688, 1035.7980193862275, 11179.429290684104, 11427.314361138358, 11502.769944601228, 11540.653780386434, 11555.133364997659, 168998.15500922417, 171138.14430927765, 171360.0, 171378.0, 171737.0, 40293.79853100774, 40831.387529187086, 40835.591644083775, 40839.7958010214, 40982.38526422106, 1215.2647648172906, 1264.3172686749053, 1269.2447993443886, 1275.1329096214663, 1276.208750574631, 19840.90079549593, 19882.304119355755, 20361.49096272605, 21330.253441129487, 21384.786152138902, 29737.851310743306, 29774.851125744233, 29842.403151936407, 29873.0, 29927.401451970403, 144275.27862360622, 144732.0, 144886.0, 145216.0, 145451.0, 29127.0, 29282.267943301587, 29659.555106672986, 30722.692773071984, 30731.38537229198, 36555.45166822553, 36759.63240367562, 36779.63220367762, 37019.25961480809, 37180.814095929345, 26215.868920655274, 27323.453530928873, 27754.306142346602, 27925.301867453476, 28183.43633127367, 27684.44631107407, 28057.438851222454, 28108.578371324038, 28957.710422895503, 29238.02953497953, 31071.378572428875, 31093.378132437676, 31113.84443077861, 31117.377652447278, 31166.22084447907, 26892.327691807077, 26900.865495672395, 27814.44371112526, 28085.57871631886, 28347.716522834507, 20239.0, 23041.539169216856, 23045.65431518562, 23062.654060189445, 23140.190093346653], "value": 14526.280899573949, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.4439179303835, 418.36408658838565, 422.57953336430245, 437.61271274921694, 447.2039769210806, 17181.91409042956, 18050.90974545127, 18097.1856266468, 18628.53428664284, 19461.124249408775, 17557.736633950502, 17754.64490710185, 17762.555936101573, 17784.11079446026, 17977.0, 5423.484768946953, 5480.890382192374, 5614.29821272341, 5712.314522257314, 5735.770569177228, 5639.661620302774, 5654.406287339832, 5676.205331253628, 5685.090385538315, 5689.175069614904, 5542.0, 5617.775288988436, 5640.407757185498, 5653.886922261552, 5655.462731040565, 5559.526725417768, 5625.887482250352, 5629.549636029149, 5674.3190817101795, 5698.230738850264, 5060.165072762989, 5126.128558145124, 5130.1791713326065, 5130.589552835801, 5130.871728206787, 21897.890510547506, 21973.890130549244, 22287.777122228734, 22696.659550106597, 22827.543449130924, 1628.4137710424238, 1642.2773979449123, 1653.6609994951007, 1655.5198992292221, 1656.403694669918, 14585.19781412022, 14778.778318325234, 14987.550373488813, 15123.924380378137, 15200.0, 2032.1363420546356, 2064.370367038053, 2131.2540610786255, 2155.9461013474634, 2159.8704077755383, 83638.0, 88491.11508884894, 88621.0, 89205.0, 92804.07195928022, 10750.569977200981, 10856.240063195659, 11023.669289921316, 11116.444177791078, 11188.216824822184, 14803.629909252355, 14837.777433338508, 14846.436855154685, 14855.48005819791, 14918.701625967637, 7299.175206198451, 7405.481616286808, 7477.4391920605085, 7640.159582445926, 7671.961640191875, 6761.0872532208505, 6791.408823845672, 6984.965075174693, 7005.684744186524, 7030.472714546429, 6888.483363747739, 6923.584584924921, 7067.328603782633, 7072.5402848814665, 7079.575225486487, 2003.24878170686, 2017.1628774058895, 2055.660815965349, 2074.481379655086, 2153.935381938544, 863.4560227056913, 875.5578432891476, 879.1823604048296, 885.3979294079959, 906.1074841281333, 17180.570485737957, 17211.139443027798, 17466.737998930028, 17878.035897589158, 17901.283948641907, 877.1842186766369, 886.9689560865339, 887.5251740318898, 893.6023469556116, 893.8525143351404, 9294.953525232331, 9398.248140148771, 9506.667266645773, 9773.21814254858, 10008.49957502122, 323841.0, 328328.0, 328958.0, 330363.0, 331708.0, 73078.63460682663, 73773.0, 74006.62996684982, 74710.62644686742, 75253.24746752573, 1020.153272783573, 1028.5114570578914, 1062.1874266186373, 1071.3357718214756, 1074.403705943209, 14335.354909029327, 14746.483873064391, 14921.477748278758, 14925.776113358526, 15434.691306173589, 37271.62728372682, 37519.81240093782, 38498.80750596229, 39270.4109438353, 39535.40696889492, 44514.3322850164, 44881.10237795291, 45093.0, 45183.0, 46427.30359044685, 8438.620262088098, 8536.914630853613, 8547.74356769298, 8555.914440855511, 9046.321525885453, 13388.531401400904, 13600.251986140462, 13616.86383136156, 13753.656158596115, 13854.515091971733, 11032.172587055842, 11219.887801121884, 11571.537138514364, 11645.59240426581, 11705.473253703434, 10465.581376744845, 10575.947120264349, 10598.89401105979, 10686.786264274826, 10923.235373523778, 11394.817453428017, 11409.201355905006, 11551.653450396501, 11699.2980421175, 11794.52821887115, 8163.755087347389, 8218.342532597258, 8237.95881020615, 8353.24820766134, 8578.099299573705, 10856.13150947938, 10905.34567925927, 10922.563097476012, 10962.616308429167, 11155.665330040112], "value": 8841.10003535115, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.8423947006625, 1322.2859655785876, 1326.8009798530225, 1328.1566205459537, 1342.2550484481114, 9965.402075875452, 10155.949220253908, 10481.318714283576, 10483.790324193511, 10527.105196058325, 10419.218558608116, 10559.26085174038, 10592.41741704206, 10647.467626618658, 10649.20130990175, 2176.912923483059, 2196.187410658059, 2201.2720014788392, 2209.767974362685, 2213.1589995801573, 2137.3908436095717, 2182.443476913385, 2193.605151072806, 2200.2409168836725, 2207.426069222006, 2213.5683541709373, 2225.7662945390744, 2253.346529506441, 2268.1381075191402, 2270.625346817773, 2142.335875878475, 2160.5138843760187, 2161.7622061573215, 2187.136081247906, 2192.3094225319055, 1972.063269946778, 2106.947326316839, 2197.2968650031994, 2197.5385169114506, 2209.569134018867, 9903.405795652285, 10110.646127385506, 10164.695059148164, 10208.846867296996, 10209.591616335338, 5590.357108932484, 5774.682392468412, 5793.5654825887805, 5797.884042319172, 5808.564357673192, 3059.204606802225, 3178.475551533994, 3219.5814544109116, 3329.866805327784, 3432.1934345429054, 1061.787642471509, 1074.3285446595878, 1124.2692250037542, 1172.1033409441784, 1180.3390101543164, 15241.390344386211, 15498.225088745517, 15560.0, 15577.766333505006, 15586.454474093352, 4921.434035086011, 4984.3021976923255, 5058.418281897629, 5066.341375621219, 5069.949300507022, 12697.238165709901, 12723.936380318224, 12726.872731272753, 12735.681607959876, 12756.55352062692, 5709.885802283931, 5729.7708091676695, 5739.913901291484, 5740.339860915965, 5747.281589801275, 4883.291922671193, 5002.274670172877, 5111.897762044812, 5136.43499215086, 5272.077386457355, 4230.830766769356, 4331.155424692155, 4338.501072376717, 4381.627561657295, 4417.867463976086, 1370.3216907630785, 1391.8634895435457, 1397.1547213935626, 1413.2651021468778, 1418.5886093032905, 701.7543859649082, 723.0636325957897, 724.2178447276929, 725.1986554856912, 742.6732237815344, 5647.29408823897, 5728.77084916607, 5744.4829965303325, 5827.067669172912, 5830.096335068071, 547.2038184441628, 564.6950646650845, 567.222904620664, 570.3526497425452, 570.6747154122111, 3415.7438192135687, 3418.8974330770116, 3803.657670809585, 3819.579846216914, 3932.9774258692373, 13084.738305234032, 13469.932650336686, 13678.794818077737, 13764.793528097087, 13774.380152893144, 13119.540816071392, 13338.799918001238, 13469.797953030713, 13631.04582679203, 13726.588202353945, 6872.209695884937, 7240.9862619233345, 7320.267973202744, 7377.704891804267, 7407.740729074564, 6195.101710252078, 6501.2523559791225, 6502.772402965874, 6611.272759996493, 6640.568363056386, 11681.415929203677, 12150.392480376122, 12209.816852747039, 12422.813657794959, 12453.813192801934, 11989.580364687194, 12051.578194763491, 12251.203671761306, 12357.382130893599, 12441.191322564004, 8207.302379297827, 8265.917340826514, 8387.203215694499, 8395.538245396561, 8406.411551191359, 9542.236621070158, 9805.607775688892, 9809.803803924024, 9820.312578119463, 9828.164606008284, 7904.774759912223, 8138.064122625974, 8157.551334676413, 8294.509729907144, 8455.661773529237, 8209.096999330188, 8231.876521852057, 8248.917510825055, 8338.207870252316, 8353.916460835557, 7064.0, 7179.676914538963, 7187.8562428752175, 7207.71169153228, 7213.062301900719, 5316.973415132899, 5338.599605029561, 5425.972870135624, 5428.864278393072, 5544.3346798384455, 5202.2196670499725, 5227.0, 5288.894222115613, 5330.653507521999, 5466.3986961435], "value": 4799.991708168181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.9755615884967, 397.6202726396291, 400.0937875711512, 400.5313782874037, 410.42335518596366, 5401.351837779472, 5508.917366239504, 5524.281843360358, 5526.0, 5542.334919809624, 5373.973130134344, 5431.755570999305, 5450.809221677242, 5451.236826844235, 5464.972675136619, 4324.589164029412, 4333.1117120990275, 4352.825886964533, 4356.346548017791, 4359.0, 4245.724027938174, 4318.4170137031415, 4338.587834155766, 4346.391505189276, 4351.977285337943, 4311.91376172478, 4312.762798046122, 4313.374560688699, 4314.842578710644, 4337.522872484024, 4302.440682711243, 4320.0711846952745, 4329.480462344523, 4337.501187363462, 4349.412829268072, 3865.8260378283044, 3939.231849789292, 3968.7023473239624, 3977.363621820524, 4008.67930565557, 5352.591333899761, 5360.16917377807, 5360.839174824722, 5364.1149210380245, 5384.138537833967, 5156.948430515685, 5166.302549155854, 5180.067587834188, 5183.0, 5192.792288308463, 5668.291463567054, 5733.254676892019, 5786.855328616776, 5838.883222335572, 5848.941510584925, 4396.670249731283, 4417.116576684676, 4419.845305414295, 4441.333799930037, 4449.621782148522, 5825.330087040003, 6076.696165191723, 6094.481969032638, 6096.725647345836, 6144.201253837017, 4283.635890949242, 4327.675424343124, 4332.480102387671, 4335.934960975588, 4352.412424322676, 4393.967417656848, 4397.142557201379, 4406.162829062468, 4409.49290831552, 4425.424694789721, 4943.530364615356, 4945.357103576512, 4956.207006878954, 5091.7016160879475, 5142.0, 5759.164921086419, 5775.0, 5777.7977770777825, 5799.304083509922, 5801.3328467225965, 1605.2776250687236, 1626.5852207686964, 1631.4371541818055, 1633.3466613354753, 1637.6560922206231, 1177.6231605886035, 1184.2894263442038, 1185.3895243949373, 1193.26614132308, 1209.2744353388073, 4929.901401971941, 4954.529319714621, 4957.925631115536, 4970.527799859007, 4976.42771081323, 5938.61399009063, 5942.405759424109, 5962.642241465526, 5971.611845230046, 5977.671228082497, 4837.637177211724, 4924.630652701062, 4926.679765815211, 4948.0, 4968.22992436173, 3116.626004879429, 3124.4063627910623, 3139.152428844199, 3144.7326977206735, 3151.842407879597, 5288.471152884757, 5473.507384335429, 5489.533389661923, 5498.1752737089755, 5513.476219759116, 6120.449159575571, 6140.8771824563255, 6151.815445536641, 6153.753849845956, 6154.292256390483, 5495.945040549624, 5512.9877594676855, 5515.200295957064, 5517.503424691717, 5528.783667593123, 5816.534677225727, 5906.497947674324, 5909.202257695328, 5952.5833191676165, 5959.821205363846, 5668.801591944427, 5818.301803783573, 5825.271841019872, 5855.853603659943, 5895.351511333835, 5465.863353416196, 5478.151361292185, 5508.44915508446, 5517.337919449692, 5517.779288828402, 4072.7963601819197, 4103.815328310174, 4107.630313271819, 4108.876733697994, 4112.033672087117, 5900.881982360414, 5974.2830860297045, 5990.670513121646, 6010.068439391901, 6026.427489388501, 5786.0, 5790.623609465371, 5811.024251754424, 5822.097574875901, 5823.475887170175, 5683.765594632026, 5761.942380576141, 5770.740316685676, 5785.913211301918, 5804.622699524517, 5688.943110568841, 5689.8862022758485, 5698.800541981011, 5705.771769129188, 5735.9139612905, 5813.79651712188, 5833.4749872511675, 5843.8539036522725, 5858.853528661647, 5874.265716785402, 5419.3225846769155, 5602.299712535933, 5608.0, 5618.353889302783, 5657.575681823962], "value": 4428.271845472605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.9333160015598, 756.5498528375617, 765.8736308509096, 773.6750564762799, 783.1189911349734, 11887.583934562292, 12425.875741242586, 13220.537281195147, 14271.500497482602, 14282.428702851887, 13696.383662735176, 14087.436502539886, 14145.71708565828, 14192.787108193384, 14290.214038227894, 892.2415946445534, 916.6791622931987, 920.4247345409119, 921.806420651664, 924.935254532183, 906.8322360363354, 912.9452232866049, 914.8261830252264, 916.3906002508324, 919.1865199298602, 961.5336561767538, 962.4610218277752, 963.9228861691048, 964.0215181590692, 967.6709918627665, 955.7085089047838, 956.0964888180672, 957.042957042957, 957.6791774755466, 961.0821665309647, 699.2168770976539, 705.562551218248, 706.6608028146519, 710.0201721624177, 710.6766421278357, 13774.311284435838, 13803.585892423243, 13901.930490347584, 14488.927555362261, 14735.042222255519, 15647.0, 15791.21043947798, 15798.60503487422, 15950.521484355488, 16081.919590401973, 12754.298513581842, 12780.0, 12835.935820320932, 12838.101332906701, 12863.935680321538, 2947.852607369623, 2958.1421387797513, 2968.807027543203, 2976.1666733314705, 2979.06159559738, 61159.38840611582, 63762.0, 64703.0, 65050.0, 65349.67325163391, 12624.747505049847, 12897.097203195686, 12965.546205882938, 12978.935105324601, 12979.610611681665, 22849.771502284766, 22897.656535151986, 22927.312180634275, 23236.0, 23434.296971090895, 6505.21937367519, 6520.902186467207, 6693.230278518033, 6704.497162712719, 6726.024726414643, 3069.493533566981, 3131.5146152346424, 3139.0, 3162.652108268089, 3166.9366612668077, 3265.1184180271193, 3328.084776686382, 3341.064501939461, 3348.196432856097, 3439.8968030959113, 693.1820451866745, 697.3619138488327, 700.992990070103, 702.3959394920364, 703.0543918429704, 596.5347029317139, 618.8638499530186, 619.4672581579838, 628.9622622642564, 634.0172732264971, 9316.48759318244, 9986.30095893295, 10045.849312260321, 10248.0, 10644.733881652866, 525.75552368149, 527.5357685237044, 529.6080900133874, 530.3423754544337, 538.8625900395452, 4448.488423831301, 4629.328747331618, 4646.697964632288, 4697.859064228079, 4777.4505931818285, 62765.68617156885, 63110.68444657747, 63713.681431592544, 63878.68060659667, 64743.35256647468, 55871.44128558744, 56069.71965140148, 56662.433375666544, 56814.71592642093, 57311.426885731446, 49741.0, 51634.22548661773, 52023.21965170526, 52581.737091315066, 53257.2011419829, 8819.559022048743, 9080.727578172666, 9315.72052838416, 9554.713358599252, 9565.808683826424, 27133.321666958484, 27372.315692107855, 27457.0, 27551.31121721973, 27990.160295191177, 32158.35683286368, 32612.34775304528, 32663.346733065682, 32684.346313074082, 33317.83341083279, 11273.830892536454, 13460.461581536629, 13882.652933676334, 13899.16605003703, 14096.154230745778, 15009.77485337699, 15753.606159846095, 15851.603709907344, 16336.264868080727, 16941.407050753165, 14522.419103235752, 14713.705725885637, 14944.476943306932, 15180.544583662508, 15307.54077377636, 14572.198529081003, 14893.404263829325, 15225.086494810346, 15528.611784705472, 15702.21488925572, 14850.925745371636, 14921.179335136672, 15475.148866812433, 15783.842161578697, 16064.67870642604, 10040.497975101362, 10719.839202411815, 10848.132149427869, 10939.890601094206, 10986.560537578407, 11239.157063220127, 11978.64064078079, 12015.219010764273, 12188.756224875275, 12264.38678066111], "value": 6876.631121349577, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 111.0, 111.0, 112.0, 112.0, 114.0, 111.0, 114.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 125.0, 162.0, 125.0, 124.0, 124.0, 126.0, 157.0, 128.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 164.0, 164.0, 167.0, 169.0, 168.0, 163.0, 168.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 106.0, 76.0, 75.0, 78.0, 75.0, 93.0, 76.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 111.0, 83.0, 84.0, 84.0, 100.0, 84.0, 83.0, 108.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 114.0, 114.0, 117.0, 114.0, 114.0, 117.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 152.0, 151.0, 151.0, 151.0, 153.0, 150.0, 152.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 98.0, 99.0, 101.0, 94.0, 100.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 56.0, 56.0, 56.0, 56.0, 59.0, 61.0, 56.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 58.0, 56.0, 56.0, 55.0, 56.0, 60.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 83.0, 82.0, 85.0, 85.0, 83.0, 84.0, 85.0, 91.0, 82.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 131.0, 142.0, 143.0, 132.0, 133.0, 130.0, 188.0, 146.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 190.0, 194.0, 190.0, 186.0, 200.0, 191.0, 193.0, 183.0, 181.0], "value": 190.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 74.0, 78.0, 76.0, 79.0, 72.0, 77.0, 76.0], "value": 76.2, "unit": "score"}]}]} 09:34:54 INFO - Return code: 0 09:34:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:34:54 INFO - # TBPL SUCCESS # 09:34:54 INFO - Running post-action listener: _resource_record_post_action 09:34:54 INFO - [mozharness: 2017-05-19 16:34:54.745056Z] Finished run-tests step (success) 09:34:54 INFO - Running post-run listener: _resource_record_post_run 09:34:54 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 20480; Write bytes: 421175296; Read time: 324; Write time: 251764 09:34:54 INFO - TinderboxPrint: CPU usage
13.3% 09:34:54 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 324 09:34:54 INFO - TinderboxPrint: I/O write bytes / time
421,175,296 / 251,764 09:34:54 INFO - TinderboxPrint: CPU idle
8,299.2 (86.6%) 09:34:54 INFO - TinderboxPrint: CPU user
1,220.4 (12.7%) 09:34:54 INFO - TinderboxPrint: Swap in / out
0 / 0 09:34:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 12288; Write bytes: 103182336; Read time: 180; Write time: 84844 09:34:54 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317992960; Read time: 128; Write time: 166920 09:34:55 INFO - Running post-run listener: _upload_blobber_files 09:34:55 INFO - Blob upload gear active. 09:34:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:34:55 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 09:34:55 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'] 09:34:55 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 09:34:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:34:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:34:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:34:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:57 INFO - (blobuploader) - INFO - Done attempting. 09:34:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:34:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:34:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:58 INFO - (blobuploader) - INFO - Done attempting. 09:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:35:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:02 INFO - (blobuploader) - INFO - Done attempting. 09:35:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:35:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:35:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:03 INFO - (blobuploader) - INFO - Done attempting. 09:35:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:35:03 INFO - Return code: 0 09:35:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:35:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:35:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21e15f44e5f6acc9463fc70b1d1b641ce873879dfb66534e0a1611851c1314a9b270bc313d40e1e70e33df89b6f223c89a702553654f928b0ec6b3b2882f6a01", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d351794423ae254e2a624a3b992025a6ed537e7009e1377f786c1c75177ad585558014324884656a3a2f3f6e6d4550c25398827e8e5b624664b2a40f7cf4d9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/206093afa5bc5b6f44dc01074331839474c0292a586fc2d685ea22e378bdc3eedb29815577f8f9755bfafa1a944bcce475f2a362205c2c54ccbff533e9a3224f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57e3dcbf7989a79906b232f00d5d242712ef5a6e83a21c7c14df0da0251b8c209a0d8ff57b536acff09fb687fdea3a7a3d3a4c9a8c35961c31672348c6d1ccbd"} 09:35:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:35:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:35:03 INFO - Contents: 09:35:03 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21e15f44e5f6acc9463fc70b1d1b641ce873879dfb66534e0a1611851c1314a9b270bc313d40e1e70e33df89b6f223c89a702553654f928b0ec6b3b2882f6a01", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d351794423ae254e2a624a3b992025a6ed537e7009e1377f786c1c75177ad585558014324884656a3a2f3f6e6d4550c25398827e8e5b624664b2a40f7cf4d9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/206093afa5bc5b6f44dc01074331839474c0292a586fc2d685ea22e378bdc3eedb29815577f8f9755bfafa1a944bcce475f2a362205c2c54ccbff533e9a3224f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57e3dcbf7989a79906b232f00d5d242712ef5a6e83a21c7c14df0da0251b8c209a0d8ff57b536acff09fb687fdea3a7a3d3a4c9a8c35961c31672348c6d1ccbd"} 09:35:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:35:03 INFO - Copying logs to upload dir... 09:35:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:35:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.827996 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-19 09:35:03.162802) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 09:35:03.166663) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21e15f44e5f6acc9463fc70b1d1b641ce873879dfb66534e0a1611851c1314a9b270bc313d40e1e70e33df89b6f223c89a702553654f928b0ec6b3b2882f6a01", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d351794423ae254e2a624a3b992025a6ed537e7009e1377f786c1c75177ad585558014324884656a3a2f3f6e6d4550c25398827e8e5b624664b2a40f7cf4d9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/206093afa5bc5b6f44dc01074331839474c0292a586fc2d685ea22e378bdc3eedb29815577f8f9755bfafa1a944bcce475f2a362205c2c54ccbff533e9a3224f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57e3dcbf7989a79906b232f00d5d242712ef5a6e83a21c7c14df0da0251b8c209a0d8ff57b536acff09fb687fdea3a7a3d3a4c9a8c35961c31672348c6d1ccbd"} build_url:https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/Vy_hf-shQ-mdsWttWHqW9g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21e15f44e5f6acc9463fc70b1d1b641ce873879dfb66534e0a1611851c1314a9b270bc313d40e1e70e33df89b6f223c89a702553654f928b0ec6b3b2882f6a01", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d351794423ae254e2a624a3b992025a6ed537e7009e1377f786c1c75177ad585558014324884656a3a2f3f6e6d4550c25398827e8e5b624664b2a40f7cf4d9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/206093afa5bc5b6f44dc01074331839474c0292a586fc2d685ea22e378bdc3eedb29815577f8f9755bfafa1a944bcce475f2a362205c2c54ccbff533e9a3224f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57e3dcbf7989a79906b232f00d5d242712ef5a6e83a21c7c14df0da0251b8c209a0d8ff57b536acff09fb687fdea3a7a3d3a4c9a8c35961c31672348c6d1ccbd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 09:35:03.191988) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:35:03.192334) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495206992.469768-1860711443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:35:03.277479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 09:35:03.277838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 09:35:03.278247) ========= ========= Total master_lag: 0.24 =========