builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1495764718.49 results: success (0) revision: c2ff59dd31bce41bc9108939e86618017943b88d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:58.489394) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:58.489882) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:58.490201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:58.509746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:58.510082) ========= 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=cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 19:11:58-- 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% 26.8M=0s 2017-05-25 19:11:58 (26.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105216 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:58.631224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:58.631565) ========= 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=cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013982 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:58.680952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:58.681298) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c2ff59dd31bce41bc9108939e86618017943b88d --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 c2ff59dd31bce41bc9108939e86618017943b88d --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=cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 19:11:58,912 truncating revision to first 12 chars 2017-05-25 19:11:58,912 Setting DEBUG logging. 2017-05-25 19:11:58,912 attempt 1/10 2017-05-25 19:11:58,912 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c2ff59dd31bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 19:11:59,426 unpacking tar archive at: mozilla-central-c2ff59dd31bc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.813446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:59.509840) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:59.510141) ========= script_repo_revision: c2ff59dd31bce41bc9108939e86618017943b88d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:59.513524) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:59.513793) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 19:11:59.522287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-25 19:11:59.522583) ========= /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=cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:11:59 INFO - MultiFileLogger online at 20170525 19:11:59 in /builds/slave/test 19:11:59 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 19:11:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:11:59 INFO - {'append_to_log': False, 19:11:59 INFO - 'base_work_dir': '/builds/slave/test', 19:11:59 INFO - 'blob_upload_branch': 'Firefox', 19:11:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:11:59 INFO - 'branch': 'Firefox', 19:11:59 INFO - 'buildbot_json_path': 'buildprops.json', 19:11:59 INFO - 'config_files': ('talos/linux_config.py',), 19:11:59 INFO - 'default_actions': ('clobber', 19:11:59 INFO - 'read-buildbot-config', 19:11:59 INFO - 'download-and-extract', 19:11:59 INFO - 'populate-webroot', 19:11:59 INFO - 'create-virtualenv', 19:11:59 INFO - 'install', 19:11:59 INFO - 'run-tests'), 19:11:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:11:59 INFO - 'download_minidump_stackwalk': True, 19:11:59 INFO - 'download_symbols': 'ondemand', 19:11:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:11:59 INFO - 'tooltool.py': '/tools/tooltool.py', 19:11:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:11:59 INFO - '/tools/misc-python/virtualenv.py')}, 19:11:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:11:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:11:59 INFO - 'gecko_profile': False, 19:11:59 INFO - 'gecko_profile_interval': 0, 19:11:59 INFO - 'installer_path': 'installer.exe', 19:11:59 INFO - 'log_level': 'info', 19:11:59 INFO - 'log_name': 'talos', 19:11:59 INFO - 'log_to_console': True, 19:11:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:11:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:11:59 INFO - 'opt_config_files': (), 19:11:59 INFO - 'pip_index': False, 19:11:59 INFO - 'suite': 'dromaeojs-e10s', 19:11:59 INFO - 'system_bits': '32', 19:11:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:11:59 INFO - 'title': 'talos-linux64-ix-054', 19:11:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:11:59 INFO - 'use_talos_json': True, 19:11:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:11:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:11:59 INFO - 'work_dir': 'build'} 19:11:59 INFO - [mozharness: 2017-05-26 02:11:59.852604Z] Running clobber step. 19:11:59 INFO - Running pre-action listener: _resource_record_pre_action 19:11:59 INFO - Running main action method: clobber 19:11:59 INFO - rmtree: /builds/slave/test/build 19:11:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:12:00 INFO - Running post-action listener: _resource_record_post_action 19:12:00 INFO - [mozharness: 2017-05-26 02:12:00.853255Z] Finished clobber step (success) 19:12:00 INFO - [mozharness: 2017-05-26 02:12:00.853356Z] Running read-buildbot-config step. 19:12:00 INFO - Running pre-action listener: _resource_record_pre_action 19:12:00 INFO - Running main action method: read_buildbot_config 19:12:00 INFO - Using buildbot properties: 19:12:00 INFO - { 19:12:00 INFO - "project": "", 19:12:00 INFO - "product": "firefox", 19:12:00 INFO - "who": "ryanvm@gmail.com", 19:12:00 INFO - "installer_path": "public/build/target.tar.bz2", 19:12:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 19:12:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:12:00 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 19:12:00 INFO - "stage_platform": "linux64-stylosequential", 19:12:00 INFO - "basedir": "/builds/slave/test", 19:12:00 INFO - "buildnumber": 21, 19:12:00 INFO - "platform": "ubuntu64_hw_styloseq", 19:12:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:12:00 INFO - "slavebuilddir": "test", 19:12:00 INFO - "taskId": "AkRub8sBT_u9ju69UsIIDA", 19:12:00 INFO - "branch": "mozilla-central", 19:12:00 INFO - "script_repo_revision": "production", 19:12:00 INFO - "revision": "c2ff59dd31bce41bc9108939e86618017943b88d", 19:12:00 INFO - "slavename": "talos-linux64-ix-054", 19:12:00 INFO - "repo_path": "mozilla-central" 19:12:00 INFO - } 19:12:00 INFO - Finding installer, test and symbols from parent task. 19:12:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AkRub8sBT_u9ju69UsIIDA'}, attempt #1 19:12:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AkRub8sBT_u9ju69UsIIDA'}, attempt #1 19:12:01 INFO - Task dependencies: JXCa_B9iTWW2mMh5RWYnSA 19:12:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA'}, attempt #1 19:12:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.tar.bz2 19:12:02 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/test_packages.json 19:12:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.crashreporter-symbols.zip 19:12:02 INFO - Running post-action listener: _resource_record_post_action 19:12:02 INFO - [mozharness: 2017-05-26 02:12:02.228911Z] Finished read-buildbot-config step (success) 19:12:02 INFO - [mozharness: 2017-05-26 02:12:02.229138Z] Running download-and-extract step. 19:12:02 INFO - Running pre-action listener: _resource_record_pre_action 19:12:02 INFO - Running main action method: download_and_extract 19:12:02 INFO - mkdir: /builds/slave/test/build/tests 19:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:02 INFO - trying https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.test_packages.json 19:12:02 INFO - Downloading https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:12:02 INFO - Downloaded 986 bytes. 19:12:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:12:02 INFO - Using the following test package requirements: 19:12:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:12:02 INFO - u'common': [u'target.common.tests.zip'], 19:12:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:12:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:12:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:12:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:12:02 INFO - u'mozbase': [u'target.common.tests.zip'], 19:12:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:12:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:12:02 INFO - u'web-platform': [u'target.common.tests.zip', 19:12:02 INFO - u'target.web-platform.tests.zip'], 19:12:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:12:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:12:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.common.tests.zip 19:12:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:12:02 INFO - Fetch https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.common.tests.zip into memory 19:12:03 INFO - Content-Length response header: 63525249 19:12:03 INFO - Bytes received: 63525249 19:12:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:12:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.common.tests.zip 19:12:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:12:15 INFO - Fetch https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.common.tests.zip into memory 19:12:16 INFO - Content-Length response header: 63525249 19:12:16 INFO - Bytes received: 63525249 19:12:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.talos.tests.zip 19:12:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:12:29 INFO - Fetch https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.talos.tests.zip into memory 19:12:30 INFO - Content-Length response header: 14411888 19:12:30 INFO - Bytes received: 14411888 19:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:30 INFO - trying https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.tar.bz2 19:12:30 INFO - Downloading https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:12:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:12:32 INFO - Downloaded 55776101 bytes. 19:12:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.tar.bz2 19:12:32 INFO - mkdir: /builds/slave/test/properties 19:12:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:12:32 INFO - Writing to file /builds/slave/test/properties/build_url 19:12:32 INFO - Contents: 19:12:32 INFO - build_url:https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.tar.bz2 19:12:32 INFO - Running post-action listener: _resource_record_post_action 19:12:32 INFO - Running post-action listener: set_extra_try_arguments 19:12:32 INFO - [mozharness: 2017-05-26 02:12:32.055380Z] Finished download-and-extract step (success) 19:12:32 INFO - [mozharness: 2017-05-26 02:12:32.055477Z] Running populate-webroot step. 19:12:32 INFO - Running pre-action listener: _resource_record_pre_action 19:12:32 INFO - Running main action method: populate_webroot 19:12:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:12:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:12:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:12:32 INFO - '--tppagecycles', 19:12:32 INFO - '7'], 19:12:32 INFO - 'tests': ['tsvgm']}}, 19:12:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:12:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:12:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:12:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:12:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:12:32 INFO - 'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:12:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:12:32 INFO - 'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['damp', 'tps']}, 19:12:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:12:32 INFO - 'tests': ['damp', 'tps']}, 19:12:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['dromaeo_dom']}, 19:12:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:12:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:12:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:12:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:12:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:12:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['a11yr', 19:12:32 INFO - 'ts_paint', 19:12:32 INFO - 'tpaint', 19:12:32 INFO - 'sessionrestore', 19:12:32 INFO - 'sessionrestore_no_auto_restore', 19:12:32 INFO - 'tabpaint']}, 19:12:32 INFO - 'other-e10s': {'tests': ['a11yr', 19:12:32 INFO - 'ts_paint', 19:12:32 INFO - 'tpaint', 19:12:32 INFO - 'sessionrestore', 19:12:32 INFO - 'sessionrestore_no_auto_restore', 19:12:32 INFO - 'tabpaint']}, 19:12:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:12:32 INFO - 'ts_paint', 19:12:32 INFO - 'tpaint', 19:12:32 INFO - 'sessionrestore', 19:12:32 INFO - 'sessionrestore_no_auto_restore', 19:12:32 INFO - 'tabpaint']}, 19:12:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:12:32 INFO - 'ts_paint', 19:12:32 INFO - 'tpaint', 19:12:32 INFO - 'sessionrestore', 19:12:32 INFO - 'sessionrestore_no_auto_restore', 19:12:32 INFO - 'tabpaint']}, 19:12:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['a11yr', 19:12:32 INFO - 'ts_paint', 19:12:32 INFO - 'tpaint', 19:12:32 INFO - 'sessionrestore', 19:12:32 INFO - 'sessionrestore_no_auto_restore', 19:12:32 INFO - 'tabpaint']}, 19:12:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['a11yr', 19:12:32 INFO - 'ts_paint', 19:12:32 INFO - 'tpaint', 19:12:32 INFO - 'sessionrestore', 19:12:32 INFO - 'sessionrestore_no_auto_restore', 19:12:32 INFO - 'tabpaint']}, 19:12:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:12:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:12:32 INFO - 'bloom_basic_ref']}, 19:12:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['tsvgx', 19:12:32 INFO - 'tsvgr_opacity', 19:12:32 INFO - 'tart', 19:12:32 INFO - 'tscrollx', 19:12:32 INFO - 'cart', 19:12:32 INFO - 'tsvg_static']}, 19:12:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:12:32 INFO - 'tsvgr_opacity', 19:12:32 INFO - 'tart', 19:12:32 INFO - 'tscrollx', 19:12:32 INFO - 'cart', 19:12:32 INFO - 'tsvg_static']}, 19:12:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:12:32 INFO - 'talos_options': ['--disable-e10s'], 19:12:32 INFO - 'tests': ['tp5o']}, 19:12:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:12:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:12:32 INFO - 'talos_options': ['--disable-e10s', 19:12:32 INFO - '--xperf_path', 19:12:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:32 INFO - 'tests': ['tp5n']}, 19:12:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:12:32 INFO - 'talos_options': ['--xperf_path', 19:12:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:32 INFO - 'tests': ['tp5n']}}, 19:12:32 INFO - 'talos.zip': {'path': '', 19:12:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:12:32 INFO - Running post-action listener: _resource_record_post_action 19:12:32 INFO - [mozharness: 2017-05-26 02:12:32.069412Z] Finished populate-webroot step (success) 19:12:32 INFO - [mozharness: 2017-05-26 02:12:32.069501Z] Running create-virtualenv step. 19:12:32 INFO - Running pre-action listener: _resource_record_pre_action 19:12:32 INFO - Running main action method: create_virtualenv 19:12:32 INFO - Creating virtualenv /builds/slave/test/build/venv 19:12:32 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 19:12:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:12:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:12:32 INFO - Using real prefix '/usr' 19:12:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:12:32 INFO - Installing distribute.............................................................................................................................................................................................done. 19:12:34 INFO - Installing pip.................done. 19:12:34 INFO - Return code: 0 19:12:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:12:34 INFO - Reading from file tmpfile_stdout 19:12:34 INFO - Output received: 19:12:34 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) 19:12:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:12: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')]} 19:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12: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')]} 19:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:34 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 0x23a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, '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': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', '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 19:12:34 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 19:12:34 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 19:12:34 INFO - Using env: {'DISPLAY': ':0', 19:12:34 INFO - 'HOME': '/home/cltbld', 19:12:34 INFO - 'LANG': 'en_US.UTF-8', 19:12:34 INFO - 'LANGUAGE': 'en_US:en', 19:12:34 INFO - 'LOGNAME': 'cltbld', 19:12:34 INFO - 'MAIL': '/var/mail/cltbld', 19:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:34 INFO - 'MOZ_NO_REMOTE': '1', 19:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:34 INFO - 'NO_EM_RESTART': '1', 19:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:34 INFO - 'PWD': '/builds/slave/test', 19:12:34 INFO - 'SHELL': '/bin/bash', 19:12:34 INFO - 'SHLVL': '1', 19:12:34 INFO - 'TERM': 'linux', 19:12:34 INFO - 'TMOUT': '86400', 19:12:34 INFO - 'USER': 'cltbld', 19:12:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:34 INFO - '_': '/tools/buildbot/bin/python'} 19:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:35 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 19:12:35 INFO - Cleaning up... 19:12:35 INFO - Return code: 0 19:12:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:12:35 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')]} 19:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:35 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')]} 19:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:35 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 0x23a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, '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': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', '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 19:12:35 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 19:12:35 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 19:12:35 INFO - Using env: {'DISPLAY': ':0', 19:12:35 INFO - 'HOME': '/home/cltbld', 19:12:35 INFO - 'LANG': 'en_US.UTF-8', 19:12:35 INFO - 'LANGUAGE': 'en_US:en', 19:12:35 INFO - 'LOGNAME': 'cltbld', 19:12:35 INFO - 'MAIL': '/var/mail/cltbld', 19:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:35 INFO - 'MOZ_NO_REMOTE': '1', 19:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:35 INFO - 'NO_EM_RESTART': '1', 19:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:35 INFO - 'PWD': '/builds/slave/test', 19:12:35 INFO - 'SHELL': '/bin/bash', 19:12:35 INFO - 'SHLVL': '1', 19:12:35 INFO - 'TERM': 'linux', 19:12:35 INFO - 'TMOUT': '86400', 19:12:35 INFO - 'USER': 'cltbld', 19:12:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:35 INFO - '_': '/tools/buildbot/bin/python'} 19:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:35 INFO - Downloading/unpacking psutil>=3.1.1 19:12:35 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 19:12:35 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 19:12:35 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 19:12:35 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 19:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:12:36 INFO - Installing collected packages: psutil 19:12:36 INFO - Running setup.py install for psutil 19:12:36 INFO - building 'psutil._psutil_linux' extension 19:12:36 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 19:12:36 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 19:12:36 INFO - building 'psutil._psutil_posix' extension 19:12:36 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 19:12:36 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 19:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:12:36 INFO - Successfully installed psutil 19:12:36 INFO - Cleaning up... 19:12:37 INFO - Return code: 0 19:12:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, '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': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', '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 19:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:12:37 INFO - Using env: {'DISPLAY': ':0', 19:12:37 INFO - 'HOME': '/home/cltbld', 19:12:37 INFO - 'LANG': 'en_US.UTF-8', 19:12:37 INFO - 'LANGUAGE': 'en_US:en', 19:12:37 INFO - 'LOGNAME': 'cltbld', 19:12:37 INFO - 'MAIL': '/var/mail/cltbld', 19:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:37 INFO - 'MOZ_NO_REMOTE': '1', 19:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:37 INFO - 'NO_EM_RESTART': '1', 19:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:37 INFO - 'PWD': '/builds/slave/test', 19:12:37 INFO - 'SHELL': '/bin/bash', 19:12:37 INFO - 'SHLVL': '1', 19:12:37 INFO - 'TERM': 'linux', 19:12:37 INFO - 'TMOUT': '86400', 19:12:37 INFO - 'USER': 'cltbld', 19:12:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:37 INFO - '_': '/tools/buildbot/bin/python'} 19:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:12:38 INFO - Installing collected packages: mozsystemmonitor 19:12:38 INFO - Running setup.py install for mozsystemmonitor 19:12:38 INFO - Successfully installed mozsystemmonitor 19:12:38 INFO - Cleaning up... 19:12:38 INFO - Return code: 0 19:12:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:38 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 0x23a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, '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': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', '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 19:12:38 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 19:12:38 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 19:12:38 INFO - Using env: {'DISPLAY': ':0', 19:12:38 INFO - 'HOME': '/home/cltbld', 19:12:38 INFO - 'LANG': 'en_US.UTF-8', 19:12:38 INFO - 'LANGUAGE': 'en_US:en', 19:12:38 INFO - 'LOGNAME': 'cltbld', 19:12:38 INFO - 'MAIL': '/var/mail/cltbld', 19:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:38 INFO - 'MOZ_NO_REMOTE': '1', 19:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:38 INFO - 'NO_EM_RESTART': '1', 19:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:38 INFO - 'PWD': '/builds/slave/test', 19:12:38 INFO - 'SHELL': '/bin/bash', 19:12:38 INFO - 'SHLVL': '1', 19:12:38 INFO - 'TERM': 'linux', 19:12:38 INFO - 'TMOUT': '86400', 19:12:38 INFO - 'USER': 'cltbld', 19:12:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:38 INFO - '_': '/tools/buildbot/bin/python'} 19:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:38 INFO - Downloading/unpacking jsonschema==2.5.1 19:12:38 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 19:12:38 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 19:12:38 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 19:12:38 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 19:12:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:12:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:12: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 19:12: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 19:12: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 19:12: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 19:12:39 INFO - Downloading functools32-3.2.3-2.tar.gz 19:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:12:39 INFO - warning: no files found matching '*.txt' 19:12:39 INFO - no previously-included directories found matching 'build' 19:12:39 INFO - no previously-included directories found matching 'dist' 19:12:39 INFO - no previously-included directories found matching '.git*' 19:12:39 INFO - Installing collected packages: jsonschema, functools32 19:12:40 INFO - Running setup.py install for functools32 19:12:40 INFO - warning: no files found matching '*.txt' 19:12:40 INFO - no previously-included directories found matching 'build' 19:12:40 INFO - no previously-included directories found matching 'dist' 19:12:40 INFO - no previously-included directories found matching '.git*' 19:12:40 INFO - Successfully installed jsonschema functools32 19:12:40 INFO - Cleaning up... 19:12:40 INFO - Return code: 0 19:12:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:40 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 0x23a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, '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': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', '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 19:12:40 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 19:12:40 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 19:12:40 INFO - Using env: {'DISPLAY': ':0', 19:12:40 INFO - 'HOME': '/home/cltbld', 19:12:40 INFO - 'LANG': 'en_US.UTF-8', 19:12:40 INFO - 'LANGUAGE': 'en_US:en', 19:12:40 INFO - 'LOGNAME': 'cltbld', 19:12:40 INFO - 'MAIL': '/var/mail/cltbld', 19:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:40 INFO - 'MOZ_NO_REMOTE': '1', 19:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:40 INFO - 'NO_EM_RESTART': '1', 19:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:40 INFO - 'PWD': '/builds/slave/test', 19:12:40 INFO - 'SHELL': '/bin/bash', 19:12:40 INFO - 'SHLVL': '1', 19:12:40 INFO - 'TERM': 'linux', 19:12:40 INFO - 'TMOUT': '86400', 19:12:40 INFO - 'USER': 'cltbld', 19:12:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:40 INFO - '_': '/tools/buildbot/bin/python'} 19:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:12:40 INFO - Cleaning up... 19:12:40 INFO - Return code: 0 19:12:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:40 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 0x23a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, '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': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', '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 19:12:40 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 19:12:40 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 19:12:40 INFO - Using env: {'DISPLAY': ':0', 19:12:40 INFO - 'HOME': '/home/cltbld', 19:12:40 INFO - 'LANG': 'en_US.UTF-8', 19:12:40 INFO - 'LANGUAGE': 'en_US:en', 19:12:40 INFO - 'LOGNAME': 'cltbld', 19:12:40 INFO - 'MAIL': '/var/mail/cltbld', 19:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:40 INFO - 'MOZ_NO_REMOTE': '1', 19:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:40 INFO - 'NO_EM_RESTART': '1', 19:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:40 INFO - 'PWD': '/builds/slave/test', 19:12:40 INFO - 'SHELL': '/bin/bash', 19:12:40 INFO - 'SHLVL': '1', 19:12:40 INFO - 'TERM': 'linux', 19:12:40 INFO - 'TMOUT': '86400', 19:12:40 INFO - 'USER': 'cltbld', 19:12:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:40 INFO - '_': '/tools/buildbot/bin/python'} 19:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:40 INFO - Downloading/unpacking blobuploader==1.2.4 19:12:40 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 19:12:40 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 19:12:40 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 19:12:40 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 19:12:41 INFO - Downloading blobuploader-1.2.4.tar.gz 19:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:12:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:12: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 19:12: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 19:12: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 19:12: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 19:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:12:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:42 INFO - Downloading docopt-0.6.1.tar.gz 19:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:12:42 INFO - Installing collected packages: blobuploader, requests, docopt 19:12:42 INFO - Running setup.py install for blobuploader 19:12:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:12:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:12:42 INFO - Running setup.py install for requests 19:12:42 INFO - Running setup.py install for docopt 19:12:42 INFO - Successfully installed blobuploader requests docopt 19:12:42 INFO - Cleaning up... 19:12:42 INFO - Return code: 0 19:12:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12: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')]} 19:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12: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')]} 19:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:42 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 0x23a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, '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': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', '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 19:12:42 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 19:12:42 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 19:12:42 INFO - Using env: {'DISPLAY': ':0', 19:12:42 INFO - 'HOME': '/home/cltbld', 19:12:42 INFO - 'LANG': 'en_US.UTF-8', 19:12:42 INFO - 'LANGUAGE': 'en_US:en', 19:12:42 INFO - 'LOGNAME': 'cltbld', 19:12:42 INFO - 'MAIL': '/var/mail/cltbld', 19:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:42 INFO - 'MOZ_NO_REMOTE': '1', 19:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:42 INFO - 'NO_EM_RESTART': '1', 19:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:42 INFO - 'PWD': '/builds/slave/test', 19:12:42 INFO - 'SHELL': '/bin/bash', 19:12:42 INFO - 'SHLVL': '1', 19:12:42 INFO - 'TERM': 'linux', 19:12:42 INFO - 'TMOUT': '86400', 19:12:42 INFO - 'USER': 'cltbld', 19:12:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:42 INFO - '_': '/tools/buildbot/bin/python'} 19:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:43 INFO - Running setup.py (path:/tmp/pip-jWkvWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:43 INFO - Running setup.py (path:/tmp/pip-tk9YTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:43 INFO - Running setup.py (path:/tmp/pip-7DQHuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:43 INFO - Running setup.py (path:/tmp/pip-CWrpvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:43 INFO - Running setup.py (path:/tmp/pip-dRPjXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:43 INFO - Running setup.py (path:/tmp/pip-p4YO55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:43 INFO - Running setup.py (path:/tmp/pip-UKxhw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:43 INFO - Running setup.py (path:/tmp/pip-0wYZyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:43 INFO - Running setup.py (path:/tmp/pip-FqSvJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:43 INFO - Running setup.py (path:/tmp/pip-CYQ3jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:43 INFO - Running setup.py (path:/tmp/pip-9rsCmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:43 INFO - Running setup.py (path:/tmp/pip-Lv4Zba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:44 INFO - Running setup.py (path:/tmp/pip-C5056G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:44 INFO - Running setup.py (path:/tmp/pip-83CNKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:44 INFO - Running setup.py (path:/tmp/pip-ORZdh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:44 INFO - Running setup.py (path:/tmp/pip-vXDoHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:44 INFO - Running setup.py (path:/tmp/pip-dfI4uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:12:44 INFO - Running setup.py install for manifestparser 19:12:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:12:44 INFO - Running setup.py install for mozcrash 19:12:44 INFO - Running setup.py install for mozdebug 19:12:44 INFO - Running setup.py install for mozdevice 19:12:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:12:44 INFO - Running setup.py install for mozfile 19:12:44 INFO - Running setup.py install for mozhttpd 19:12:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:12:44 INFO - Running setup.py install for mozinfo 19:12:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Running setup.py install for mozInstall 19:12:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Running setup.py install for mozleak 19:12:45 INFO - Running setup.py install for mozlog 19:12:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Running setup.py install for moznetwork 19:12:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Running setup.py install for mozprocess 19:12:45 INFO - Running setup.py install for mozprofile 19:12:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Running setup.py install for mozrunner 19:12:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:12:45 INFO - Running setup.py install for mozscreenshot 19:12:45 INFO - Running setup.py install for moztest 19:12:46 INFO - Running setup.py install for mozversion 19:12:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:12:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:12:46 INFO - Cleaning up... 19:12:46 INFO - Return code: 0 19:12:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:46 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')]} 19:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:46 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')]} 19:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:46 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 0x23a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, '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': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', '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 19:12:46 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 19:12:46 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 19:12:46 INFO - Using env: {'DISPLAY': ':0', 19:12:46 INFO - 'HOME': '/home/cltbld', 19:12:46 INFO - 'LANG': 'en_US.UTF-8', 19:12:46 INFO - 'LANGUAGE': 'en_US:en', 19:12:46 INFO - 'LOGNAME': 'cltbld', 19:12:46 INFO - 'MAIL': '/var/mail/cltbld', 19:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:46 INFO - 'MOZ_NO_REMOTE': '1', 19:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:46 INFO - 'NO_EM_RESTART': '1', 19:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:46 INFO - 'PWD': '/builds/slave/test', 19:12:46 INFO - 'SHELL': '/bin/bash', 19:12:46 INFO - 'SHLVL': '1', 19:12:46 INFO - 'TERM': 'linux', 19:12:46 INFO - 'TMOUT': '86400', 19:12:46 INFO - 'USER': 'cltbld', 19:12:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:46 INFO - '_': '/tools/buildbot/bin/python'} 19:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:46 INFO - Running setup.py (path:/tmp/pip-INKy2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:46 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)) 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:46 INFO - Running setup.py (path:/tmp/pip-kZ0Etz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:46 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)) 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:46 INFO - Running setup.py (path:/tmp/pip-TUP1Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:46 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)) 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:46 INFO - Running setup.py (path:/tmp/pip-L0g2j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:46 INFO - Running setup.py (path:/tmp/pip-cf7vVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:46 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)) 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:46 INFO - Running setup.py (path:/tmp/pip-BtLaSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:46 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)) 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:46 INFO - Running setup.py (path:/tmp/pip-jP1v2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:46 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)) 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:46 INFO - Running setup.py (path:/tmp/pip-0KoeIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:46 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)) 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:46 INFO - Running setup.py (path:/tmp/pip-UzTmgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:47 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)) 19:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:47 INFO - Running setup.py (path:/tmp/pip-kRbVHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:47 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)) 19:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:47 INFO - Running setup.py (path:/tmp/pip-5t7Pe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:47 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)) 19:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:47 INFO - Running setup.py (path:/tmp/pip-fTVysX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:47 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)) 19:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:47 INFO - Running setup.py (path:/tmp/pip-_bSEtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:47 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)) 19:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:47 INFO - Running setup.py (path:/tmp/pip-8A2tfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:47 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)) 19:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:47 INFO - Running setup.py (path:/tmp/pip-3hWffp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:47 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)) 19:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:47 INFO - Running setup.py (path:/tmp/pip-UOWtGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:47 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)) 19:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:47 INFO - Running setup.py (path:/tmp/pip-5ctoTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:47 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)) 19:12:47 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)) 19:12:47 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)) 19:12:47 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)) 19:12:47 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:12:47 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:12:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:12:47 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 19:12:47 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 19:12:47 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 19:12:47 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 19:12:48 INFO - Downloading blessings-1.6.tar.gz 19:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:12:48 INFO - Installing collected packages: blessings 19:12:48 INFO - Running setup.py install for blessings 19:12:48 INFO - Successfully installed blessings 19:12:48 INFO - Cleaning up... 19:12:48 INFO - Return code: 0 19:12:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:49 INFO - Reading from file tmpfile_stdout 19:12:49 INFO - Current package versions: 19:12:49 INFO - argparse == 1.2.1 19:12:49 INFO - blessings == 1.6 19:12:49 INFO - blobuploader == 1.2.4 19:12:49 INFO - docopt == 0.6.1 19:12:49 INFO - functools32 == 3.2.3-2 19:12:49 INFO - jsonschema == 2.5.1 19:12:49 INFO - manifestparser == 1.1 19:12:49 INFO - mozInstall == 1.12 19:12:49 INFO - mozcrash == 1.0 19:12:49 INFO - mozdebug == 0.1 19:12:49 INFO - mozdevice == 0.51 19:12:49 INFO - mozfile == 1.2 19:12:49 INFO - mozhttpd == 0.7 19:12:49 INFO - mozinfo == 0.9 19:12:49 INFO - mozleak == 0.1 19:12:49 INFO - mozlog == 3.4 19:12:49 INFO - moznetwork == 0.27 19:12:49 INFO - mozprocess == 0.25 19:12:49 INFO - mozprofile == 0.28 19:12:49 INFO - mozrunner == 6.13 19:12:49 INFO - mozscreenshot == 0.1 19:12:49 INFO - mozsystemmonitor == 0.3 19:12:49 INFO - moztest == 0.8 19:12:49 INFO - mozversion == 1.4 19:12:49 INFO - psutil == 3.1.1 19:12:49 INFO - requests == 1.2.3 19:12:49 INFO - wsgiref == 0.1.2 19:12:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:49 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')]} 19:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:49 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')]} 19:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:49 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 0x23a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, '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': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', '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 19:12:49 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 19:12:49 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 19:12:49 INFO - Using env: {'DISPLAY': ':0', 19:12:49 INFO - 'HOME': '/home/cltbld', 19:12:49 INFO - 'LANG': 'en_US.UTF-8', 19:12:49 INFO - 'LANGUAGE': 'en_US:en', 19:12:49 INFO - 'LOGNAME': 'cltbld', 19:12:49 INFO - 'MAIL': '/var/mail/cltbld', 19:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:49 INFO - 'MOZ_NO_REMOTE': '1', 19:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:49 INFO - 'NO_EM_RESTART': '1', 19:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:49 INFO - 'PWD': '/builds/slave/test', 19:12:49 INFO - 'SHELL': '/bin/bash', 19:12:49 INFO - 'SHLVL': '1', 19:12:49 INFO - 'TERM': 'linux', 19:12:49 INFO - 'TMOUT': '86400', 19:12:49 INFO - 'USER': 'cltbld', 19:12:49 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:49 INFO - '_': '/tools/buildbot/bin/python'} 19:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:12:49 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 19:12:49 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 19:12:49 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 19:12:49 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 19:12:50 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:12:50 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)) 19:12:50 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)) 19:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:12:50 INFO - Installing collected packages: marionette-driver 19:12:50 INFO - Running setup.py install for marionette-driver 19:12:50 INFO - Successfully installed marionette-driver 19:12:50 INFO - Cleaning up... 19:12:50 INFO - Return code: 0 19:12:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:12: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')]} 19:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12: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')]} 19:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:50 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 0x23a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, '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': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', '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 19:12:50 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 19:12:50 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 19:12:50 INFO - Using env: {'DISPLAY': ':0', 19:12:50 INFO - 'HOME': '/home/cltbld', 19:12:50 INFO - 'LANG': 'en_US.UTF-8', 19:12:50 INFO - 'LANGUAGE': 'en_US:en', 19:12:50 INFO - 'LOGNAME': 'cltbld', 19:12:50 INFO - 'MAIL': '/var/mail/cltbld', 19:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:50 INFO - 'MOZ_NO_REMOTE': '1', 19:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:50 INFO - 'NO_EM_RESTART': '1', 19:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:50 INFO - 'PWD': '/builds/slave/test', 19:12:50 INFO - 'SHELL': '/bin/bash', 19:12:50 INFO - 'SHLVL': '1', 19:12:50 INFO - 'TERM': 'linux', 19:12:50 INFO - 'TMOUT': '86400', 19:12:50 INFO - 'USER': 'cltbld', 19:12:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:50 INFO - '_': '/tools/buildbot/bin/python'} 19:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:12:50 INFO - Cleaning up... 19:12:50 INFO - Return code: 0 19:12:50 INFO - Running post-action listener: _resource_record_post_action 19:12:50 INFO - Running post-action listener: _start_resource_monitoring 19:12:50 INFO - Starting resource monitoring. 19:12:50 INFO - [mozharness: 2017-05-26 02:12:50.960885Z] Finished create-virtualenv step (success) 19:12:50 INFO - [mozharness: 2017-05-26 02:12:50.961389Z] Running install step. 19:12:50 INFO - Running pre-action listener: _resource_record_pre_action 19:12:50 INFO - Running main action method: install 19:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:51 INFO - Reading from file tmpfile_stdout 19:12:51 INFO - Detecting whether we're running mozinstall >=1.0... 19:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:12:51 INFO - Reading from file tmpfile_stdout 19:12:51 INFO - Output received: 19:12:51 INFO - Usage: mozinstall [options] installer 19:12:51 INFO - Options: 19:12:51 INFO - -h, --help show this help message and exit 19:12:51 INFO - -d DEST, --destination=DEST 19:12:51 INFO - Directory to install application into. [default: 19:12:51 INFO - "/builds/slave/test"] 19:12:51 INFO - --app=APP Application being installed. [default: firefox] 19:12:51 INFO - mkdir: /builds/slave/test/build/application 19:12:51 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'] 19:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:13:07 INFO - Reading from file tmpfile_stdout 19:13:07 INFO - Output received: 19:13:07 INFO - /builds/slave/test/build/application/firefox/firefox 19:13:07 INFO - Running post-action listener: _resource_record_post_action 19:13:07 INFO - [mozharness: 2017-05-26 02:13:07.328512Z] Finished install step (success) 19:13:07 INFO - [mozharness: 2017-05-26 02:13:07.328786Z] Running run-tests step. 19:13:07 INFO - Running pre-action listener: _resource_record_pre_action 19:13:07 INFO - Running main action method: run_tests 19:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:13:07 INFO - Python 2.7.3 19:13:07 INFO - Return code: 0 19:13:07 INFO - grabbing minidump binary from tooltool 19:13: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')]} 19:13:07 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 0x27107a0>, '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 0x27116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:13:07 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 19:13:07 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 19:13:07 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 19:13:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:13:07 INFO - Return code: 0 19:13:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:13:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:13:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:13:07 INFO - ENV: RUST_BACKTRACE is now 1 19:13:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:13:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:13:07 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/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 19:13:07 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/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 19:13:07 INFO - Using env: {'DISPLAY': ':0', 19:13:07 INFO - 'HOME': '/home/cltbld', 19:13:07 INFO - 'LANG': 'en_US.UTF-8', 19:13:07 INFO - 'LANGUAGE': 'en_US:en', 19:13:07 INFO - 'LOGNAME': 'cltbld', 19:13:07 INFO - 'MAIL': '/var/mail/cltbld', 19:13:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:13:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:07 INFO - 'MOZ_NO_REMOTE': '1', 19:13:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:07 INFO - 'NO_EM_RESTART': '1', 19:13:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:07 INFO - 'PWD': '/builds/slave/test', 19:13:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:13:07 INFO - 'RUST_BACKTRACE': '1', 19:13:07 INFO - 'SHELL': '/bin/bash', 19:13:07 INFO - 'SHLVL': '1', 19:13:07 INFO - 'TERM': 'linux', 19:13:07 INFO - 'TMOUT': '86400', 19:13:07 INFO - 'USER': 'cltbld', 19:13:07 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122', 19:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:07 INFO - '_': '/tools/buildbot/bin/python'} 19:13:07 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/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 19:13:07 INFO - mozversion application_buildid: 20170526012945 19:13:07 INFO - mozversion application_changeset: c2ff59dd31bce41bc9108939e86618017943b88d 19:13:07 INFO - mozversion application_display_name: Nightly 19:13:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:13:07 INFO - mozversion application_name: Firefox 19:13:07 INFO - mozversion application_remotingname: firefox 19:13:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:13:07 INFO - mozversion application_vendor: Mozilla 19:13:07 INFO - mozversion application_version: 55.0a1 19:13:07 INFO - mozversion platform_buildid: 20170526012945 19:13:07 INFO - mozversion platform_changeset: c2ff59dd31bce41bc9108939e86618017943b88d 19:13:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:13:07 INFO - mozversion platform_version: 55.0a1 19:13:07 INFO - using testdate: 1495764787 19:13:07 INFO - actual date: 1495764787 19:13:07 INFO - starting webserver on 'localhost:46890' 19:13:07 INFO - SUITE-START | Running 2 tests 19:13:07 INFO - TEST-START | dromaeo_css 19:13:07 INFO - operating with platform_type : linux_ 19:13:07 INFO - Initialising browser for dromaeo_css test... 19:13:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46890/getInfo.html -profile /tmp/tmp7E7p8j/profile 19:13:07 INFO - TEST-INFO | started process 5960 (/builds/slave/test/build/application/firefox/firefox http://localhost:46890/getInfo.html) 19:13:43 INFO - TEST-INFO | 5960: killed by SIGTERM 19:13:43 INFO - Browser initialized. 19:13:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:13:43 INFO - TEST-INFO | started process 6185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7E7p8j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:55 INFO - PID 6185 | RSS: Main: 172564480 19:13:55 INFO - PID 6185 | 19:16:59 INFO - PID 6185 | Cycle 1(1): loaded http://localhost:46890/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46890/tests/dromaeo/cssquery-ext.html) 19:17:01 INFO - PID 6185 | RSS: Main: 172322816 19:17:01 INFO - PID 6185 | 19:20:02 INFO - PID 6185 | Cycle 1(1): loaded http://localhost:46890/tests/dromaeo/cssquery-ext.html (next: http://localhost:46890/tests/dromaeo/cssquery-jquery.html) 19:20:03 INFO - PID 6185 | RSS: Main: 177004544 19:20:03 INFO - PID 6185 | 19:23:05 INFO - PID 6185 | Cycle 1(1): loaded http://localhost:46890/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46890/tests/dromaeo/cssquery-mootools.html) 19:23:05 INFO - PID 6185 | RSS: Main: 174399488 19:23:05 INFO - PID 6185 | 19:26:07 INFO - PID 6185 | Cycle 1(1): loaded http://localhost:46890/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46890/tests/dromaeo/cssquery-prototype.html) 19:26:08 INFO - PID 6185 | RSS: Main: 179175424 19:26:08 INFO - PID 6185 | 19:29:11 INFO - PID 6185 | Cycle 1(1): loaded http://localhost:46890/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46890/tests/dromaeo/cssquery-yui.html) 19:29:12 INFO - PID 6185 | RSS: Main: 177860608 19:29:12 INFO - PID 6185 | 19:32:13 INFO - PID 6185 | Cycle 1(1): loaded http://localhost:46890/tests/dromaeo/cssquery-yui.html (next: http://localhost:46890/tests/dromaeo/cssquery-dojo.html) 19:32:14 INFO - PID 6185 | RSS: Main: 176979968 19:32:14 INFO - PID 6185 | 19:32:14 INFO - PID 6185 | __start_tp_report 19:32:14 INFO - PID 6185 | _x_x_mozilla_page_load 19:32:14 INFO - PID 6185 | _x_x_mozilla_page_load_details 19:32:14 INFO - PID 6185 | |i|pagename|runs| 19:32:14 INFO - PID 6185 | |0;dojo.html;2726.7273272672746;2739.9452010959776;2756.9862150689255;2767.584862270658;2777.805553611247;5106.463821298766;5124.8975020499665;5156.329677141966;5169.896602067956;5175;5164.793408263665;5179.404368497624;5212.087884620186;5281.6830990140525;5317.12267475867;4584.174848527264;4590.885227869297;4620.907581848361;4634.791434385461;4652.139354219464;4634.420697412824;4642.442906851183;4646.953530464702;4699.201135806921;4706.199946009169;4546.54534546546;4595.9310610340535;4610.838620648295;4672.6261899047995;4702.8118875244945;4648.976755116237;4699.5535424135;4700.482946875841;4712.764361781931;4715.056988602259;4627.8148874045;4644.373009643722;4645.953540464586;4646.79089440976;4680.953190468086;5177.145770947789;5220.791168353299;5229.529342359206;5231.136862417697;5261.86845328866;5509.283793106911;5586;5593.077142271521;5600.0759874620635;5687.090065589486;5707.971460142673;5710.428957104298;5728.513076388512;5774.595778295521;5775;5292.867678308073;5294.947050529484;5299.49654782795;5300.1519756838725;5308.0710875596615;5514;5582.720863956786;5810.622309549865;5830.562707796932;5864.9413505864395;5478.123500239943;5483.177523371526;5569.275994120739;5608.663480191201;5617.859553511195;5496.0931446310915;5498.1752737089755;5546.27898373217;5555.194496797942;5568.693721845257;5461.344638643309;5468.425815289417;5524.502794748492;5568.359638641527;5578.888422231533;5537.197106419547;5553.16702494629;5578.804741834017;5623.5220006299105;5637.408072152447;4703.482616912137;4710.62315014798;4711.387519622495;4725.621950244041;4768.642351823558;4063.6545893599377;4068.105016896278;4071.755694658271;4088.1823635273063;4124.216398884202;4715.646326525524;4774.21225497789;4796.208625576741;4834;4855.781489832966;5676.148577713376;5690.4025077367105;5695.40198279183;5711.800086997018;5748.540116790647;4809.9038019239415;4817.397825271841;4831.9275210871865;4835.6131509479155;4873.731944743073;4932.358793356841;4989.925151122736;5002.799888004512;5023;5043.36957880265;5267.631265811357;5275.182346736262;5283.788648454019;5312.495312945264;5325.9467405327005;5474.5894057945015;5552.805651802168;5672.971635141798;5674.914876276942;5682.829515114553;5125.538701516882;5191.428942816363;5283.418823929442;5290.735463226746;5307.41618421981;5425.43032981547;5613.270274864241;5613.635113717595;5616.354119276336;5656.406077361818;5565.248691426767;5597.216389705363;5608.327000759935;5619.8198378341;5647.971760141173;5513.338399392099;5521.950829342412;5522.558195344443;5531.7234138292115;5533.695646739468;5492.395836457907;5492.560595152298;5500.147477141049;5515.531179849758;5553.527950124123;5241.842744717665;5304.602154838325;5330.9466905332;5371.5971302153275;5416.997855396764;5568.220449137205;5570.442955704397;5583.190437386637;5587.7485513152815;5630.127330263816;5421.7560209791445;5423.538999185113;5427.050266203478;5430.782768689208;5436.891262174813 19:32:14 INFO - PID 6185 | |1;ext.html;706.798562409713;740.9036825212721;755.9017327747392;1040.2042437535288;1043.2697112021588;32774.83612581937;33506.832465837695;33537.83231083844;33566.49650255248;33600.49599256013;35082.8245858771;35345.64654353456;35465.822670886606;35496;35565.11087222821;6627.801165965005;6800.591964482147;6866.759663411782;6985.685644146026;7002.789916302494;6757.222919364287;6844.247132815386;6854.074699915497;6855.314468553154;6859.9314006859795;6819.24988251292;6827.624480653562;6833.9316606834045;6838.555493892881;6888.4144847688;6836.418904393133;6877.1747390312985;6879.862402751942;6881.073299476129;6881.277465866112;6720.596764194115;6753.3921947025;6756.290589488082;6759.425448836855;6776.593404395752;31469.685303146904;31661.683383166335;31758.206044848834;31869.20326991844;31937.84031079853;3008.443437963962;3022.199117233935;3033.726964573177;3046.3450358172877;3047.588575542318;24246.757532424628;24294.635580466307;24419.755802441927;24436.022559097793;24484.51030979388;2691.7981151413724;2697;2700.176446183913;2702.6756789185424;2716.361655011071;141883;143078;144797;148872;149145;39942.60057399447;40139;40149.799251003555;40178.584820290016;40220.79889600533;41932.58067419287;41976.370354444094;42013;42050.57949420466;42279.365809512885;12534.373281335897;12614.432350544248;12712.173708708904;12714.682132946751;12738.617841464771;10189.54147063384;10317.123044541147;10356.067953884187;10402.375857448576;10481.423521706227;12676.746465070832;12714.745705085847;12823.61529154127;12842.743145137045;12944.741105177844;5326.387465441447;5371.919421208685;5483.396826349099;5488.56091512678;5499.202615620713;840.7057529864621;886.1802832380023;895.359817730326;906.5421961909194;908.100980029779;20327.796722032886;20422.183112675622;21637.675434868488;21701.565968680537;21926.45183870416;971.2230215827451;974.8976357482504;981.5190556627201;989.8911119776819;1000.4147573669339;10988.505517251742;11305.830412543819;11374.658760237206;11439.942800285946;11556.537738490366;173589;174527;175123;175462;175534;41251.58748412477;41445.585544144174;41515.169696605895;41547.376789348185;41628.37557436641;1187.944562587086;1224.3633310678397;1227.1716591300835;1228.815677648342;1232.3160645841465;19757.506062348555;19761.703574446106;20431.4892127698;21210.893945530173;21428;29697.554536681535;29708.55437168401;29721.81112755552;29762.702372975993;29784;147077;147359;147411;147732;147972;29397.002509572998;29630.703692963656;30275.243118922204;30729.385412292075;30772.846135769178;35886.28227435384;35952.64047359597;36028.27943441169;36063.0984225386;36080;25855.482890342464;27278.590821137303;27669.30826729348;28112.43775124527;28795.856020719762;27019.86490067616;27668.446631066865;27913.720862791113;28625.856870715514;28766.137015889555;29696.703032969395;30142.397152057274;30592.84703576468;30759.69240307568;31026;26469.867650662392;26848.59727104134;27058.864705677133;27392.17823465299;28291.2927176814;19993.600127997066;22041.559168816853;22127.889360553738;22155.446113847283;22257.666135008312 19:32:14 INFO - PID 6185 | |2;jquery.html;403.40900580649344;406.16127696307126;422.81818817908305;429.82806877249095;434.63056402058254;12091.455884485198;17408.73886891696;17430.215640296185;18065.36771213008;18167.727484087733;18101.09494525275;18185.181666825025;18302.816971830278;18343.357982470618;18493.999999999967;5170.353705786777;5433.293671822657;5652.349979752319;5669.234653321811;5681.488666020057;5278.102722537178;5341.172118321666;5343.332083489564;5344.839654810343;5350.973245133789;5222.216667499867;5327.121025030865;5329.280547126127;5336.706481143536;5343.519083282504;5418.566514678816;5479.945200547983;5500.972495137498;5509.696966666852;5521.2270282160525;4916.06594746997;4919.778609962525;4952.158133117378;4973.254011898208;4991.725455099968;20689.379318620464;21261.893690531604;21432.357029289145;21460.141594336365;21555.46111347213;1611.2749262831655;1614.3784642912447;1665.3338664534162;1667.908265045422;1668.7747154134158;14277.571672849832;14355.354009069513;14498.42006319746;14742.778858317133;14898.776518352233;2026.695995600657;2042.244369583249;2063.2366024570856;2072.1504183284783;2091.3725882235267;86293.56853215756;88473.11526884713;90717.54641226817;91715.54142229313;93475.53262233714;10613.363198208132;10756.569737210424;10854;10979.121670266359;11013.174011949135;15128.621784455476;15148.924255378874;15156.469523566622;15160.772588411182;32350;8603.870941935877;9010.459372437545;9018.233450156678;9226.76933076665;9266.907330926739;7015.263397343308;7059.89410158848;7100.289971002859;7252.347288744038;7274.054372931485;8876.20114189726;8997.685081022133;9097.636094556276;9195.586198620944;9509.762255943519;3779.6214417009846;3945.3292940200236;4079.755214687128;4179.185058913544;4223.619874211336;841.4614646626164;866.2501746472091;871.329076611006;871.6208449324438;901.7655409593552;16425.91787041081;16572.419965301397;16623.750643740354;17159.142042898056;17344.47966561005;869.6608322754131;871.0984131423946;888.8755574219614;898.6360523987795;905.6105874473908;8930.821383572293;9171.862422063674;9311.534423278808;9358.473212232659;9439.716808495756;346038;347686;349155;364612;375411;73384.26615733882;74141.6292918532;75058.62470687611;76320.61839690767;76519;1065.3448129400517;1080.0765345629375;1106.2145876427664;1107.5846557540922;1115.1246271676857;16630;16910.239039243508;17387;17457.30170793154;17550;37710.62289377071;37906.24187516179;38740.806295969465;38967.2206555873;39711;45738.54261457476;45895.54104459046;46755.29867051929;47594.286085709435;47766.283505748135;8127.024757029194;8353.24820766134;8353.498790072616;8364.581770911309;8382;12084.006138986968;12491.687707807014;12851.421686024338;13134.080614356903;13227.272500012592;9495.85756213671;10101.393916365041;10176.287659863738;10611.045005949502;11160.051395631137;9234.445933244027;9383.436993780395;9465.195458386115;9586.137247647745;9998.550065246936;9743.415395076318;9799.167070798776;10060.39637621745;10362.326448780805;10568.630097946534;7774.572398518136;7788.766337009899;7793.805154871174;7903.881441778263;7906.683732650859;9398.67104651334;9497.335186536877;9575.712728618153;9610.327277090537;9752.658656946973 19:32:14 INFO - PID 6185 | |3;mootools.html;1236.9319687417192;1297.5004623220057;1302.1405872124387;1302.322792148083;1304.6738315421144;9990.100890919815;10320.535575899085;10441.530131144089;10465.162786977042;10627.893721062786;10401.531931063102;10614.469276536181;10618.203634727408;10618.681439556807;10618.78762424751;2100.527381339202;2135.6049130910756;2135.903884325209;2136.380449669594;2139.0801955159277;2068.603692507559;2110.841686873483;2111.050027487629;2113.3448630924463;2117.491801967532;2062.783407742188;2082.1671331467383;2090.9268175613856;2092.4978005278776;2096.7379077615296;2022.5145964968376;2030.949226269355;2031.8171364577186;2033.5460145995537;2035.5216524116895;1975.9703604445945;2022.3326302320347;2055.640262953992;2073.9792602073935;2081.08432289792;10052.296339256254;10156.593736250541;10160.644377446828;10164.847527287096;10175.236857235663;5246.7638956247065;5454.372747134091;5467.863303417406;5471.2887324647545;5480.835574932758;3207.5028370602595;3285.983570082158;3329.250918543333;3331.6335203127637;3341.2816244507303;1030.7320096774893;1052.6210564196883;1057.735566108473;1063.7925604507125;1078.8543546621183;15225.695486090326;15436.151011694352;15703.842961570466;15707.057576545443;15982.44061457855;5062.088824011639;5105.693658380509;5135.537801597874;5154.149565321755;5213.296205012351;12676.366181690879;12779.61661150167;12822.80765788514;12827.679308017188;12831.663767420352;5579.358373786985;5668.348139963874;5672;5676.545876329884;5690.715464226772;5061.7469126544265;5114.3862736471865;5116.437191908887;5146.253793199965;5178.223266510054;4239.745615263094;4372.4315838941375;4377.715448495837;4389.780510974502;4411.691181617256;1293.127139181049;1322.385090932721;1336.6791969927147;1355.1868878672717;1364.3928451838835;689.4518857508293;707.3563057617646;715.4812760748416;728.3954317916117;729.0267492897042;5281.313429254173;5332.92000619991;5411.56707463402;5412.07994640912;5487.75305111271;558.3857756467934;561.738791461964;568.8577855536116;571.1404336473664;571.7798647520734;3467.5665541807275;3638.381475149231;3757.49273848027;3819.331616967075;3841.157543417851;12978.480860765652;13279;13288.534901278603;13293.93353033248;13456.394462249222;13197.20816750998;13203.66990825237;13576.728465430833;13692.863071369158;13818.309084545732;7286.380657644054;7482.139553951365;7665.3101220890385;7669.348105411103;7785.104712958082;6382.776602818879;6517.152770139852;6584.209894812461;6686.966565167338;6876.724931002704;11894.286342819458;12202.14584979043;12369.567065152676;12396.194247373893;12490.06324525646;12470.688232794253;12674.683132921751;12698.619041428772;12789.232646041268;12848.614541563767;7951.840963180588;8155.266026057446;8157.79605509867;8164.224398682116;8183.099859015384;9081.228095611683;9395.15443610051;9425.680404743205;9435.150836424755;9468.242540596599;7697.538147710931;7814.296713295831;7848.646810893638;7875.803104922423;7972.760817175494;7959.602019899097;7963.084245311863;7972.521648701097;8021.398395120273;8158.224968627971;7099.538529995534;7189.245129261352;7216.097987751531;7226.927730722626;7240;5060.595152387727;5146.639735218649;5239.921401178909;5348.3954813555;5366.248725178556;4560.6807523473035;5298.489930369826;5300.416954135119;5371;5420.457954204548 19:32:14 INFO - PID 6185 | |4;prototype.html;393.15667892370845;394.77497826239045;399.14651633790476;399.7082130045069;403.75976294105016;5523.033469142904;5528.198411230369;5535.280413546238;5554.1391084381885;5582.413846546115;5083.6441449098575;5320.654157479761;5381.865453363668;5395.10980688186;5398.811041613544;4281.464816897896;4319.308910574308;4320.5031421386475;4328.437303150602;4343.109662519176;4297.634701050399;4306.483222013347;4309.547497512763;4322;4352.12957408518;4223.02870339822;4279.593438623326;4287.957120428802;4320.222359975203;4335.479742430897;4294.196437496244;4296.548862369437;4307.569243075683;4321.438213032286;4322.783860806947;3913.7847418391975;3921.7450865693922;3928.3714605663245;3930.21395720857;3931.410288456726;5182.170852663556;5286.414075777251;5290.470952904717;5300.3639563252655;5310.62825602208;5105.412877519096;5117.8464646060675;5128.461511541309;5131.84604461863;5141.203113517374;5715.257016587859;5742.626729262584;5742.856428589277;5748.844183431213;5793.391693872167;4200.327947528381;4387.62705170061;4435.556444355571;4436.955630443719;4483.439570053743;5834.920539700127;6041.72812223451;6046.395360463918;6088.208532890741;6120.908186377208;4326.41593384889;4331.740095594211;4348.586884245991;4356.671215279307;4356.673249506236;4381.9342709859375;4404.11917616478;4415.896025993502;4488.371627972087;4636.884077898012;5030.647854650139;5112.182050871843;5114.130597798383;5134;5152.355955505562;5773.35459394079;5782.59521833476;5790.623609465456;5791.420857914175;5810.941890581124;1604.6951079294897;1606.8955517891534;1622.853943145099;1624.7725318455425;1634.4687976407715;1147.8278258261328;1173.6537721372215;1187.4062968515743;1197.9640610781692;1201.2492192379764;4949.925751113664;4980.352554167935;4989.90020199594;4990.700557966534;4993.975030124899;5890.911636325459;5901.734421951022;5906;5917.615355001911;5939.227900372924;4784;4965.1311020571975;4990.650654454226;4999.950000500021;5025.623078269145;3168.1604374840686;3172.365526894584;3187.330660561308;3194.1375828526634;3200.9359812804078;5414.187871819258;5546.334439867242;5552.444755524496;5565.721713914288;5567.944320556742;6014.398560143951;6062.514998800086;6084.969575152184;6091.48222401092;6124.846878827976;5522.502974732213;5530.806421775299;5540.030494663499;5544.916826247529;5563.193336966117;5863.648181109147;5884.911726324194;5914.290285165807;5928.911066334094;5957.791477298447;5658.1709145427285;5814.215080964016;5833.3833023525685;5835.183074369506;5865.120231965239;5521.889562208814;5523;5536;5539.861503462445;5560.527355174693;4080.7557991396316;4093.488313960755;4107.815148318393;4129.690273229459;4152.439420678291;5898.528117750484;5921.970390148022;5925.466707996128;5953.732082056405;5957.821265362046;5717.914231286617;5727.11229759388;5801.622894511843;5811.360750317546;5815.331236907809;5553.16702494629;5734.817176467101;5741.1388291756575;5759.510441612342;5775.682337471311;5634.971825140848;5638.746256418389;5648.943510564842;5657.462541058593;5659.886802264014;5707.68607726579;5853.473187413153;5865.765369385177;5883.529317654663;5893.528517718658;5644.294463192101;5682.346530149086;5693.459121383462;5695.345035320825;5712.571557133148 19:32:14 INFO - PID 6185 | |5;yui.html;670.9228438729546;693.237438817301;700.215758350647;719.7336985315434;750.3996802557956;11524.71188220295;12013.399330033486;12856;13382.799258011126;13437.32813359333;14718.705625887476;15486;15578.376864925418;15581.298841552129;15608.843911560882;875.0986483921571;897.9146981036791;905.714699869539;906.2749800159879;908.5094049213417;906.3610154840821;906.863970404438;906.9682561110362;911.6581282019242;916.2486760856101;953.4755884263627;953.918916892065;954.5227386306847;954.5847556312991;954.5847556312991;945;949.8052899155691;954.8472244440856;956.3926906414476;959.6881013670585;680.2177495879729;680.2687111355312;690.86182763447;690.989635155473;692.3906961873519;14654.560363189015;14837.183954882477;14878.776818347733;14928.70142597142;14970.62573435662;15607.687846243012;16379.91810040954;16562.83437165637;16569.91715041429;16574.917125414417;12527.749445011048;12810.935945320307;13008.934955325258;13076.411561479756;13092.934535327262;2917.6061231733656;2949.690282520326;2950.100219433072;2950.129711735043;2951.144168191222;78781;79104;80879;81164;81358.59320703418;10433.895661043443;10606.15150787935;10619.681409557727;10630.840537391945;10664.840027399596;17767.20047597861;17929.641407172043;18149.909250453926;18305.35931242427;18523.66574016663;5875.50058245054;5909.734061967136;5929.0513517836935;5939.821805345847;5949.286085669661;2825.50553653114;2901.405211931549;2901.608282881826;2904.390078083626;2905.622269105003;3542.6634469725336;3608.963910360863;4221.598948099926;4360.280553708666;4387.473503179639;715.4348065028569;754.1252147508864;755.0222461911837;756.3042001358763;769.2346115615;607.471499795181;623.432676264597;624.5846512069513;626.5457543281176;641.3041849593151;9536.380135291183;9819.75450613726;9862.852057219148;10052.547635356426;10966.890331096587;559.2087196616742;573.5784198614016;574.7643466178847;581.2240658720656;595.9582829201914;4611.5619016193405;4639.257718765049;4668.5798278155125;4681;4803.759812009385;83940.16059839324;84866.57566712251;86324.56837715897;88468.55765721259;89864;75073.62463187758;75648.62175689086;77170.61414693003;77821.2217877814;79447;66021.99999999904;66577.66711166414;66676;66694.66652666802;67603.66198168977;8999.730008099506;9301.976782553778;9374.765630859283;9452.810943780949;9614.71155865325;28677.85661071681;28829.711702883542;29167.562486563143;29572;30205.244868878453;36224.456633149995;36369.81815090908;36536.26927461383;37048;37142.62857371392;12519.874801252236;12766.872331276569;13176.670583235496;13187.340632968506;13202.933985330012;14065.367058482598;14132.717345653235;14356.282185890455;14388.568342949728;14565.708685826012;12729.618111456672;12894.613161605166;13251.349730053835;15089.54731358061;15313.540593782205;15079.849201507845;15320.846791532387;15528.689426211638;15656.843431565538;15802.525924222291;14999.925000374928;15200.923995380395;15282.388704452142;15397.07617542951;15602.375904963674;10188.847167292644;10381.169506439617;10483.580656773644;10581.624388829403;10655;11530.538778449103;11595.246308989888;12048.698782530157;12295.32375719344;12361.93819030899 19:32:14 INFO - PID 6185 | __end_tp_report 19:32:14 INFO - PID 6185 | __start_cc_report 19:32:14 INFO - PID 6185 | _x_x_mozilla_cycle_collect,333 19:32:14 INFO - PID 6185 | __end_cc_report 19:32:14 INFO - PID 6185 | __startTimestamp1495765934108__endTimestamp 19:32:14 INFO - PID 6185 | 19:32:14 INFO - PID 6185 | ------- Summary: start ------- 19:32:14 INFO - PID 6185 | Number of tests: 6 19:32:14 INFO - PID 6185 | 19:32:14 INFO - PID 6185 | [#0] dojo.html Cycles:165 Average:5151.92 Median:5307.42 stddev:597.17 (11.3%) stddev-sans-first:567.89 19:32:14 INFO - PID 6185 | Values: 2726.7 2739.9 2757.0 2767.6 2777.8 5106.5 5124.9 5156.3 5169.9 5175.0 5164.8 5179.4 5212.1 5281.7 5317.1 4584.2 4590.9 4620.9 4634.8 4652.1 4634.4 4642.4 4647.0 4699.2 4706.2 4546.5 4595.9 4610.8 4672.6 4702.8 4649.0 4699.6 4700.5 4712.8 4715.1 4627.8 4644.4 4646.0 4646.8 4681.0 5177.1 5220.8 5229.5 5231.1 5261.9 5509.3 5586.0 5593.1 5600.1 5687.1 5708.0 5710.4 5728.5 5774.6 5775.0 5292.9 5294.9 5299.5 5300.2 5308.1 5514.0 5582.7 5810.6 5830.6 5864.9 5478.1 5483.2 5569.3 5608.7 5617.9 5496.1 5498.2 5546.3 5555.2 5568.7 5461.3 5468.4 5524.5 5568.4 5578.9 5537.2 5553.2 5578.8 5623.5 5637.4 4703.5 4710.6 4711.4 4725.6 4768.6 4063.7 4068.1 4071.8 4088.2 4124.2 4715.6 4774.2 4796.2 4834.0 4855.8 5676.1 5690.4 5695.4 5711.8 5748.5 4809.9 4817.4 4831.9 4835.6 4873.7 4932.4 4989.9 5002.8 5023.0 5043.4 5267.6 5275.2 5283.8 5312.5 5325.9 5474.6 5552.8 5673.0 5674.9 5682.8 5125.5 5191.4 5283.4 5290.7 5307.4 5425.4 5613.3 5613.6 5616.4 5656.4 5565.2 5597.2 5608.3 5619.8 5648.0 5513.3 5522.0 5522.6 5531.7 5533.7 5492.4 5492.6 5500.1 5515.5 5553.5 5241.8 5304.6 5330.9 5371.6 5417.0 5568.2 5570.4 5583.2 5587.7 5630.1 5421.8 5423.5 5427.1 5430.8 5436.9 19:32:14 INFO - PID 6185 | 19:32:14 INFO - PID 6185 | [#1] ext.html Cycles:180 Average:30150.55 Median:16396.22 stddev:40374.64 (246.2%) stddev-sans-first:40427.37 19:32:14 INFO - PID 6185 | Values: 706.8 740.9 755.9 1040.2 1043.3 32774.8 33506.8 33537.8 33566.5 33600.5 35082.8 35345.6 35465.8 35496.0 35565.1 6627.8 6800.6 6866.8 6985.7 7002.8 6757.2 6844.2 6854.1 6855.3 6859.9 6819.2 6827.6 6833.9 6838.6 6888.4 6836.4 6877.2 6879.9 6881.1 6881.3 6720.6 6753.4 6756.3 6759.4 6776.6 31469.7 31661.7 31758.2 31869.2 31937.8 3008.4 3022.2 3033.7 3046.3 3047.6 24246.8 24294.6 24419.8 24436.0 24484.5 2691.8 2697.0 2700.2 2702.7 2716.4 141883.0 143078.0 144797.0 148872.0 149145.0 39942.6 40139.0 40149.8 40178.6 40220.8 41932.6 41976.4 42013.0 42050.6 42279.4 12534.4 12614.4 12712.2 12714.7 12738.6 10189.5 10317.1 10356.1 10402.4 10481.4 12676.7 12714.7 12823.6 12842.7 12944.7 5326.4 5371.9 5483.4 5488.6 5499.2 840.7 886.2 895.4 906.5 908.1 20327.8 20422.2 21637.7 21701.6 21926.5 971.2 974.9 981.5 989.9 1000.4 10988.5 11305.8 11374.7 11439.9 11556.5 173589.0 174527.0 175123.0 175462.0 175534.0 41251.6 41445.6 41515.2 41547.4 41628.4 1187.9 1224.4 1227.2 1228.8 1232.3 19757.5 19761.7 20431.5 21210.9 21428.0 29697.6 29708.6 29721.8 29762.7 29784.0 147077.0 147359.0 147411.0 147732.0 147972.0 29397.0 29630.7 30275.2 30729.4 30772.8 35886.3 35952.6 36028.3 36063.1 36080.0 25855.5 27278.6 27669.3 28112.4 28795.9 27019.9 27668.4 27913.7 28625.9 28766.1 29696.7 30142.4 30592.8 30759.7 31026.0 26469.9 26848.6 27058.9 27392.2 28291.3 19993.6 22041.6 22127.9 22155.4 22257.7 19:32:14 INFO - PID 6185 | 19:32:14 INFO - PID 6185 | [#2] jquery.html Cycles:180 Average:24498.34 Median:47680.28 stddev:59478.21 (124.7%) stddev-sans-first:59617.55 19:32:14 INFO - PID 6185 | Values: 403.4 406.2 422.8 429.8 434.6 12091.5 17408.7 17430.2 18065.4 18167.7 18101.1 18185.2 18302.8 18343.4 18494.0 5170.4 5433.3 5652.3 5669.2 5681.5 5278.1 5341.2 5343.3 5344.8 5351.0 5222.2 5327.1 5329.3 5336.7 5343.5 5418.6 5479.9 5501.0 5509.7 5521.2 4916.1 4919.8 4952.2 4973.3 4991.7 20689.4 21261.9 21432.4 21460.1 21555.5 1611.3 1614.4 1665.3 1667.9 1668.8 14277.6 14355.4 14498.4 14742.8 14898.8 2026.7 2042.2 2063.2 2072.2 2091.4 86293.6 88473.1 90717.5 91715.5 93475.5 10613.4 10756.6 10854.0 10979.1 11013.2 15128.6 15148.9 15156.5 15160.8 32350.0 8603.9 9010.5 9018.2 9226.8 9266.9 7015.3 7059.9 7100.3 7252.3 7274.1 8876.2 8997.7 9097.6 9195.6 9509.8 3779.6 3945.3 4079.8 4179.2 4223.6 841.5 866.3 871.3 871.6 901.8 16425.9 16572.4 16623.8 17159.1 17344.5 869.7 871.1 888.9 898.6 905.6 8930.8 9171.9 9311.5 9358.5 9439.7 346038.0 347686.0 349155.0 364612.0 375411.0 73384.3 74141.6 75058.6 76320.6 76519.0 1065.3 1080.1 1106.2 1107.6 1115.1 16630.0 16910.2 17387.0 17457.3 17550.0 37710.6 37906.2 38740.8 38967.2 39711.0 45738.5 45895.5 46755.3 47594.3 47766.3 8127.0 8353.2 8353.5 8364.6 8382.0 12084.0 12491.7 12851.4 13134.1 13227.3 9495.9 10101.4 10176.3 10611.0 11160.1 9234.4 9383.4 9465.2 9586.1 9998.6 9743.4 9799.2 10060.4 10362.3 10568.6 7774.6 7788.8 7793.8 7903.9 7906.7 9398.7 9497.3 9575.7 9610.3 9752.7 19:32:14 INFO - PID 6185 | 19:32:14 INFO - PID 6185 | [#3] mootools.html Cycles:180 Average:6383.07 Median:3697.94 stddev:4205.29 (113.7%) stddev-sans-first:4199.31 19:32:14 INFO - PID 6185 | Values: 1236.9 1297.5 1302.1 1302.3 1304.7 9990.1 10320.5 10441.5 10465.2 10627.9 10401.5 10614.5 10618.2 10618.7 10618.8 2100.5 2135.6 2135.9 2136.4 2139.1 2068.6 2110.8 2111.1 2113.3 2117.5 2062.8 2082.2 2090.9 2092.5 2096.7 2022.5 2030.9 2031.8 2033.5 2035.5 1976.0 2022.3 2055.6 2074.0 2081.1 10052.3 10156.6 10160.6 10164.8 10175.2 5246.8 5454.4 5467.9 5471.3 5480.8 3207.5 3286.0 3329.3 3331.6 3341.3 1030.7 1052.6 1057.7 1063.8 1078.9 15225.7 15436.2 15703.8 15707.1 15982.4 5062.1 5105.7 5135.5 5154.1 5213.3 12676.4 12779.6 12822.8 12827.7 12831.7 5579.4 5668.3 5672.0 5676.5 5690.7 5061.7 5114.4 5116.4 5146.3 5178.2 4239.7 4372.4 4377.7 4389.8 4411.7 1293.1 1322.4 1336.7 1355.2 1364.4 689.5 707.4 715.5 728.4 729.0 5281.3 5332.9 5411.6 5412.1 5487.8 558.4 561.7 568.9 571.1 571.8 3467.6 3638.4 3757.5 3819.3 3841.2 12978.5 13279.0 13288.5 13293.9 13456.4 13197.2 13203.7 13576.7 13692.9 13818.3 7286.4 7482.1 7665.3 7669.3 7785.1 6382.8 6517.2 6584.2 6687.0 6876.7 11894.3 12202.1 12369.6 12396.2 12490.1 12470.7 12674.7 12698.6 12789.2 12848.6 7951.8 8155.3 8157.8 8164.2 8183.1 9081.2 9395.2 9425.7 9435.2 9468.2 7697.5 7814.3 7848.6 7875.8 7972.8 7959.6 7963.1 7972.5 8021.4 8158.2 7099.5 7189.2 7216.1 7226.9 7240.0 5060.6 5146.6 5239.9 5348.4 5366.2 4560.7 5298.5 5300.4 5371.0 5420.5 19:32:14 INFO - PID 6185 | 19:32:14 INFO - PID 6185 | [#4] prototype.html Cycles:180 Average:4822.71 Median:5315.64 stddev:1347.61 (25.4%) stddev-sans-first:1309.74 19:32:14 INFO - PID 6185 | Values: 393.2 394.8 399.1 399.7 403.8 5523.0 5528.2 5535.3 5554.1 5582.4 5083.6 5320.7 5381.9 5395.1 5398.8 4281.5 4319.3 4320.5 4328.4 4343.1 4297.6 4306.5 4309.5 4322.0 4352.1 4223.0 4279.6 4288.0 4320.2 4335.5 4294.2 4296.5 4307.6 4321.4 4322.8 3913.8 3921.7 3928.4 3930.2 3931.4 5182.2 5286.4 5290.5 5300.4 5310.6 5105.4 5117.8 5128.5 5131.8 5141.2 5715.3 5742.6 5742.9 5748.8 5793.4 4200.3 4387.6 4435.6 4437.0 4483.4 5834.9 6041.7 6046.4 6088.2 6120.9 4326.4 4331.7 4348.6 4356.7 4356.7 4381.9 4404.1 4415.9 4488.4 4636.9 5030.6 5112.2 5114.1 5134.0 5152.4 5773.4 5782.6 5790.6 5791.4 5810.9 1604.7 1606.9 1622.9 1624.8 1634.5 1147.8 1173.7 1187.4 1198.0 1201.2 4949.9 4980.4 4989.9 4990.7 4994.0 5890.9 5901.7 5906.0 5917.6 5939.2 4784.0 4965.1 4990.7 5000.0 5025.6 3168.2 3172.4 3187.3 3194.1 3200.9 5414.2 5546.3 5552.4 5565.7 5567.9 6014.4 6062.5 6085.0 6091.5 6124.8 5522.5 5530.8 5540.0 5544.9 5563.2 5863.6 5884.9 5914.3 5928.9 5957.8 5658.2 5814.2 5833.4 5835.2 5865.1 5521.9 5523.0 5536.0 5539.9 5560.5 4080.8 4093.5 4107.8 4129.7 4152.4 5898.5 5922.0 5925.5 5953.7 5957.8 5717.9 5727.1 5801.6 5811.4 5815.3 5553.2 5734.8 5741.1 5759.5 5775.7 5635.0 5638.7 5648.9 5657.5 5659.9 5707.7 5853.5 5865.8 5883.5 5893.5 5644.3 5682.3 5693.5 5695.3 5712.6 19:32:14 INFO - PID 6185 | 19:32:14 INFO - PID 6185 | [#5] yui.html Cycles:180 Average:17187.60 Median:36453.04 stddev:23030.39 (63.2%) stddev-sans-first:23061.60 19:32:14 INFO - PID 6185 | Values: 670.9 693.2 700.2 719.7 750.4 11524.7 12013.4 12856.0 13382.8 13437.3 14718.7 15486.0 15578.4 15581.3 15608.8 875.1 897.9 905.7 906.3 908.5 906.4 906.9 907.0 911.7 916.2 953.5 953.9 954.5 954.6 954.6 945.0 949.8 954.8 956.4 959.7 680.2 680.3 690.9 691.0 692.4 14654.6 14837.2 14878.8 14928.7 14970.6 15607.7 16379.9 16562.8 16569.9 16574.9 12527.7 12810.9 13008.9 13076.4 13092.9 2917.6 2949.7 2950.1 2950.1 2951.1 78781.0 79104.0 80879.0 81164.0 81358.6 10433.9 10606.2 10619.7 10630.8 10664.8 17767.2 17929.6 18149.9 18305.4 18523.7 5875.5 5909.7 5929.1 5939.8 5949.3 2825.5 2901.4 2901.6 2904.4 2905.6 3542.7 3609.0 4221.6 4360.3 4387.5 715.4 754.1 755.0 756.3 769.2 607.5 623.4 624.6 626.5 641.3 9536.4 9819.8 9862.9 10052.5 10966.9 559.2 573.6 574.8 581.2 596.0 4611.6 4639.3 4668.6 4681.0 4803.8 83940.2 84866.6 86324.6 88468.6 89864.0 75073.6 75648.6 77170.6 77821.2 79447.0 66022.0 66577.7 66676.0 66694.7 67603.7 8999.7 9302.0 9374.8 9452.8 9614.7 28677.9 28829.7 29167.6 29572.0 30205.2 36224.5 36369.8 36536.3 37048.0 37142.6 12519.9 12766.9 13176.7 13187.3 13202.9 14065.4 14132.7 14356.3 14388.6 14565.7 12729.6 12894.6 13251.3 15089.5 15313.5 15079.8 15320.8 15528.7 15656.8 15802.5 14999.9 15200.9 15282.4 15397.1 15602.4 10188.8 10381.2 10483.6 10581.6 10655.0 11530.5 11595.2 12048.7 12295.3 12361.9 19:32:14 INFO - PID 6185 | -------- Summary: end -------- 19:32:14 INFO - PID 6185 | 19:32:14 INFO - TEST-INFO | 6185: exit 0 19:32:14 INFO - TEST-OK | dromaeo_css | took 1147307ms 19:32:14 INFO - TEST-START | kraken 19:32:14 INFO - operating with platform_type : linux_ 19:32:14 INFO - Initialising browser for kraken test... 19:32:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46890/getInfo.html -profile /tmp/tmpd_XjSE/profile 19:32:14 INFO - TEST-INFO | started process 6612 (/builds/slave/test/build/application/firefox/firefox http://localhost:46890/getInfo.html) 19:32:50 INFO - TEST-INFO | 6612: killed by SIGTERM 19:32:50 INFO - Browser initialized. 19:32:50 INFO - Running cycle 1/1 for kraken test... 19:32:50 INFO - TEST-INFO | started process 6833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd_XjSE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:33:02 INFO - PID 6833 | RSS: Main: 172437504 19:33:02 INFO - PID 6833 | 19:33:04 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46890/tests/kraken/driver.html?testName=audio-beat-detection) 19:33:06 INFO - PID 6833 | RSS: Main: 178720768 19:33:06 INFO - PID 6833 | 19:33:08 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46890/tests/kraken/driver.html?testName=audio-dft) 19:33:09 INFO - PID 6833 | RSS: Main: 177811456 19:33:09 INFO - PID 6833 | 19:33:12 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46890/tests/kraken/driver.html?testName=audio-fft) 19:33:12 INFO - PID 6833 | RSS: Main: 175554560 19:33:12 INFO - PID 6833 | 19:33:15 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46890/tests/kraken/driver.html?testName=audio-oscillator) 19:33:15 INFO - PID 6833 | RSS: Main: 175747072 19:33:15 INFO - PID 6833 | 19:33:17 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46890/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:33:18 INFO - PID 6833 | RSS: Main: 176029696 19:33:18 INFO - PID 6833 | 19:33:21 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46890/tests/kraken/driver.html?testName=imaging-darkroom) 19:33:22 INFO - PID 6833 | RSS: Main: 180101120 19:33:22 INFO - PID 6833 | 19:33:25 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46890/tests/kraken/driver.html?testName=imaging-desaturate) 19:33:26 INFO - PID 6833 | RSS: Main: 175906816 19:33:26 INFO - PID 6833 | 19:33:29 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46890/tests/kraken/driver.html?testName=json-parse-financial) 19:33:29 INFO - PID 6833 | RSS: Main: 176820224 19:33:29 INFO - PID 6833 | 19:33:31 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46890/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:33:32 INFO - PID 6833 | RSS: Main: 176508928 19:33:32 INFO - PID 6833 | 19:33:33 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46890/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:33:34 INFO - PID 6833 | RSS: Main: 176357376 19:33:34 INFO - PID 6833 | 19:33:36 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46890/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:33:37 INFO - PID 6833 | RSS: Main: 177266688 19:33:37 INFO - PID 6833 | 19:33:40 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:33:41 INFO - PID 6833 | RSS: Main: 177287168 19:33:41 INFO - PID 6833 | 19:33:44 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:33:44 INFO - PID 6833 | RSS: Main: 176861184 19:33:44 INFO - PID 6833 | 19:33:46 INFO - PID 6833 | Cycle 1(1): loaded http://localhost:46890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46890/tests/kraken/driver.html?testName=ai-astar) 19:33:46 INFO - PID 6833 | RSS: Main: 178417664 19:33:46 INFO - PID 6833 | 19:33:46 INFO - PID 6833 | __start_tp_report 19:33:46 INFO - PID 6833 | _x_x_mozilla_page_load 19:33:46 INFO - PID 6833 | _x_x_mozilla_page_load_details 19:33:46 INFO - PID 6833 | |i|pagename|runs| 19:33:46 INFO - PID 6833 | |0;ai-astar;109;115;113;111;113;111;111;111;111;112 19:33:46 INFO - PID 6833 | |1;audio-beat-detection;148;125;121;174;130;128;123;127;145;125 19:33:46 INFO - PID 6833 | |2;audio-dft;164;167;164;165;169;166;174;167;163;163 19:33:46 INFO - PID 6833 | |3;audio-fft;74;75;73;101;76;74;74;74;95;77 19:33:46 INFO - PID 6833 | |4;audio-oscillator;84;85;108;83;86;84;100;83;84;105 19:33:46 INFO - PID 6833 | |5;imaging-gaussian-blur;114;115;114;114;113;114;114;114;114;114 19:33:46 INFO - PID 6833 | |6;imaging-darkroom;151;150;152;149;150;152;151;151;151;151 19:33:46 INFO - PID 6833 | |7;imaging-desaturate;95;96;99;94;95;94;94;94;94;94 19:33:46 INFO - PID 6833 | |8;json-parse-financial;54;55;54;55;56;56;58;60;55;55 19:33:46 INFO - PID 6833 | |9;json-stringify-tinderbox;58;58;57;56;56;57;57;57;57;58 19:33:46 INFO - PID 6833 | |10;stanford-crypto-aes;90;89;86;86;87;86;105;88;129;86 19:33:46 INFO - PID 6833 | |11;stanford-crypto-ccm;139;137;132;136;142;133;141;136;136;142 19:33:46 INFO - PID 6833 | |12;stanford-crypto-pbkdf2;190;210;198;191;194;208;200;192;194;200 19:33:46 INFO - PID 6833 | |13;stanford-crypto-sha256-iterative;75;80;76;73;73;75;74;76;73;81 19:33:46 INFO - PID 6833 | __end_tp_report 19:33:46 INFO - PID 6833 | __start_cc_report 19:33:46 INFO - PID 6833 | _x_x_mozilla_cycle_collect,901 19:33:46 INFO - PID 6833 | __end_cc_report 19:33:46 INFO - PID 6833 | __startTimestamp1495766026988__endTimestamp 19:33:46 INFO - PID 6833 | 19:33:46 INFO - PID 6833 | ------- Summary: start ------- 19:33:46 INFO - PID 6833 | Number of tests: 14 19:33:46 INFO - PID 6833 | 19:33:46 INFO - PID 6833 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:1.64 (1.5%) stddev-sans-first:1.41 19:33:46 INFO - PID 6833 | Values: 109.0 115.0 113.0 111.0 113.0 111.0 111.0 111.0 111.0 112.0 19:33:46 INFO - PID 6833 | 19:33:46 INFO - PID 6833 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:129.00 stddev:16.55 (12.8%) stddev-sans-first:16.83 19:33:46 INFO - PID 6833 | Values: 148.0 125.0 121.0 174.0 130.0 128.0 123.0 127.0 145.0 125.0 19:33:46 INFO - PID 6833 | 19:33:46 INFO - PID 6833 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.50 stddev:3.36 (2.0%) stddev-sans-first:3.47 19:33:46 INFO - PID 6833 | Values: 164.0 167.0 164.0 165.0 169.0 166.0 174.0 167.0 163.0 163.0 19:33:46 INFO - PID 6833 | 19:33:46 INFO - PID 6833 | [#3] audio-fft Cycles:10 Average:79.30 Median:74.50 stddev:10.02 (13.5%) stddev-sans-first:10.45 19:33:46 INFO - PID 6833 | Values: 74.0 75.0 73.0 101.0 76.0 74.0 74.0 74.0 95.0 77.0 19:33:46 INFO - PID 6833 | 19:33:47 INFO - PID 6833 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:84.00 stddev:9.98 (11.9%) stddev-sans-first:10.33 19:33:47 INFO - PID 6833 | Values: 84.0 85.0 108.0 83.0 86.0 84.0 100.0 83.0 84.0 105.0 19:33:47 INFO - PID 6833 | 19:33:47 INFO - PID 6833 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 19:33:47 INFO - PID 6833 | Values: 114.0 115.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 19:33:47 INFO - PID 6833 | 19:33:47 INFO - PID 6833 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 19:33:47 INFO - PID 6833 | Values: 151.0 150.0 152.0 149.0 150.0 152.0 151.0 151.0 151.0 151.0 19:33:47 INFO - PID 6833 | 19:33:47 INFO - PID 6833 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.50 stddev:1.60 (1.7%) stddev-sans-first:1.69 19:33:47 INFO - PID 6833 | Values: 95.0 96.0 99.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 19:33:47 INFO - PID 6833 | 19:33:47 INFO - PID 6833 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:1.87 (3.4%) stddev-sans-first:1.87 19:33:47 INFO - PID 6833 | Values: 54.0 55.0 54.0 55.0 56.0 56.0 58.0 60.0 55.0 55.0 19:33:47 INFO - PID 6833 | 19:33:47 INFO - PID 6833 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 19:33:47 INFO - PID 6833 | Values: 58.0 58.0 57.0 56.0 56.0 57.0 57.0 57.0 57.0 58.0 19:33:47 INFO - PID 6833 | 19:33:47 INFO - PID 6833 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:86.50 stddev:13.83 (16.0%) stddev-sans-first:14.62 19:33:47 INFO - PID 6833 | Values: 90.0 89.0 86.0 86.0 87.0 86.0 105.0 88.0 129.0 86.0 19:33:47 INFO - PID 6833 | 19:33:47 INFO - PID 6833 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:138.00 stddev:3.53 (2.6%) stddev-sans-first:3.70 19:33:47 INFO - PID 6833 | Values: 139.0 137.0 132.0 136.0 142.0 133.0 141.0 136.0 136.0 142.0 19:33:47 INFO - PID 6833 | 19:33:47 INFO - PID 6833 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.70 Median:199.00 stddev:6.93 (3.5%) stddev-sans-first:6.77 19:33:47 INFO - PID 6833 | Values: 190.0 210.0 198.0 191.0 194.0 208.0 200.0 192.0 194.0 200.0 19:33:47 INFO - PID 6833 | 19:33:47 INFO - PID 6833 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:75.50 stddev:2.84 (3.8%) stddev-sans-first:3.00 19:33:47 INFO - PID 6833 | Values: 75.0 80.0 76.0 73.0 73.0 75.0 74.0 76.0 73.0 81.0 19:33:47 INFO - PID 6833 | -------- Summary: end -------- 19:33:47 INFO - PID 6833 | 19:33:48 INFO - TEST-INFO | 6833: exit 0 19:33:48 INFO - TEST-OK | kraken | took 93092ms 19:33:48 INFO - SUITE-END | took 1240s 19:33:48 INFO - Completed test suite (00:20:40) 19:33:48 INFO - javascript benchmark 19:33:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6781.98265623515, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2726.7273272672746, 2739.9452010959776, 2756.9862150689255, 2767.584862270658, 2777.805553611247, 5106.463821298766, 5124.8975020499665, 5156.329677141966, 5169.896602067956, 5175.0, 5164.793408263665, 5179.404368497624, 5212.087884620186, 5281.6830990140525, 5317.12267475867, 4584.174848527264, 4590.885227869297, 4620.907581848361, 4634.791434385461, 4652.139354219464, 4634.420697412824, 4642.442906851183, 4646.953530464702, 4699.201135806921, 4706.199946009169, 4546.54534546546, 4595.9310610340535, 4610.838620648295, 4672.6261899047995, 4702.8118875244945, 4648.976755116237, 4699.5535424135, 4700.482946875841, 4712.764361781931, 4715.056988602259, 4627.8148874045, 4644.373009643722, 4645.953540464586, 4646.79089440976, 4680.953190468086, 5177.145770947789, 5220.791168353299, 5229.529342359206, 5231.136862417697, 5261.86845328866, 5509.283793106911, 5586.0, 5593.077142271521, 5600.0759874620635, 5687.090065589486, 5707.971460142673, 5710.428957104298, 5728.513076388512, 5774.595778295521, 5775.0, 5292.867678308073, 5294.947050529484, 5299.49654782795, 5300.1519756838725, 5308.0710875596615, 5514.0, 5582.720863956786, 5810.622309549865, 5830.562707796932, 5864.9413505864395, 5478.123500239943, 5483.177523371526, 5569.275994120739, 5608.663480191201, 5617.859553511195, 5496.0931446310915, 5498.1752737089755, 5546.27898373217, 5555.194496797942, 5568.693721845257, 5461.344638643309, 5468.425815289417, 5524.502794748492, 5568.359638641527, 5578.888422231533, 5537.197106419547, 5553.16702494629, 5578.804741834017, 5623.5220006299105, 5637.408072152447, 4703.482616912137, 4710.62315014798, 4711.387519622495, 4725.621950244041, 4768.642351823558, 4063.6545893599377, 4068.105016896278, 4071.755694658271, 4088.1823635273063, 4124.216398884202, 4715.646326525524, 4774.21225497789, 4796.208625576741, 4834.0, 4855.781489832966, 5676.148577713376, 5690.4025077367105, 5695.40198279183, 5711.800086997018, 5748.540116790647, 4809.9038019239415, 4817.397825271841, 4831.9275210871865, 4835.6131509479155, 4873.731944743073, 4932.358793356841, 4989.925151122736, 5002.799888004512, 5023.0, 5043.36957880265, 5267.631265811357, 5275.182346736262, 5283.788648454019, 5312.495312945264, 5325.9467405327005, 5474.5894057945015, 5552.805651802168, 5672.971635141798, 5674.914876276942, 5682.829515114553, 5125.538701516882, 5191.428942816363, 5283.418823929442, 5290.735463226746, 5307.41618421981, 5425.43032981547, 5613.270274864241, 5613.635113717595, 5616.354119276336, 5656.406077361818, 5565.248691426767, 5597.216389705363, 5608.327000759935, 5619.8198378341, 5647.971760141173, 5513.338399392099, 5521.950829342412, 5522.558195344443, 5531.7234138292115, 5533.695646739468, 5492.395836457907, 5492.560595152298, 5500.147477141049, 5515.531179849758, 5553.527950124123, 5241.842744717665, 5304.602154838325, 5330.9466905332, 5371.5971302153275, 5416.997855396764, 5568.220449137205, 5570.442955704397, 5583.190437386637, 5587.7485513152815, 5630.127330263816, 5421.7560209791445, 5423.538999185113, 5427.050266203478, 5430.782768689208, 5436.891262174813], "value": 5109.333502676811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.798562409713, 740.9036825212721, 755.9017327747392, 1040.2042437535288, 1043.2697112021588, 32774.83612581937, 33506.832465837695, 33537.83231083844, 33566.49650255248, 33600.49599256013, 35082.8245858771, 35345.64654353456, 35465.822670886606, 35496.0, 35565.11087222821, 6627.801165965005, 6800.591964482147, 6866.759663411782, 6985.685644146026, 7002.789916302494, 6757.222919364287, 6844.247132815386, 6854.074699915497, 6855.314468553154, 6859.9314006859795, 6819.24988251292, 6827.624480653562, 6833.9316606834045, 6838.555493892881, 6888.4144847688, 6836.418904393133, 6877.1747390312985, 6879.862402751942, 6881.073299476129, 6881.277465866112, 6720.596764194115, 6753.3921947025, 6756.290589488082, 6759.425448836855, 6776.593404395752, 31469.685303146904, 31661.683383166335, 31758.206044848834, 31869.20326991844, 31937.84031079853, 3008.443437963962, 3022.199117233935, 3033.726964573177, 3046.3450358172877, 3047.588575542318, 24246.757532424628, 24294.635580466307, 24419.755802441927, 24436.022559097793, 24484.51030979388, 2691.7981151413724, 2697.0, 2700.176446183913, 2702.6756789185424, 2716.361655011071, 141883.0, 143078.0, 144797.0, 148872.0, 149145.0, 39942.60057399447, 40139.0, 40149.799251003555, 40178.584820290016, 40220.79889600533, 41932.58067419287, 41976.370354444094, 42013.0, 42050.57949420466, 42279.365809512885, 12534.373281335897, 12614.432350544248, 12712.173708708904, 12714.682132946751, 12738.617841464771, 10189.54147063384, 10317.123044541147, 10356.067953884187, 10402.375857448576, 10481.423521706227, 12676.746465070832, 12714.745705085847, 12823.61529154127, 12842.743145137045, 12944.741105177844, 5326.387465441447, 5371.919421208685, 5483.396826349099, 5488.56091512678, 5499.202615620713, 840.7057529864621, 886.1802832380023, 895.359817730326, 906.5421961909194, 908.100980029779, 20327.796722032886, 20422.183112675622, 21637.675434868488, 21701.565968680537, 21926.45183870416, 971.2230215827451, 974.8976357482504, 981.5190556627201, 989.8911119776819, 1000.4147573669339, 10988.505517251742, 11305.830412543819, 11374.658760237206, 11439.942800285946, 11556.537738490366, 173589.0, 174527.0, 175123.0, 175462.0, 175534.0, 41251.58748412477, 41445.585544144174, 41515.169696605895, 41547.376789348185, 41628.37557436641, 1187.944562587086, 1224.3633310678397, 1227.1716591300835, 1228.815677648342, 1232.3160645841465, 19757.506062348555, 19761.703574446106, 20431.4892127698, 21210.893945530173, 21428.0, 29697.554536681535, 29708.55437168401, 29721.81112755552, 29762.702372975993, 29784.0, 147077.0, 147359.0, 147411.0, 147732.0, 147972.0, 29397.002509572998, 29630.703692963656, 30275.243118922204, 30729.385412292075, 30772.846135769178, 35886.28227435384, 35952.64047359597, 36028.27943441169, 36063.0984225386, 36080.0, 25855.482890342464, 27278.590821137303, 27669.30826729348, 28112.43775124527, 28795.856020719762, 27019.86490067616, 27668.446631066865, 27913.720862791113, 28625.856870715514, 28766.137015889555, 29696.703032969395, 30142.397152057274, 30592.84703576468, 30759.69240307568, 31026.0, 26469.867650662392, 26848.59727104134, 27058.864705677133, 27392.17823465299, 28291.2927176814, 19993.600127997066, 22041.559168816853, 22127.889360553738, 22155.446113847283, 22257.666135008312], "value": 14429.17688858963, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.40900580649344, 406.16127696307126, 422.81818817908305, 429.82806877249095, 434.63056402058254, 12091.455884485198, 17408.73886891696, 17430.215640296185, 18065.36771213008, 18167.727484087733, 18101.09494525275, 18185.181666825025, 18302.816971830278, 18343.357982470618, 18493.999999999967, 5170.353705786777, 5433.293671822657, 5652.349979752319, 5669.234653321811, 5681.488666020057, 5278.102722537178, 5341.172118321666, 5343.332083489564, 5344.839654810343, 5350.973245133789, 5222.216667499867, 5327.121025030865, 5329.280547126127, 5336.706481143536, 5343.519083282504, 5418.566514678816, 5479.945200547983, 5500.972495137498, 5509.696966666852, 5521.2270282160525, 4916.06594746997, 4919.778609962525, 4952.158133117378, 4973.254011898208, 4991.725455099968, 20689.379318620464, 21261.893690531604, 21432.357029289145, 21460.141594336365, 21555.46111347213, 1611.2749262831655, 1614.3784642912447, 1665.3338664534162, 1667.908265045422, 1668.7747154134158, 14277.571672849832, 14355.354009069513, 14498.42006319746, 14742.778858317133, 14898.776518352233, 2026.695995600657, 2042.244369583249, 2063.2366024570856, 2072.1504183284783, 2091.3725882235267, 86293.56853215756, 88473.11526884713, 90717.54641226817, 91715.54142229313, 93475.53262233714, 10613.363198208132, 10756.569737210424, 10854.0, 10979.121670266359, 11013.174011949135, 15128.621784455476, 15148.924255378874, 15156.469523566622, 15160.772588411182, 32350.0, 8603.870941935877, 9010.459372437545, 9018.233450156678, 9226.76933076665, 9266.907330926739, 7015.263397343308, 7059.89410158848, 7100.289971002859, 7252.347288744038, 7274.054372931485, 8876.20114189726, 8997.685081022133, 9097.636094556276, 9195.586198620944, 9509.762255943519, 3779.6214417009846, 3945.3292940200236, 4079.755214687128, 4179.185058913544, 4223.619874211336, 841.4614646626164, 866.2501746472091, 871.329076611006, 871.6208449324438, 901.7655409593552, 16425.91787041081, 16572.419965301397, 16623.750643740354, 17159.142042898056, 17344.47966561005, 869.6608322754131, 871.0984131423946, 888.8755574219614, 898.6360523987795, 905.6105874473908, 8930.821383572293, 9171.862422063674, 9311.534423278808, 9358.473212232659, 9439.716808495756, 346038.0, 347686.0, 349155.0, 364612.0, 375411.0, 73384.26615733882, 74141.6292918532, 75058.62470687611, 76320.61839690767, 76519.0, 1065.3448129400517, 1080.0765345629375, 1106.2145876427664, 1107.5846557540922, 1115.1246271676857, 16630.0, 16910.239039243508, 17387.0, 17457.30170793154, 17550.0, 37710.62289377071, 37906.24187516179, 38740.806295969465, 38967.2206555873, 39711.0, 45738.54261457476, 45895.54104459046, 46755.29867051929, 47594.286085709435, 47766.283505748135, 8127.024757029194, 8353.24820766134, 8353.498790072616, 8364.581770911309, 8382.0, 12084.006138986968, 12491.687707807014, 12851.421686024338, 13134.080614356903, 13227.272500012592, 9495.85756213671, 10101.393916365041, 10176.287659863738, 10611.045005949502, 11160.051395631137, 9234.445933244027, 9383.436993780395, 9465.195458386115, 9586.137247647745, 9998.550065246936, 9743.415395076318, 9799.167070798776, 10060.39637621745, 10362.326448780805, 10568.630097946534, 7774.572398518136, 7788.766337009899, 7793.805154871174, 7903.881441778263, 7906.683732650859, 9398.67104651334, 9497.335186536877, 9575.712728618153, 9610.327277090537, 9752.658656946973], "value": 8986.02294855116, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.9319687417192, 1297.5004623220057, 1302.1405872124387, 1302.322792148083, 1304.6738315421144, 9990.100890919815, 10320.535575899085, 10441.530131144089, 10465.162786977042, 10627.893721062786, 10401.531931063102, 10614.469276536181, 10618.203634727408, 10618.681439556807, 10618.78762424751, 2100.527381339202, 2135.6049130910756, 2135.903884325209, 2136.380449669594, 2139.0801955159277, 2068.603692507559, 2110.841686873483, 2111.050027487629, 2113.3448630924463, 2117.491801967532, 2062.783407742188, 2082.1671331467383, 2090.9268175613856, 2092.4978005278776, 2096.7379077615296, 2022.5145964968376, 2030.949226269355, 2031.8171364577186, 2033.5460145995537, 2035.5216524116895, 1975.9703604445945, 2022.3326302320347, 2055.640262953992, 2073.9792602073935, 2081.08432289792, 10052.296339256254, 10156.593736250541, 10160.644377446828, 10164.847527287096, 10175.236857235663, 5246.7638956247065, 5454.372747134091, 5467.863303417406, 5471.2887324647545, 5480.835574932758, 3207.5028370602595, 3285.983570082158, 3329.250918543333, 3331.6335203127637, 3341.2816244507303, 1030.7320096774893, 1052.6210564196883, 1057.735566108473, 1063.7925604507125, 1078.8543546621183, 15225.695486090326, 15436.151011694352, 15703.842961570466, 15707.057576545443, 15982.44061457855, 5062.088824011639, 5105.693658380509, 5135.537801597874, 5154.149565321755, 5213.296205012351, 12676.366181690879, 12779.61661150167, 12822.80765788514, 12827.679308017188, 12831.663767420352, 5579.358373786985, 5668.348139963874, 5672.0, 5676.545876329884, 5690.715464226772, 5061.7469126544265, 5114.3862736471865, 5116.437191908887, 5146.253793199965, 5178.223266510054, 4239.745615263094, 4372.4315838941375, 4377.715448495837, 4389.780510974502, 4411.691181617256, 1293.127139181049, 1322.385090932721, 1336.6791969927147, 1355.1868878672717, 1364.3928451838835, 689.4518857508293, 707.3563057617646, 715.4812760748416, 728.3954317916117, 729.0267492897042, 5281.313429254173, 5332.92000619991, 5411.56707463402, 5412.07994640912, 5487.75305111271, 558.3857756467934, 561.738791461964, 568.8577855536116, 571.1404336473664, 571.7798647520734, 3467.5665541807275, 3638.381475149231, 3757.49273848027, 3819.331616967075, 3841.157543417851, 12978.480860765652, 13279.0, 13288.534901278603, 13293.93353033248, 13456.394462249222, 13197.20816750998, 13203.66990825237, 13576.728465430833, 13692.863071369158, 13818.309084545732, 7286.380657644054, 7482.139553951365, 7665.3101220890385, 7669.348105411103, 7785.104712958082, 6382.776602818879, 6517.152770139852, 6584.209894812461, 6686.966565167338, 6876.724931002704, 11894.286342819458, 12202.14584979043, 12369.567065152676, 12396.194247373893, 12490.06324525646, 12470.688232794253, 12674.683132921751, 12698.619041428772, 12789.232646041268, 12848.614541563767, 7951.840963180588, 8155.266026057446, 8157.79605509867, 8164.224398682116, 8183.099859015384, 9081.228095611683, 9395.15443610051, 9425.680404743205, 9435.150836424755, 9468.242540596599, 7697.538147710931, 7814.296713295831, 7848.646810893638, 7875.803104922423, 7972.760817175494, 7959.602019899097, 7963.084245311863, 7972.521648701097, 8021.398395120273, 8158.224968627971, 7099.538529995534, 7189.245129261352, 7216.097987751531, 7226.927730722626, 7240.0, 5060.595152387727, 5146.639735218649, 5239.921401178909, 5348.3954813555, 5366.248725178556, 4560.6807523473035, 5298.489930369826, 5300.416954135119, 5371.0, 5420.457954204548], "value": 4726.189144918666, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.15667892370845, 394.77497826239045, 399.14651633790476, 399.7082130045069, 403.75976294105016, 5523.033469142904, 5528.198411230369, 5535.280413546238, 5554.1391084381885, 5582.413846546115, 5083.6441449098575, 5320.654157479761, 5381.865453363668, 5395.10980688186, 5398.811041613544, 4281.464816897896, 4319.308910574308, 4320.5031421386475, 4328.437303150602, 4343.109662519176, 4297.634701050399, 4306.483222013347, 4309.547497512763, 4322.0, 4352.12957408518, 4223.02870339822, 4279.593438623326, 4287.957120428802, 4320.222359975203, 4335.479742430897, 4294.196437496244, 4296.548862369437, 4307.569243075683, 4321.438213032286, 4322.783860806947, 3913.7847418391975, 3921.7450865693922, 3928.3714605663245, 3930.21395720857, 3931.410288456726, 5182.170852663556, 5286.414075777251, 5290.470952904717, 5300.3639563252655, 5310.62825602208, 5105.412877519096, 5117.8464646060675, 5128.461511541309, 5131.84604461863, 5141.203113517374, 5715.257016587859, 5742.626729262584, 5742.856428589277, 5748.844183431213, 5793.391693872167, 4200.327947528381, 4387.62705170061, 4435.556444355571, 4436.955630443719, 4483.439570053743, 5834.920539700127, 6041.72812223451, 6046.395360463918, 6088.208532890741, 6120.908186377208, 4326.41593384889, 4331.740095594211, 4348.586884245991, 4356.671215279307, 4356.673249506236, 4381.9342709859375, 4404.11917616478, 4415.896025993502, 4488.371627972087, 4636.884077898012, 5030.647854650139, 5112.182050871843, 5114.130597798383, 5134.0, 5152.355955505562, 5773.35459394079, 5782.59521833476, 5790.623609465456, 5791.420857914175, 5810.941890581124, 1604.6951079294897, 1606.8955517891534, 1622.853943145099, 1624.7725318455425, 1634.4687976407715, 1147.8278258261328, 1173.6537721372215, 1187.4062968515743, 1197.9640610781692, 1201.2492192379764, 4949.925751113664, 4980.352554167935, 4989.90020199594, 4990.700557966534, 4993.975030124899, 5890.911636325459, 5901.734421951022, 5906.0, 5917.615355001911, 5939.227900372924, 4784.0, 4965.1311020571975, 4990.650654454226, 4999.950000500021, 5025.623078269145, 3168.1604374840686, 3172.365526894584, 3187.330660561308, 3194.1375828526634, 3200.9359812804078, 5414.187871819258, 5546.334439867242, 5552.444755524496, 5565.721713914288, 5567.944320556742, 6014.398560143951, 6062.514998800086, 6084.969575152184, 6091.48222401092, 6124.846878827976, 5522.502974732213, 5530.806421775299, 5540.030494663499, 5544.916826247529, 5563.193336966117, 5863.648181109147, 5884.911726324194, 5914.290285165807, 5928.911066334094, 5957.791477298447, 5658.1709145427285, 5814.215080964016, 5833.3833023525685, 5835.183074369506, 5865.120231965239, 5521.889562208814, 5523.0, 5536.0, 5539.861503462445, 5560.527355174693, 4080.7557991396316, 4093.488313960755, 4107.815148318393, 4129.690273229459, 4152.439420678291, 5898.528117750484, 5921.970390148022, 5925.466707996128, 5953.732082056405, 5957.821265362046, 5717.914231286617, 5727.11229759388, 5801.622894511843, 5811.360750317546, 5815.331236907809, 5553.16702494629, 5734.817176467101, 5741.1388291756575, 5759.510441612342, 5775.682337471311, 5634.971825140848, 5638.746256418389, 5648.943510564842, 5657.462541058593, 5659.886802264014, 5707.68607726579, 5853.473187413153, 5865.765369385177, 5883.529317654663, 5893.528517718658, 5644.294463192101, 5682.346530149086, 5693.459121383462, 5695.345035320825, 5712.571557133148], "value": 4424.089788842095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.9228438729546, 693.237438817301, 700.215758350647, 719.7336985315434, 750.3996802557956, 11524.71188220295, 12013.399330033486, 12856.0, 13382.799258011126, 13437.32813359333, 14718.705625887476, 15486.0, 15578.376864925418, 15581.298841552129, 15608.843911560882, 875.0986483921571, 897.9146981036791, 905.714699869539, 906.2749800159879, 908.5094049213417, 906.3610154840821, 906.863970404438, 906.9682561110362, 911.6581282019242, 916.2486760856101, 953.4755884263627, 953.918916892065, 954.5227386306847, 954.5847556312991, 954.5847556312991, 945.0, 949.8052899155691, 954.8472244440856, 956.3926906414476, 959.6881013670585, 680.2177495879729, 680.2687111355312, 690.86182763447, 690.989635155473, 692.3906961873519, 14654.560363189015, 14837.183954882477, 14878.776818347733, 14928.70142597142, 14970.62573435662, 15607.687846243012, 16379.91810040954, 16562.83437165637, 16569.91715041429, 16574.917125414417, 12527.749445011048, 12810.935945320307, 13008.934955325258, 13076.411561479756, 13092.934535327262, 2917.6061231733656, 2949.690282520326, 2950.100219433072, 2950.129711735043, 2951.144168191222, 78781.0, 79104.0, 80879.0, 81164.0, 81358.59320703418, 10433.895661043443, 10606.15150787935, 10619.681409557727, 10630.840537391945, 10664.840027399596, 17767.20047597861, 17929.641407172043, 18149.909250453926, 18305.35931242427, 18523.66574016663, 5875.50058245054, 5909.734061967136, 5929.0513517836935, 5939.821805345847, 5949.286085669661, 2825.50553653114, 2901.405211931549, 2901.608282881826, 2904.390078083626, 2905.622269105003, 3542.6634469725336, 3608.963910360863, 4221.598948099926, 4360.280553708666, 4387.473503179639, 715.4348065028569, 754.1252147508864, 755.0222461911837, 756.3042001358763, 769.2346115615, 607.471499795181, 623.432676264597, 624.5846512069513, 626.5457543281176, 641.3041849593151, 9536.380135291183, 9819.75450613726, 9862.852057219148, 10052.547635356426, 10966.890331096587, 559.2087196616742, 573.5784198614016, 574.7643466178847, 581.2240658720656, 595.9582829201914, 4611.5619016193405, 4639.257718765049, 4668.5798278155125, 4681.0, 4803.759812009385, 83940.16059839324, 84866.57566712251, 86324.56837715897, 88468.55765721259, 89864.0, 75073.62463187758, 75648.62175689086, 77170.61414693003, 77821.2217877814, 79447.0, 66021.99999999904, 66577.66711166414, 66676.0, 66694.66652666802, 67603.66198168977, 8999.730008099506, 9301.976782553778, 9374.765630859283, 9452.810943780949, 9614.71155865325, 28677.85661071681, 28829.711702883542, 29167.562486563143, 29572.0, 30205.244868878453, 36224.456633149995, 36369.81815090908, 36536.26927461383, 37048.0, 37142.62857371392, 12519.874801252236, 12766.872331276569, 13176.670583235496, 13187.340632968506, 13202.933985330012, 14065.367058482598, 14132.717345653235, 14356.282185890455, 14388.568342949728, 14565.708685826012, 12729.618111456672, 12894.613161605166, 13251.349730053835, 15089.54731358061, 15313.540593782205, 15079.849201507845, 15320.846791532387, 15528.689426211638, 15656.843431565538, 15802.525924222291, 14999.925000374928, 15200.923995380395, 15282.388704452142, 15397.07617542951, 15602.375904963674, 10188.847167292644, 10381.169506439617, 10483.580656773644, 10581.624388829403, 10655.0, 11530.538778449103, 11595.246308989888, 12048.698782530157, 12295.32375719344, 12361.93819030899], "value": 7024.260354878481, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 113.0, 111.0, 113.0, 111.0, 111.0, 111.0, 111.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 121.0, 174.0, 130.0, 128.0, 123.0, 127.0, 145.0, 125.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 164.0, 165.0, 169.0, 166.0, 174.0, 167.0, 163.0, 163.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 101.0, 76.0, 74.0, 74.0, 74.0, 95.0, 77.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 108.0, 83.0, 86.0, 84.0, 100.0, 83.0, 84.0, 105.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 152.0, 149.0, 150.0, 152.0, 151.0, 151.0, 151.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 99.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 56.0, 56.0, 58.0, 60.0, 55.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 56.0, 56.0, 57.0, 57.0, 57.0, 57.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 86.0, 86.0, 87.0, 86.0, 105.0, 88.0, 129.0, 86.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 132.0, 136.0, 142.0, 133.0, 141.0, 136.0, 136.0, 142.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 210.0, 198.0, 191.0, 194.0, 208.0, 200.0, 192.0, 194.0, 200.0], "value": 197.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 76.0, 73.0, 73.0, 75.0, 74.0, 76.0, 73.0, 81.0], "value": 75.6, "unit": "score"}]}]} 19:33:48 INFO - Return code: 0 19:33:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:33:48 INFO - # TBPL SUCCESS # 19:33:48 INFO - Running post-action listener: _resource_record_post_action 19:33:48 INFO - [mozharness: 2017-05-26 02:33:48.286416Z] Finished run-tests step (success) 19:33:48 INFO - Running post-run listener: _resource_record_post_run 19:33:48 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 1384448; Write bytes: 415141888; Read time: 744; Write time: 250628 19:33:48 INFO - TinderboxPrint: CPU usage
12.7% 19:33:48 INFO - TinderboxPrint: I/O read bytes / time
1,384,448 / 744 19:33:48 INFO - TinderboxPrint: I/O write bytes / time
415,141,888 / 250,628 19:33:48 INFO - TinderboxPrint: CPU idle
8,760.1 (87.3%) 19:33:48 INFO - TinderboxPrint: CPU user
1,217.8 (12.1%) 19:33:48 INFO - TinderboxPrint: Swap in / out
0 / 0 19:33:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110006272; Read time: 64; Write time: 81812 19:33:48 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 1355776; Write bytes: 305135616; Read time: 652; Write time: 168816 19:33:48 INFO - Running post-run listener: _upload_blobber_files 19:33:48 INFO - Blob upload gear active. 19:33:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:33:48 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 19:33:48 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'] 19:33:48 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 19:33:49 INFO - (blobuploader) - INFO - Open directory for files ... 19:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:33:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:52 INFO - (blobuploader) - INFO - Done attempting. 19:33:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:33:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:33:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:53 INFO - (blobuploader) - INFO - Done attempting. 19:33:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:33:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:33:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:54 INFO - (blobuploader) - INFO - Done attempting. 19:33:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:33:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:33:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:55 INFO - (blobuploader) - INFO - Done attempting. 19:33:55 INFO - (blobuploader) - INFO - Iteration through files over. 19:33:55 INFO - Return code: 0 19:33:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:33:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:33:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52c43a22b9dd5ecebe1daf51ffedcfe43cd7c3a22c897ee10164309eaa6c3d2af4d881a4e97a984371fd8f5b0ce254b2b9d02d19c5540ed0e7b7001d8928990b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1382ff5b33c99ac50bd4c6cca2bdfccabf546b6ae977cf2fd891b02806f81be6653ae2e78a22d7852ee4f67dce486fa5df2422dba3368f7b14d3b6b26aad58a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62e06b78344ad89c8f6665444334cc52690fd702707c9ce1e9714b999639af9af56c514105ccaf9a30cdb72caac32fd87f83172c36b06d84cdb82635022bc5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64c2d9676074e06b8b62049c7c1820e8b620fa4758eb827c0df4fd08ff27997bc6080e16c61a5fd959cbe665ddfcbb85a877c44072dd10e7496ee33129d5c37"} 19:33:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:33:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:33:55 INFO - Contents: 19:33:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52c43a22b9dd5ecebe1daf51ffedcfe43cd7c3a22c897ee10164309eaa6c3d2af4d881a4e97a984371fd8f5b0ce254b2b9d02d19c5540ed0e7b7001d8928990b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1382ff5b33c99ac50bd4c6cca2bdfccabf546b6ae977cf2fd891b02806f81be6653ae2e78a22d7852ee4f67dce486fa5df2422dba3368f7b14d3b6b26aad58a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62e06b78344ad89c8f6665444334cc52690fd702707c9ce1e9714b999639af9af56c514105ccaf9a30cdb72caac32fd87f83172c36b06d84cdb82635022bc5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64c2d9676074e06b8b62049c7c1820e8b620fa4758eb827c0df4fd08ff27997bc6080e16c61a5fd959cbe665ddfcbb85a877c44072dd10e7496ee33129d5c37"} 19:33:55 INFO - Running post-run listener: copy_logs_to_upload_dir 19:33:55 INFO - Copying logs to upload dir... 19:33:55 INFO - mkdir: /builds/slave/test/build/upload/logs 19:33:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.703322 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-25 19:33:55.248277) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 19:33:55.252644) ========= 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=cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122 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/52c43a22b9dd5ecebe1daf51ffedcfe43cd7c3a22c897ee10164309eaa6c3d2af4d881a4e97a984371fd8f5b0ce254b2b9d02d19c5540ed0e7b7001d8928990b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1382ff5b33c99ac50bd4c6cca2bdfccabf546b6ae977cf2fd891b02806f81be6653ae2e78a22d7852ee4f67dce486fa5df2422dba3368f7b14d3b6b26aad58a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62e06b78344ad89c8f6665444334cc52690fd702707c9ce1e9714b999639af9af56c514105ccaf9a30cdb72caac32fd87f83172c36b06d84cdb82635022bc5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64c2d9676074e06b8b62049c7c1820e8b620fa4758eb827c0df4fd08ff27997bc6080e16c61a5fd959cbe665ddfcbb85a877c44072dd10e7496ee33129d5c37"} build_url:https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/JXCa_B9iTWW2mMh5RWYnSA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52c43a22b9dd5ecebe1daf51ffedcfe43cd7c3a22c897ee10164309eaa6c3d2af4d881a4e97a984371fd8f5b0ce254b2b9d02d19c5540ed0e7b7001d8928990b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1382ff5b33c99ac50bd4c6cca2bdfccabf546b6ae977cf2fd891b02806f81be6653ae2e78a22d7852ee4f67dce486fa5df2422dba3368f7b14d3b6b26aad58a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62e06b78344ad89c8f6665444334cc52690fd702707c9ce1e9714b999639af9af56c514105ccaf9a30cdb72caac32fd87f83172c36b06d84cdb82635022bc5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64c2d9676074e06b8b62049c7c1820e8b620fa4758eb827c0df4fd08ff27997bc6080e16c61a5fd959cbe665ddfcbb85a877c44072dd10e7496ee33129d5c37"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 19:33:55.284556) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:33:55.284909) ========= 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=cbe409c6de289db6ac707de3000001d4-1495758688.554023-909977122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:33:55.368298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 19:33:55.368662) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 19:33:55.368997) ========= ========= Total master_lag: 0.19 =========