builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1500338532.24 results: success (0) revision: efc0b1525edbd357818dc7195537364e76f709e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:12.235549) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:12.235985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:12.236263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:12.252227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:12.252490) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-17 17:42:13-- 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% 49.4M=0s 2017-07-17 17:42:13 (49.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198932 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:12.464493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:12.464829) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019242 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:12.514685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:12.515015) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev efc0b1525edbd357818dc7195537364e76f709e7 --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 efc0b1525edbd357818dc7195537364e76f709e7 --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=2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-17 17:42:13,436 truncating revision to first 12 chars 2017-07-17 17:42:13,436 Setting DEBUG logging. 2017-07-17 17:42:13,436 attempt 1/10 2017-07-17 17:42:13,436 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/efc0b1525edb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-17 17:42:13,937 unpacking tar archive at: mozilla-central-efc0b1525edb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.826441 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:13.354190) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:13.354509) ========= script_repo_revision: efc0b1525edbd357818dc7195537364e76f709e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:13.354887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:13.355156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 17:42:13.363914) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-07-17 17:42:13.364180) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:42:14 INFO - MultiFileLogger online at 20170717 17:42:14 in /builds/slave/test 17:42:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:42:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:14 INFO - {'append_to_log': False, 17:42:14 INFO - 'base_work_dir': '/builds/slave/test', 17:42:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:42:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:14 INFO - 'branch': 'Firefox-Non-PGO', 17:42:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:14 INFO - 'code_coverage': False, 17:42:14 INFO - 'config_files': ('talos/linux_config.py',), 17:42:14 INFO - 'default_actions': ('clobber', 17:42:14 INFO - 'read-buildbot-config', 17:42:14 INFO - 'download-and-extract', 17:42:14 INFO - 'populate-webroot', 17:42:14 INFO - 'create-virtualenv', 17:42:14 INFO - 'install', 17:42:14 INFO - 'setup-mitmproxy', 17:42:14 INFO - 'run-tests'), 17:42:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:14 INFO - 'disable_ccov_upload': False, 17:42:14 INFO - 'download_minidump_stackwalk': True, 17:42:14 INFO - 'download_symbols': 'ondemand', 17:42:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:14 INFO - 'gecko_profile': False, 17:42:14 INFO - 'gecko_profile_interval': 0, 17:42:14 INFO - 'installer_path': 'installer.exe', 17:42:14 INFO - 'log_level': 'info', 17:42:14 INFO - 'log_name': 'talos', 17:42:14 INFO - 'log_to_console': True, 17:42:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:42:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:42:14 INFO - 'opt_config_files': (), 17:42:14 INFO - 'pip_index': False, 17:42:14 INFO - 'suite': 'dromaeojs-e10s', 17:42:14 INFO - 'system_bits': '32', 17:42:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:14 INFO - 'title': 'talos-linux64-ix-012', 17:42:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:14 INFO - 'use_talos_json': True, 17:42:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:14 INFO - 'work_dir': 'build'} 17:42:14 INFO - [mozharness: 2017-07-18 00:42:14.397181Z] Running clobber step. 17:42:14 INFO - Running pre-action listener: _resource_record_pre_action 17:42:14 INFO - Running main action method: clobber 17:42:14 INFO - rmtree: /builds/slave/test/build 17:42:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:42:16 INFO - Running post-action listener: _resource_record_post_action 17:42:16 INFO - [mozharness: 2017-07-18 00:42:16.080772Z] Finished clobber step (success) 17:42:16 INFO - [mozharness: 2017-07-18 00:42:16.080874Z] Running read-buildbot-config step. 17:42:16 INFO - Running pre-action listener: _resource_record_pre_action 17:42:16 INFO - Running main action method: read_buildbot_config 17:42:16 INFO - Using buildbot properties: 17:42:16 INFO - { 17:42:16 INFO - "project": "", 17:42:16 INFO - "product": "firefox", 17:42:16 INFO - "who": "kwierso@gmail.com", 17:42:16 INFO - "installer_path": "public/build/target.tar.bz2", 17:42:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:42:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:42:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:42:16 INFO - "stage_platform": "linux64", 17:42:16 INFO - "basedir": "/builds/slave/test", 17:42:16 INFO - "buildnumber": 1014, 17:42:16 INFO - "platform": "ubuntu64_hw", 17:42:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:42:16 INFO - "slavebuilddir": "test", 17:42:16 INFO - "taskId": "HdDmr9koQoWxvOqoivreMQ", 17:42:16 INFO - "branch": "mozilla-central", 17:42:16 INFO - "script_repo_revision": "production", 17:42:16 INFO - "revision": "efc0b1525edbd357818dc7195537364e76f709e7", 17:42:16 INFO - "slavename": "talos-linux64-ix-012", 17:42:16 INFO - "repo_path": "mozilla-central" 17:42:16 INFO - } 17:42:16 INFO - Finding installer, test and symbols from parent task. 17:42:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HdDmr9koQoWxvOqoivreMQ'}, attempt #1 17:42:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HdDmr9koQoWxvOqoivreMQ'}, attempt #1 17:42:16 INFO - Task dependencies: aeKol2JgST-iGC51osM4Tg 17:42:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg'}, attempt #1 17:42:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.tar.bz2 17:42:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/test_packages.json 17:42:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.crashreporter-symbols.zip 17:42:17 INFO - Running post-action listener: _resource_record_post_action 17:42:17 INFO - [mozharness: 2017-07-18 00:42:17.413626Z] Finished read-buildbot-config step (success) 17:42:17 INFO - [mozharness: 2017-07-18 00:42:17.413845Z] Running download-and-extract step. 17:42:17 INFO - Running pre-action listener: _resource_record_pre_action 17:42:17 INFO - Running main action method: download_and_extract 17:42:17 INFO - mkdir: /builds/slave/test/build/tests 17:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:17 INFO - trying https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.test_packages.json 17:42:17 INFO - Downloading https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:42:18 INFO - Downloaded 989 bytes. 17:42:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:42:18 INFO - Using the following test package requirements: 17:42:18 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:42:18 INFO - u'common': [u'target.common.tests.zip'], 17:42:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:42:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:42:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:42:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:42:18 INFO - u'mozbase': [u'target.common.tests.zip'], 17:42:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:42:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:42:18 INFO - u'web-platform': [u'target.common.tests.zip', 17:42:18 INFO - u'target.web-platform.tests.tar.gz'], 17:42:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:42:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:42:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.common.tests.zip 17:42:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:42:18 INFO - Fetch https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.common.tests.zip into memory 17:42:19 INFO - Content-Length response header: 72769053 17:42:19 INFO - Bytes received: 72769053 17:42:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:42:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.common.tests.zip 17:42:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:42:30 INFO - Fetch https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.common.tests.zip into memory 17:42:31 INFO - Content-Length response header: 72769053 17:42:31 INFO - Bytes received: 72769053 17:42:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.talos.tests.zip 17:42:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:42:43 INFO - Fetch https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.talos.tests.zip into memory 17:42:44 INFO - Content-Length response header: 14495033 17:42:44 INFO - Bytes received: 14495033 17:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:44 INFO - trying https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.tar.bz2 17:42:44 INFO - Downloading https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:42:45 INFO - Downloaded 61903399 bytes. 17:42:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.tar.bz2 17:42:45 INFO - mkdir: /builds/slave/test/properties 17:42:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:42:45 INFO - Writing to file /builds/slave/test/properties/build_url 17:42:45 INFO - Contents: 17:42:45 INFO - build_url:https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.tar.bz2 17:42:45 INFO - Running post-action listener: _resource_record_post_action 17:42:45 INFO - Running post-action listener: set_extra_try_arguments 17:42:45 INFO - [mozharness: 2017-07-18 00:42:45.861431Z] Finished download-and-extract step (success) 17:42:45 INFO - [mozharness: 2017-07-18 00:42:45.861528Z] Running populate-webroot step. 17:42:45 INFO - Running pre-action listener: _resource_record_pre_action 17:42:45 INFO - Running main action method: populate_webroot 17:42:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:42:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:42:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:42:45 INFO - '--tppagecycles', 17:42:45 INFO - '7'], 17:42:45 INFO - 'tests': ['tsvgm']}}, 17:42:45 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:42:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:42:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:42:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:42:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:42:45 INFO - 'talos_options': ['--disable-e10s'], 17:42:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:42:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:42:45 INFO - 'talos_options': ['--disable-e10s'], 17:42:45 INFO - 'tests': ['damp', 'tps']}, 17:42:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:42:45 INFO - 'tests': ['damp', 'tps']}, 17:42:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:42:45 INFO - 'tests': ['dromaeo_dom']}, 17:42:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:42:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:42:45 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:42:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:42:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:42:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:42:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:42:45 INFO - 'tests': ['a11yr', 17:42:45 INFO - 'ts_paint', 17:42:45 INFO - 'tpaint', 17:42:45 INFO - 'sessionrestore', 17:42:45 INFO - 'sessionrestore_no_auto_restore', 17:42:45 INFO - 'tabpaint']}, 17:42:45 INFO - 'other-e10s': {'tests': ['a11yr', 17:42:45 INFO - 'ts_paint', 17:42:45 INFO - 'tpaint', 17:42:45 INFO - 'sessionrestore', 17:42:45 INFO - 'sessionrestore_many_windows', 17:42:45 INFO - 'sessionrestore_no_auto_restore', 17:42:45 INFO - 'tabpaint']}, 17:42:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:42:45 INFO - 'ts_paint', 17:42:45 INFO - 'tpaint', 17:42:45 INFO - 'sessionrestore', 17:42:45 INFO - 'sessionrestore_many_windows', 17:42:45 INFO - 'sessionrestore_no_auto_restore', 17:42:45 INFO - 'tabpaint']}, 17:42:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:42:45 INFO - 'ts_paint', 17:42:45 INFO - 'tpaint', 17:42:45 INFO - 'sessionrestore', 17:42:45 INFO - 'sessionrestore_many_windows', 17:42:45 INFO - 'sessionrestore_no_auto_restore', 17:42:45 INFO - 'tabpaint']}, 17:42:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:42:45 INFO - 'tests': ['a11yr', 17:42:45 INFO - 'ts_paint', 17:42:45 INFO - 'tpaint', 17:42:45 INFO - 'sessionrestore', 17:42:45 INFO - 'sessionrestore_no_auto_restore', 17:42:45 INFO - 'tabpaint']}, 17:42:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:42:45 INFO - 'tests': ['a11yr', 17:42:45 INFO - 'ts_paint', 17:42:45 INFO - 'tpaint', 17:42:45 INFO - 'sessionrestore', 17:42:45 INFO - 'sessionrestore_no_auto_restore', 17:42:45 INFO - 'tabpaint']}, 17:42:45 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 17:42:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:42:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:42:45 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:42:45 INFO - 'talos_options': ['--mitmproxy', 17:42:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:42:45 INFO - '--firstNonBlankPaint'], 17:42:45 INFO - 'tests': ['quantum_pageload_google', 17:42:45 INFO - 'quantum_pageload_youtube', 17:42:45 INFO - 'quantum_pageload_amazon', 17:42:45 INFO - 'quantum_pageload_facebook']}, 17:42:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:42:45 INFO - 'tests': ['tsvgx', 17:42:45 INFO - 'tsvgr_opacity', 17:42:45 INFO - 'tart', 17:42:45 INFO - 'tscrollx', 17:42:45 INFO - 'cart', 17:42:45 INFO - 'tsvg_static']}, 17:42:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:42:45 INFO - 'tsvgr_opacity', 17:42:45 INFO - 'tart', 17:42:45 INFO - 'tscrollx', 17:42:45 INFO - 'cart', 17:42:45 INFO - 'tsvg_static']}, 17:42:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:42:45 INFO - 'talos_options': ['--disable-e10s'], 17:42:45 INFO - 'tests': ['tp5o']}, 17:42:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:42:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:42:45 INFO - 'talos_options': ['--disable-e10s', 17:42:45 INFO - '--xperf_path', 17:42:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:45 INFO - 'tests': ['tp5n']}, 17:42:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:42:45 INFO - 'talos_options': ['--xperf_path', 17:42:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:45 INFO - 'tests': ['tp5n']}}, 17:42:45 INFO - 'talos.zip': {'path': '', 17:42:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:42:45 INFO - Running post-action listener: _resource_record_post_action 17:42:45 INFO - [mozharness: 2017-07-18 00:42:45.876815Z] Finished populate-webroot step (success) 17:42:45 INFO - [mozharness: 2017-07-18 00:42:45.876906Z] Running create-virtualenv step. 17:42:45 INFO - Running pre-action listener: _resource_record_pre_action 17:42:45 INFO - Running main action method: create_virtualenv 17:42:45 INFO - Creating virtualenv /builds/slave/test/build/venv 17:42:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:42:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:42:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:42:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:42:45 INFO - Using real prefix '/usr' 17:42:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:42:46 INFO - Installing distribute.............................................................................................................................................................................................done. 17:42:48 INFO - Installing pip.................done. 17:42:48 INFO - Return code: 0 17:42:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:42:48 INFO - Reading from file tmpfile_stdout 17:42:48 INFO - Output received: 17:42:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:42:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:48 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 0x116c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ddb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:42:48 INFO - Using env: {'DISPLAY': ':0', 17:42:48 INFO - 'HOME': '/home/cltbld', 17:42:48 INFO - 'LANG': 'en_US.UTF-8', 17:42:48 INFO - 'LANGUAGE': 'en_US:en', 17:42:48 INFO - 'LOGNAME': 'cltbld', 17:42:48 INFO - 'MAIL': '/var/mail/cltbld', 17:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:48 INFO - 'MOZ_NO_REMOTE': '1', 17:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:48 INFO - 'NO_EM_RESTART': '1', 17:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:48 INFO - 'PWD': '/builds/slave/test', 17:42:48 INFO - 'SHELL': '/bin/bash', 17:42:48 INFO - 'SHLVL': '1', 17:42:48 INFO - 'TERM': 'linux', 17:42:48 INFO - 'TMOUT': '86400', 17:42:48 INFO - 'USER': 'cltbld', 17:42:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:48 INFO - '_': '/tools/buildbot/bin/python'} 17:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:42:48 INFO - Cleaning up... 17:42:48 INFO - Return code: 0 17:42:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:48 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 0x116c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ddb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:42:48 INFO - Using env: {'DISPLAY': ':0', 17:42:48 INFO - 'HOME': '/home/cltbld', 17:42:48 INFO - 'LANG': 'en_US.UTF-8', 17:42:48 INFO - 'LANGUAGE': 'en_US:en', 17:42:48 INFO - 'LOGNAME': 'cltbld', 17:42:48 INFO - 'MAIL': '/var/mail/cltbld', 17:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:48 INFO - 'MOZ_NO_REMOTE': '1', 17:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:48 INFO - 'NO_EM_RESTART': '1', 17:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:48 INFO - 'PWD': '/builds/slave/test', 17:42:48 INFO - 'SHELL': '/bin/bash', 17:42:48 INFO - 'SHLVL': '1', 17:42:48 INFO - 'TERM': 'linux', 17:42:48 INFO - 'TMOUT': '86400', 17:42:48 INFO - 'USER': 'cltbld', 17:42:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:48 INFO - '_': '/tools/buildbot/bin/python'} 17:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:49 INFO - Downloading/unpacking psutil>=3.1.1 17:42: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 17:42: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 17:42: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 17:42: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 17:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:42:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:50 INFO - Installing collected packages: psutil 17:42:50 INFO - Running setup.py install for psutil 17:42:50 INFO - building 'psutil._psutil_linux' extension 17:42:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:42:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:42:50 INFO - building 'psutil._psutil_posix' extension 17:42:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:42:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:42:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:50 INFO - Successfully installed psutil 17:42:50 INFO - Cleaning up... 17:42:50 INFO - Return code: 0 17:42:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42: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')]} 17:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ddb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:42: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 mozsystemmonitor==0.3 17:42:50 INFO - Using env: {'DISPLAY': ':0', 17:42:50 INFO - 'HOME': '/home/cltbld', 17:42:50 INFO - 'LANG': 'en_US.UTF-8', 17:42:50 INFO - 'LANGUAGE': 'en_US:en', 17:42:50 INFO - 'LOGNAME': 'cltbld', 17:42:50 INFO - 'MAIL': '/var/mail/cltbld', 17:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:50 INFO - 'MOZ_NO_REMOTE': '1', 17:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:50 INFO - 'NO_EM_RESTART': '1', 17:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:50 INFO - 'PWD': '/builds/slave/test', 17:42:50 INFO - 'SHELL': '/bin/bash', 17:42:50 INFO - 'SHLVL': '1', 17:42:50 INFO - 'TERM': 'linux', 17:42:50 INFO - 'TMOUT': '86400', 17:42:50 INFO - 'USER': 'cltbld', 17:42:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:50 INFO - '_': '/tools/buildbot/bin/python'} 17:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:42:52 INFO - Installing collected packages: mozsystemmonitor 17:42:52 INFO - Running setup.py install for mozsystemmonitor 17:42:52 INFO - Successfully installed mozsystemmonitor 17:42:52 INFO - Cleaning up... 17:42:52 INFO - Return code: 0 17:42:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ddb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:42:52 INFO - Using env: {'DISPLAY': ':0', 17:42:52 INFO - 'HOME': '/home/cltbld', 17:42:52 INFO - 'LANG': 'en_US.UTF-8', 17:42:52 INFO - 'LANGUAGE': 'en_US:en', 17:42:52 INFO - 'LOGNAME': 'cltbld', 17:42:52 INFO - 'MAIL': '/var/mail/cltbld', 17:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:52 INFO - 'MOZ_NO_REMOTE': '1', 17:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:52 INFO - 'NO_EM_RESTART': '1', 17:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:52 INFO - 'PWD': '/builds/slave/test', 17:42:52 INFO - 'SHELL': '/bin/bash', 17:42:52 INFO - 'SHLVL': '1', 17:42:52 INFO - 'TERM': 'linux', 17:42:52 INFO - 'TMOUT': '86400', 17:42:52 INFO - 'USER': 'cltbld', 17:42:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:52 INFO - '_': '/tools/buildbot/bin/python'} 17:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:52 INFO - Downloading/unpacking jsonschema==2.5.1 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:53 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:53 INFO - warning: no files found matching '*.txt' 17:42:53 INFO - no previously-included directories found matching 'build' 17:42:53 INFO - no previously-included directories found matching 'dist' 17:42:53 INFO - no previously-included directories found matching '.git*' 17:42:53 INFO - Installing collected packages: jsonschema, functools32 17:42:53 INFO - Running setup.py install for functools32 17:42:53 INFO - warning: no files found matching '*.txt' 17:42:53 INFO - no previously-included directories found matching 'build' 17:42:53 INFO - no previously-included directories found matching 'dist' 17:42:53 INFO - no previously-included directories found matching '.git*' 17:42:53 INFO - Successfully installed jsonschema functools32 17:42:53 INFO - Cleaning up... 17:42:54 INFO - Return code: 0 17:42:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:54 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 0x116c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ddb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:42:54 INFO - Using env: {'DISPLAY': ':0', 17:42:54 INFO - 'HOME': '/home/cltbld', 17:42:54 INFO - 'LANG': 'en_US.UTF-8', 17:42:54 INFO - 'LANGUAGE': 'en_US:en', 17:42:54 INFO - 'LOGNAME': 'cltbld', 17:42:54 INFO - 'MAIL': '/var/mail/cltbld', 17:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:54 INFO - 'MOZ_NO_REMOTE': '1', 17:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:54 INFO - 'NO_EM_RESTART': '1', 17:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:54 INFO - 'PWD': '/builds/slave/test', 17:42:54 INFO - 'SHELL': '/bin/bash', 17:42:54 INFO - 'SHLVL': '1', 17:42:54 INFO - 'TERM': 'linux', 17:42:54 INFO - 'TMOUT': '86400', 17:42:54 INFO - 'USER': 'cltbld', 17:42:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:54 INFO - '_': '/tools/buildbot/bin/python'} 17:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:42:54 INFO - Cleaning up... 17:42:54 INFO - Return code: 0 17:42:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:54 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 0x116c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ddb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:42:54 INFO - Using env: {'DISPLAY': ':0', 17:42:54 INFO - 'HOME': '/home/cltbld', 17:42:54 INFO - 'LANG': 'en_US.UTF-8', 17:42:54 INFO - 'LANGUAGE': 'en_US:en', 17:42:54 INFO - 'LOGNAME': 'cltbld', 17:42:54 INFO - 'MAIL': '/var/mail/cltbld', 17:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:54 INFO - 'MOZ_NO_REMOTE': '1', 17:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:54 INFO - 'NO_EM_RESTART': '1', 17:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:54 INFO - 'PWD': '/builds/slave/test', 17:42:54 INFO - 'SHELL': '/bin/bash', 17:42:54 INFO - 'SHLVL': '1', 17:42:54 INFO - 'TERM': 'linux', 17:42:54 INFO - 'TMOUT': '86400', 17:42:54 INFO - 'USER': 'cltbld', 17:42:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:54 INFO - '_': '/tools/buildbot/bin/python'} 17:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:54 INFO - Downloading/unpacking blobuploader==1.2.4 17:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:55 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:56 INFO - Downloading docopt-0.6.1.tar.gz 17:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:56 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:56 INFO - Running setup.py install for blobuploader 17:42:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:56 INFO - Running setup.py install for requests 17:42:56 INFO - Running setup.py install for docopt 17:42:56 INFO - Successfully installed blobuploader requests docopt 17:42:56 INFO - Cleaning up... 17:42:56 INFO - Return code: 0 17:42:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:56 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 0x116c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ddb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:42:56 INFO - Using env: {'DISPLAY': ':0', 17:42:56 INFO - 'HOME': '/home/cltbld', 17:42:56 INFO - 'LANG': 'en_US.UTF-8', 17:42:56 INFO - 'LANGUAGE': 'en_US:en', 17:42:56 INFO - 'LOGNAME': 'cltbld', 17:42:56 INFO - 'MAIL': '/var/mail/cltbld', 17:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:56 INFO - 'MOZ_NO_REMOTE': '1', 17:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:56 INFO - 'NO_EM_RESTART': '1', 17:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:56 INFO - 'PWD': '/builds/slave/test', 17:42:56 INFO - 'SHELL': '/bin/bash', 17:42:56 INFO - 'SHLVL': '1', 17:42:56 INFO - 'TERM': 'linux', 17:42:56 INFO - 'TMOUT': '86400', 17:42:56 INFO - 'USER': 'cltbld', 17:42:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:56 INFO - '_': '/tools/buildbot/bin/python'} 17:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:57 INFO - Running setup.py (path:/tmp/pip-2d8RB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:57 INFO - Running setup.py (path:/tmp/pip-LXhevB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:57 INFO - Running setup.py (path:/tmp/pip-lpTfqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:57 INFO - Running setup.py (path:/tmp/pip-3j74uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:57 INFO - Running setup.py (path:/tmp/pip-Z3StvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:57 INFO - Running setup.py (path:/tmp/pip-rsarFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:57 INFO - Running setup.py (path:/tmp/pip-aNVZ9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:57 INFO - Running setup.py (path:/tmp/pip-V8sou4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:57 INFO - Running setup.py (path:/tmp/pip-IWpHiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:57 INFO - Running setup.py (path:/tmp/pip-z5rgxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:57 INFO - Running setup.py (path:/tmp/pip-ucoyGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:57 INFO - Running setup.py (path:/tmp/pip-10iqzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:57 INFO - Running setup.py (path:/tmp/pip-AsIa4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:58 INFO - Running setup.py (path:/tmp/pip-SMSSIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:58 INFO - Running setup.py (path:/tmp/pip-zn20FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:58 INFO - Running setup.py (path:/tmp/pip-aXRZ93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:58 INFO - Running setup.py (path:/tmp/pip-ohEU8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:42:58 INFO - Running setup.py install for manifestparser 17:42:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:42:58 INFO - Running setup.py install for mozcrash 17:42:58 INFO - Running setup.py install for mozdebug 17:42:58 INFO - Running setup.py install for mozdevice 17:42:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:42:58 INFO - Running setup.py install for mozfile 17:42:58 INFO - Running setup.py install for mozhttpd 17:42:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:42:58 INFO - Running setup.py install for mozinfo 17:42:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Running setup.py install for mozInstall 17:42:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Running setup.py install for mozleak 17:42:59 INFO - Running setup.py install for mozlog 17:42:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Running setup.py install for moznetwork 17:42:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Running setup.py install for mozprocess 17:42:59 INFO - Running setup.py install for mozprofile 17:42:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Running setup.py install for mozrunner 17:42:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:42:59 INFO - Running setup.py install for mozscreenshot 17:42:59 INFO - Running setup.py install for moztest 17:42:59 INFO - Running setup.py install for mozversion 17:43:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:00 INFO - Cleaning up... 17:43:00 INFO - Return code: 0 17:43:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:00 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 0x116c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ddb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:00 INFO - Using env: {'DISPLAY': ':0', 17:43:00 INFO - 'HOME': '/home/cltbld', 17:43:00 INFO - 'LANG': 'en_US.UTF-8', 17:43:00 INFO - 'LANGUAGE': 'en_US:en', 17:43:00 INFO - 'LOGNAME': 'cltbld', 17:43:00 INFO - 'MAIL': '/var/mail/cltbld', 17:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:00 INFO - 'MOZ_NO_REMOTE': '1', 17:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:00 INFO - 'NO_EM_RESTART': '1', 17:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:00 INFO - 'PWD': '/builds/slave/test', 17:43:00 INFO - 'SHELL': '/bin/bash', 17:43:00 INFO - 'SHLVL': '1', 17:43:00 INFO - 'TERM': 'linux', 17:43:00 INFO - 'TMOUT': '86400', 17:43:00 INFO - 'USER': 'cltbld', 17:43:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:00 INFO - '_': '/tools/buildbot/bin/python'} 17:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:00 INFO - Running setup.py (path:/tmp/pip-IARRo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:00 INFO - Running setup.py (path:/tmp/pip-A2x6NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:00 INFO - Running setup.py (path:/tmp/pip-33MPek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:00 INFO - Running setup.py (path:/tmp/pip-mGl43l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:00 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)) 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:00 INFO - Running setup.py (path:/tmp/pip-qnGmmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:00 INFO - Running setup.py (path:/tmp/pip-iz0HME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:00 INFO - Running setup.py (path:/tmp/pip-k9fHdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:00 INFO - Running setup.py (path:/tmp/pip-HTXRfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:00 INFO - Running setup.py (path:/tmp/pip-mWWzZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:00 INFO - Running setup.py (path:/tmp/pip-aIBBKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:01 INFO - Running setup.py (path:/tmp/pip-SBzSCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:01 INFO - Running setup.py (path:/tmp/pip-8b2kv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:01 INFO - Running setup.py (path:/tmp/pip-EZ6cpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:01 INFO - Running setup.py (path:/tmp/pip-LNiBiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:01 INFO - Running setup.py (path:/tmp/pip-BoJZhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:01 INFO - Running setup.py (path:/tmp/pip-VWY4hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:01 INFO - Running setup.py (path:/tmp/pip-oJNg1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:43:01 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)) 17:43:01 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)) 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:43:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:02 INFO - Downloading blessings-1.6.tar.gz 17:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:43:02 INFO - Installing collected packages: blessings 17:43:02 INFO - Running setup.py install for blessings 17:43:02 INFO - Successfully installed blessings 17:43:02 INFO - Cleaning up... 17:43:02 INFO - Return code: 0 17:43:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:43:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:03 INFO - Reading from file tmpfile_stdout 17:43:03 INFO - Current package versions: 17:43:03 INFO - argparse == 1.2.1 17:43:03 INFO - blessings == 1.6 17:43:03 INFO - blobuploader == 1.2.4 17:43:03 INFO - docopt == 0.6.1 17:43:03 INFO - functools32 == 3.2.3-2 17:43:03 INFO - jsonschema == 2.5.1 17:43:03 INFO - manifestparser == 1.1 17:43:03 INFO - mozInstall == 1.13 17:43:03 INFO - mozcrash == 1.0 17:43:03 INFO - mozdebug == 0.1 17:43:03 INFO - mozdevice == 0.51 17:43:03 INFO - mozfile == 1.2 17:43:03 INFO - mozhttpd == 0.7 17:43:03 INFO - mozinfo == 0.10 17:43:03 INFO - mozleak == 0.1 17:43:03 INFO - mozlog == 3.5 17:43:03 INFO - moznetwork == 0.27 17:43:03 INFO - mozprocess == 0.25 17:43:03 INFO - mozprofile == 0.28 17:43:03 INFO - mozrunner == 6.13 17:43:03 INFO - mozscreenshot == 0.1 17:43:03 INFO - mozsystemmonitor == 0.3 17:43:03 INFO - moztest == 0.8 17:43:03 INFO - mozversion == 1.4 17:43:03 INFO - psutil == 3.1.1 17:43:03 INFO - requests == 1.2.3 17:43:03 INFO - wsgiref == 0.1.2 17:43:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:03 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 0x116c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ddb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:03 INFO - Using env: {'DISPLAY': ':0', 17:43:03 INFO - 'HOME': '/home/cltbld', 17:43:03 INFO - 'LANG': 'en_US.UTF-8', 17:43:03 INFO - 'LANGUAGE': 'en_US:en', 17:43:03 INFO - 'LOGNAME': 'cltbld', 17:43:03 INFO - 'MAIL': '/var/mail/cltbld', 17:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:03 INFO - 'MOZ_NO_REMOTE': '1', 17:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:03 INFO - 'NO_EM_RESTART': '1', 17:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:03 INFO - 'PWD': '/builds/slave/test', 17:43:03 INFO - 'SHELL': '/bin/bash', 17:43:03 INFO - 'SHLVL': '1', 17:43:03 INFO - 'TERM': 'linux', 17:43:03 INFO - 'TMOUT': '86400', 17:43:03 INFO - 'USER': 'cltbld', 17:43:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:03 INFO - '_': '/tools/buildbot/bin/python'} 17:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:43:03 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:04 INFO - Downloading marionette_driver-1.4.0.tar.gz 17:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 17:43:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 17:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:43:04 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)) 17:43:04 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)) 17:43:04 INFO - Installing collected packages: marionette-driver, simplejson 17:43:04 INFO - Running setup.py install for marionette-driver 17:43:04 INFO - Running setup.py install for simplejson 17:43:04 INFO - building 'simplejson._speedups' extension 17:43:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:43:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:43:05 INFO - Successfully installed marionette-driver simplejson 17:43:05 INFO - Cleaning up... 17:43:05 INFO - Return code: 0 17:43:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:05 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 0x116c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ddb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:43:05 INFO - Using env: {'DISPLAY': ':0', 17:43:05 INFO - 'HOME': '/home/cltbld', 17:43:05 INFO - 'LANG': 'en_US.UTF-8', 17:43:05 INFO - 'LANGUAGE': 'en_US:en', 17:43:05 INFO - 'LOGNAME': 'cltbld', 17:43:05 INFO - 'MAIL': '/var/mail/cltbld', 17:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:05 INFO - 'MOZ_NO_REMOTE': '1', 17:43:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:05 INFO - 'NO_EM_RESTART': '1', 17:43:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:05 INFO - 'PWD': '/builds/slave/test', 17:43:05 INFO - 'SHELL': '/bin/bash', 17:43:05 INFO - 'SHLVL': '1', 17:43:05 INFO - 'TERM': 'linux', 17:43:05 INFO - 'TMOUT': '86400', 17:43:05 INFO - 'USER': 'cltbld', 17:43:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:05 INFO - '_': '/tools/buildbot/bin/python'} 17:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:43:06 INFO - Cleaning up... 17:43:06 INFO - Return code: 0 17:43:06 INFO - Running post-action listener: _resource_record_post_action 17:43:06 INFO - Running post-action listener: _start_resource_monitoring 17:43:06 INFO - Starting resource monitoring. 17:43:06 INFO - [mozharness: 2017-07-18 00:43:06.201961Z] Finished create-virtualenv step (success) 17:43:06 INFO - [mozharness: 2017-07-18 00:43:06.202477Z] Running install step. 17:43:06 INFO - Running pre-action listener: _resource_record_pre_action 17:43:06 INFO - Running main action method: install 17:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:06 INFO - Reading from file tmpfile_stdout 17:43:06 INFO - Detecting whether we're running mozinstall >=1.0... 17:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:43:06 INFO - Reading from file tmpfile_stdout 17:43:06 INFO - Output received: 17:43:06 INFO - Usage: mozinstall [options] installer 17:43:06 INFO - Options: 17:43:06 INFO - -h, --help show this help message and exit 17:43:06 INFO - -d DEST, --destination=DEST 17:43:06 INFO - Directory to install application into. [default: 17:43:06 INFO - "/builds/slave/test"] 17:43:06 INFO - --app=APP Application being installed. [default: firefox] 17:43:06 INFO - mkdir: /builds/slave/test/build/application 17:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:43:24 INFO - Reading from file tmpfile_stdout 17:43:24 INFO - Output received: 17:43:24 INFO - /builds/slave/test/build/application/firefox/firefox 17:43:24 INFO - Running post-action listener: _resource_record_post_action 17:43:24 INFO - [mozharness: 2017-07-18 00:43:24.492832Z] Finished install step (success) 17:43:24 INFO - [mozharness: 2017-07-18 00:43:24.493086Z] Running setup-mitmproxy step. 17:43:24 INFO - Running pre-action listener: _resource_record_pre_action 17:43:24 INFO - Running main action method: setup_mitmproxy 17:43:24 INFO - Skipping: mitmproxy is not required 17:43:24 INFO - Running post-action listener: _resource_record_post_action 17:43:24 INFO - [mozharness: 2017-07-18 00:43:24.494230Z] Finished setup-mitmproxy step (success) 17:43:24 INFO - [mozharness: 2017-07-18 00:43:24.494451Z] Running run-tests step. 17:43:24 INFO - Running pre-action listener: _resource_record_pre_action 17:43:24 INFO - Running pre-action listener: _set_gcov_prefix 17:43:24 INFO - Running main action method: run_tests 17:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:43:24 INFO - Python 2.7.3 17:43:24 INFO - Return code: 0 17:43:24 INFO - grabbing minidump binary from tooltool 17:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:24 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 0x14dad10>, '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 0x14dbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14dc0c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:43:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:43:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:43:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:43:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:43:24 INFO - Return code: 0 17:43:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:43:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:43:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:43:24 INFO - ENV: RUST_BACKTRACE is now 1 17:43:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:43:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:43:24 INFO - Using env: {'DISPLAY': ':0', 17:43:24 INFO - 'HOME': '/home/cltbld', 17:43:24 INFO - 'LANG': 'en_US.UTF-8', 17:43:24 INFO - 'LANGUAGE': 'en_US:en', 17:43:24 INFO - 'LOGNAME': 'cltbld', 17:43:24 INFO - 'MAIL': '/var/mail/cltbld', 17:43:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:43:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:24 INFO - 'MOZ_NO_REMOTE': '1', 17:43:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:24 INFO - 'NO_EM_RESTART': '1', 17:43:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:24 INFO - 'PWD': '/builds/slave/test', 17:43:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:43:24 INFO - 'RUST_BACKTRACE': '1', 17:43:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:43:24 INFO - 'SHELL': '/bin/bash', 17:43:24 INFO - 'SHLVL': '1', 17:43:24 INFO - 'TERM': 'linux', 17:43:24 INFO - 'TMOUT': '86400', 17:43:24 INFO - 'USER': 'cltbld', 17:43:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182', 17:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:24 INFO - '_': '/tools/buildbot/bin/python'} 17:43:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:43:24 INFO - mozversion application_buildid: 20170718000101 17:43:24 INFO - mozversion application_changeset: efc0b1525edbd357818dc7195537364e76f709e7 17:43:24 INFO - mozversion application_display_name: Nightly 17:43:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:43:24 INFO - mozversion application_name: Firefox 17:43:24 INFO - mozversion application_remotingname: firefox 17:43:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:43:24 INFO - mozversion application_vendor: Mozilla 17:43:24 INFO - mozversion application_version: 56.0a1 17:43:24 INFO - mozversion platform_buildid: 20170718000101 17:43:24 INFO - mozversion platform_changeset: efc0b1525edbd357818dc7195537364e76f709e7 17:43:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:43:24 INFO - mozversion platform_version: 56.0a1 17:43:24 INFO - using testdate: 1500338604 17:43:24 INFO - actual date: 1500338604 17:43:24 INFO - starting webserver on 'localhost:57908' 17:43:24 INFO - SUITE-START | Running 2 tests 17:43:24 INFO - TEST-START | dromaeo_css 17:43:24 INFO - Initialising browser for dromaeo_css test... 17:43:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57908/getInfo.html -profile /tmp/tmpH4QsXd/profile 17:43:24 INFO - TEST-INFO | started process 2335 (/builds/slave/test/build/application/firefox/firefox http://localhost:57908/getInfo.html) 17:43:30 INFO - TEST-INFO | 2335: exit 0 17:43:30 INFO - Browser initialized. 17:43:30 INFO - Running cycle 1/1 for dromaeo_css test... 17:43:30 INFO - TEST-INFO | started process 2633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH4QsXd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:41 INFO - PID 2633 | RSS: Main: 167673856 17:43:41 INFO - PID 2633 | 17:46:40 INFO - PID 2633 | Cycle 1(1): loaded http://localhost:57908/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57908/tests/dromaeo/cssquery-ext.html) 17:46:41 INFO - PID 2633 | RSS: Main: 176164864 17:46:41 INFO - PID 2633 | 17:49:43 INFO - PID 2633 | Cycle 1(1): loaded http://localhost:57908/tests/dromaeo/cssquery-ext.html (next: http://localhost:57908/tests/dromaeo/cssquery-jquery.html) 17:49:43 INFO - PID 2633 | RSS: Main: 174202880 17:49:43 INFO - PID 2633 | 17:52:45 INFO - PID 2633 | Cycle 1(1): loaded http://localhost:57908/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57908/tests/dromaeo/cssquery-mootools.html) 17:52:46 INFO - PID 2633 | RSS: Main: 176476160 17:52:46 INFO - PID 2633 | 17:55:47 INFO - PID 2633 | Cycle 1(1): loaded http://localhost:57908/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57908/tests/dromaeo/cssquery-prototype.html) 17:55:48 INFO - PID 2633 | RSS: Main: 175407104 17:55:48 INFO - PID 2633 | 17:58:51 INFO - PID 2633 | Cycle 1(1): loaded http://localhost:57908/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57908/tests/dromaeo/cssquery-yui.html) 17:58:52 INFO - PID 2633 | RSS: Main: 174804992 17:58:52 INFO - PID 2633 | 18:01:53 INFO - PID 2633 | Cycle 1(1): loaded http://localhost:57908/tests/dromaeo/cssquery-yui.html (next: http://localhost:57908/tests/dromaeo/cssquery-dojo.html) 18:01:54 INFO - PID 2633 | RSS: Main: 177799168 18:01:54 INFO - PID 2633 | 18:01:54 INFO - PID 2633 | __start_tp_report 18:01:54 INFO - PID 2633 | _x_x_mozilla_page_load 18:01:54 INFO - PID 2633 | _x_x_mozilla_page_load_details 18:01:54 INFO - PID 2633 | |i|pagename|runs| 18:01:54 INFO - PID 2633 | |0;dojo.html;2972.9702702972963;3069.831159286239;3105.2702614885497;3116.7818252722304;3124.094012736306;5878.970605146974;5916.053431450969;5926.199963004993;6002.489788367983;6006.729697163627;5970.492508136803;5982.072778719295;5992.760289588411;6003.129546215807;6015.21802165719;5419.566434685215;5427.0773968425465;5434;5449.7275136243225;5481.177823326503;5508.586855985797;5515.4760297771845;5530.557555395579;5540.335159780832;5544.944550554504;5508.614396992212;5554.028045092113;5558.166275058753;5563.165525171236;5565.41563135871;5530.972345138289;5532.944670553304;5542.63972841766;5557.722113894289;5560.805371811987;5497.39528651848;5520.558355331564;5594.9720251398885;5613.045782216992;5706.77172913083;6078.6048906820915;6091.604045737057;6134.631922084644;6163.537734669918;6166.445019948226;6338;6489.286178520359;6513.218413790375;6529.2164940207;6579.703913323912;6516.804495865132;6528.11870397495;6532.673366331712;6550.377714117151;6561.868762624768;6076.392360763933;6081;6081.543884208658;6086.056661217518;6088.452039316483;6613.966930165367;6668.266490686021;6740.39336459721;6742.123523941857;6827.897581536281;6355.205599300088;6438.645874476855;6450.322716114834;6515.315891831384;6551.344865513506;6534.869302614016;6562.67186640666;6620.470362370998;6647.767328143492;6658.300878407795;6275.905861412082;6339.524535659844;6355.491560675227;6424.71088801005;6495.253045899687;6329.588576742497;6410.0705397718;6527.738890444424;6538.476921846241;6581.638009909501;5202.14164662834;5306.734663266821;5370.4361042090795;5400.9459905400445;5401.702906340189;4428.4243048403505;4471.7987690554;4472.686911916135;4514.277715565494;4520.434945631796;5534.972325138348;5535.557155427556;5535.6955367454375;5536.612437129443;5546.389897111315;6454.612723236621;6461.289258181596;6468.482521398277;6474.802161600119;6477.967610161919;5516.7517461714315;5517.668939863621;5598.412166722517;5607.355154157242;5611.074172761449;5662.915056274159;5714.085746280575;5715.5713321500225;5716.485516303469;5735.225744524436;5378.2470454136455;6275.717592708339;6281.937180628227;6398.168238129107;6426.485881129498;6534.934650653528;6551.279359270572;6569.080328753883;6647.867042659023;6654.600723956675;6292.52806039558;6315.5894866833505;6380.3619638035825;6410.358964103552;6414.486841052798;6252.09344645033;6261.467775239155;6285.779997700059;6297.992321228581;6517.771877984248;5537.584681148849;6433.613983161025;6438.420542151229;6439.8068057958335;6440.162778838721;6310.400511951358;6344.492440604648;6349.841253968503;6428.517861160338;6458.321876202931;6333.714982825692;6341.55609107358;6418.903716444351;6439.67801609927;6447.323031081856;6142.477889379453;6286.591371560834;6293.37066293367;6350.90473642905;6376.74493020274;6258.780942666985;6364.236291645032;6375.489960803217;6383.425491705769;6396.904046439214;6006.849828754316;6169.167162433194;6182.28903676083;6191.81424557264;6235.625862448268 18:01:54 INFO - PID 2633 | |1;ext.html;803.6222975201653;848.5545088828366;874.7944233105219;883.8232353529296;1154.3074155506702;29640.555391669117;30182.84908575457;39947.60052399471;40449.797751011276;40459.39310910339;40570.18859622806;40863.387049194214;41078;41219.58780412195;41318;7495.475316727831;7582;7650.961745191294;7675.654595543214;7677.462577619569;7505.286997735207;7607.353374963135;7631.046119235096;7635.160132385433;7655.732049378273;7553.055868016498;7589.696412143508;7703.22967703228;7738;7742.225777422241;7672.117706463772;7715.575643339642;7741.187175346564;7741.187175346592;7751.34113600339;7540.509866858637;7615.238476152396;7618.542887426716;7620.542767433916;7623.580703061385;36690.266194675954;36919.81540092309;37097.62902370996;37163.25673486542;37200.62799371999;3538.6461353864665;3554.733394995386;3572.6427357264065;3577.8032208228537;3579.1052236940764;30567.235819104477;30756.2310942226;30773.846130769427;30776.230594235098;30807.691923080707;4657.534246575349;4697.248440249544;4710.858674239778;4721.220998535237;4769.833055843029;193354;193397;227307;232225;233159;48311;48370;48479.75760121247;48528.75735621299;48668.7566562172;49677.25484117741;49745.25382119271;49830.75084624554;50045.24932126021;50070;14653.560393188221;14746;14752.704945901021;14835.629109272355;14856.777148342784;11926.224795388272;11935.641930742091;11975.28148311104;11991.22057066288;12035.819462708067;13822.170669759847;13851.961102917321;13853.307334633228;13859.168449893039;14046.719065618834;5537.390887002426;5650.802221922295;5670.347909990322;5694.743736531866;5743.741531631086;963.294967906801;980.2306836160656;983.0317137619439;1001.7044971733357;1005.8139244239838;21947.561048778934;22057.676539407687;22331.776682233296;22413.66379504309;22443.663345049838;1080.254624309224;1093.3986307530827;1097.6487523992246;1099.0273607857105;1105.1103861391657;11481.36852473122;11572.305661660159;11876.346800926032;11903.404829758478;12113.336619318614;232476;232511;233205;233625;234587;49992;50416.74791626018;50484.24273635898;50796;50860;1298.3118946958127;1341.3896677011935;1343.8320209973754;1448.978265326;1478.2608695652175;26851.73148268492;26854.462910742066;27094.458110837277;27364.042258520858;27391;35279.94160175199;35428.29143417066;45798;46934.29598556093;48622.27066594075;208337;209059;209933;210264;211196;34227;34421;34578.65421345754;34832.82583587066;35809.64190358167;44402;44979.32531012103;45332.773336133105;45633.543664564255;45696.08607827892;32005.519917200796;33265.667343326255;33378.66621333756;33380.499292511115;33604.49593256152;32116.518252225767;32831;32897.83551082229;33000.66999329976;33002.339953201285;35747.64252357443;35920.820395897856;35967.460488092176;36056.819715901256;36232.81883590565;31358.529622056143;31693.36613267768;31825.522617161223;32080.03759887207;32211.838940805144;23746.643800343354;23761.881190593936;24221.51556968886;24294.87852560726;24557.38606534851 18:01:54 INFO - PID 2633 | |2;jquery.html;570.2159530645363;574.4198359656747;580.3210244014502;581.4214856218064;603.1134232677963;16354.100524471149;21213.787862121393;22379.888100559496;22442.214522491737;22501.437464063405;18940.05299735011;19062.332818351362;19506.90246548769;19521.414357569294;21759.23842665507;3875.5155605549235;3975.840966361342;3982.2632812929555;6366.745330186787;6372.107904893319;6192.876142477147;6316.621002739827;6334.144890439778;6346.270178929436;6357.554971152022;6275.843103922392;6280.434760871521;6283.963146080914;6308.558400911938;6313.810585682414;6288.8742225155465;6295.622262664209;6298.433141017331;6313.210848643919;6323.52573556985;5494.1758736189495;5722.399148089432;5984.461398474158;6002.159697642333;6029.0353543433275;27624;27810.02664906739;28211.85894070537;28212.294692632644;28271.43457130846;1889.8110188980993;1914.5787926656114;1918.472420084474;1929.63336965976;1934.0523143659645;17085.658286834318;17765.644687106316;18055;18086.90956545222;18473.2610695572;2312.861228326306;2313.35226136682;2353.1293421434007;2355.6348765941307;2370.0519792083305;119187.40406298;125266.37366813107;125809;130110;132455.99999999904;14142.929285353714;14250.501232456814;14385.837654508587;14458.349374278183;14681.19253441071;22576.435589110075;22600.434989125402;22606;22635.43411414728;22644;9641;9978.301518893608;10162.288639795292;10331;10367.118794902366;9455.243580513543;9571.33000689945;9584.952075239718;9699.078587534173;9789.216862651114;8674.566271686517;8688.565571721389;8692.391532592785;8731.519766412908;8872.112788721077;2566.563684173695;2621.357767347012;2621.6760535929234;2647.5896236083436;2654.376221587925;950.12588418655;959.5154447004358;966.6181858165985;982.2142286171035;983.2036050798876;18084.367047153286;18207.45377638673;18333.3583324583;18510.074496275134;19150.521236968907;1040.9375437473775;1046.3408052926607;1051.117061668187;1056.0970370333407;1061.0715623829149;10178.592856285666;10191.388516689023;10336.17310615149;10595.947020265003;10645.414502202299;463604;469705;471278;473229;477198;105706.47146764371;107694;108309;110121;110374.44812775885;1173.319474704652;1183.5798291606527;1205.8070708686569;1216.519474807464;1217.6103646833105;15645.374185032471;16175;16652;16825.074620895968;17292.913535432242;50146.247806282205;50267.74866125646;51878.74060629673;52126.478735212164;52259.47740522546;65650;65742.34257657554;66307;66627.66686166538;67554.66222669052;13024.674383140497;13734.175949443066;13861.237631929936;13898.888088953061;14016.649583760487;21041.684374734697;21244.681329779756;21328.78671213268;21346.359609211748;21893.233736819137;16882;17184.65630687354;17270.82729172692;17286.481405557854;17406.651866962842;14715.264236788333;15088.094714317176;15100.16949067768;15686.450974216305;16297.755533666766;17514.38699645506;17566.297348105934;17784;17836.46490605284;17850.196741146938;13776.448942042207;13783.793243101161;13804.447822087004;13872.583822485341;13912.721745565235;16994.320227191267;17045.318187272867;17134.657306854042;17163.399281025104;17211.31154753796 18:01:54 INFO - PID 2633 | |3;mootools.html;1361.3873756809435;1391.6103491022511;1403.9789403158954;1414.2292450614414;1422.7865820126979;13237.735245295089;13705.520306789263;13810.447582096704;13821.861781382184;13910.095843770161;13901;14126.081804682713;14185.574432767007;14195.71608567828;14262.144271343726;2621.488809682108;2681.691605465367;2684.5033668771243;2684.6375739275145;2687.811853170279;2598.8570628615416;2652.0452637050744;2660.960085598708;2663.0279947819004;2668.8932442702267;2626.356542647054;2645.3254420122844;2663.6004599310063;2668.8265262757955;2669.412729199573;2545.5545279576;2560.014394458128;2572.34405226666;2576.8711564421706;2585.250277419546;2478.368016155887;2482.2429159106464;2483.6836476667395;2486.1422809130822;2505.6617356656984;13101.41043653038;13428.19430834153;13436.596902092855;13453;13469.326533673375;7305.963470182668;7583.582902940336;7627.351675107622;7630.198829122917;7669.271419215165;4840.927386089176;4903.877403064952;4949.232868905326;5030.84907452777;5077.238414237894;1879.2952642758964;1897.9715304270446;1898.0889173196942;1930.1217945834612;1936.2932529626726;20648.896755516278;21206.999999999847;22143.224987125534;22321.330360089225;22374.9931253094;5566.693831839288;5772.797952071657;6353.841153971188;6563.442107420828;6567.573107747981;15609.843901561066;15723.528294151194;15729.842701573067;15731.213439327988;15734.291956861969;7224.927750722425;7429.145648250413;7441.367483763941;7447.329740323288;7452.552846829208;6807.897881531781;6970.93029069713;7038.085048943707;7039.26087760788;7102.715891364391;4816.133096042676;4890.119778439915;4898.093852637274;4937.555619994146;4994.8251811187165;1433.8422773494908;1448.160067161044;1448.9565313040625;1458.8541145885538;1471.830739464954;889.7686601483531;907.6777743900952;917.6879860847343;929.4237572704966;935.91108844661;7327.5969821659255;7430.814229644302;7751.534907905544;8271.090180080186;8340.332773378115;704.4822055788991;710.1974768511549;733.9853202935911;742.8180095876545;750.0399488654531;4497.662675299365;4572.4055872736335;4573.222552166139;4601.562851529099;4606.378138951266;17406.47780566585;17755.73366399505;18212;18430.447086587425;18471.815281847277;17735;17824.19791109403;18171.182296796676;18324;18477;9509.239260859114;9893.307468477138;10094.899051009395;10109.494525273707;10276.537555810006;7632.045994250719;7704.653290601825;7827.92172078272;7898.170692077249;8000.119986801564;15107.960425342439;15346.925715200276;15618.687626247638;15872.841271587136;15919;15921.920390397974;16388.83611163873;16504.25730842091;16566.83433165701;16653.41713040038;10136.949315253376;10155.339902906288;10164.390136591828;10267.897321026992;10286.639967601099;12542.12205145631;12706.618801435972;12718.745625087631;12744.235345879277;12835.743285134431;10442.600276625137;10517.579296828042;10551.525181366704;10749.677509674722;11015.889841101487;9639.373440726331;9742.07450292221;9750.561224744763;9882.654107106217;9976.102150806462;8416.873746893923;8489.87265191035;8514.531700756517;8519.23326900582;8576.185262400062;6841.657917104224;7040.683169257293;7204.53170543913;7204.783856484314;7223.927760722326;6906;7100.147982241958;7195.928040719526;7223.674934627849;7273.236310187354 18:01:54 INFO - PID 2633 | |4;prototype.html;494.46103746915855;500.7220992349246;518.3417060333375;523.128990231265;531.9998403002355;6115.327313995457;6133.2026836511195;6157.815265542035;6169.660668663222;6244.188255526781;5835.912461313083;6013.308469526006;6017.127516510103;6036.4265394787535;6104.969475152618;4826.61387089032;4845.685030473026;4905.190643543829;4922.21244600864;4939.753012349386;4791.425028996526;4869.366982292297;4926.605871530269;4927.556519913207;4928.732782919861;4810.86944568028;4839.153148199069;4851.393575803025;4855.32025516428;4906.5093490650825;4663.160631086403;4830.430110214194;4864.124457597631;4867.51324867514;4870.951290487085;4358.542353052915;4380.167768124046;4395.4725432947935;4397.582229688174;4409.382686423904;5860.208871802295;5860.619059761102;5874.38725184013;5876.882462350772;5944.940550594482;5593.105103183471;5620.887582248373;5647.8588035299035;5668.348139963874;5672.461116193955;6321.60924596588;6353.491720662336;6415.807525774234;6457.16056912603;6490.902636460457;4824.903501929977;4827.9034419311765;4850.296706977504;4851.878703032417;4876.439209490918;6794.3545363190415;6804.897926531106;6838.589684618939;6895.5173137879865;6949.235584085746;5015.448300686921;5018.974905125524;5028.899422011539;5030.84907452777;5033.697978121324;5019.7490125494305;5055.34280543527;5079.517445842639;5091.2363145527725;5091.847244582668;5600.943990560124;5602.243697100839;5603.439656034364;5613.747381367848;5625.943740562624;6315.5263355247625;6398.2322121344805;6413.967930160413;6440.355964403522;6461.578452740389;1734.965300693979;1735.5747841778846;1736.6179440523065;1752.8510076643372;1755.824417558234;1133.8469306643663;1205.8372119763894;1219.439058033297;1221.2184202110657;1222.87771222877;5375.650582712111;5437.918431223535;5473.959947609941;5513.807016754395;5615.719214039282;6409.67951602418;6456.580322279036;6540.70566824494;6604.2074951005225;6661.966690166518;5564.165375193753;5583.078791999355;5596.888062238732;5625.4374562544235;5639.125935480007;3427.2974040321674;3496.8426420811124;3505.158761897177;3517.2437925846066;3522.876699315512;6316.315565884573;6360.268569114519;6365.968170159213;6415.326390728999;6427.618062116668;6715.5299129060495;6727.29363416844;6727.831804204836;6798;6840.897386539206;6296.024116261895;6334.461570766352;6375.872482550323;6397.584157029778;6404.647744374104;6364.936350636434;6457;6540.771073012612;6588.571742836701;6625.768098116543;6455.548111632141;6486.99451585005;6495.9025614614875;6555.96722016406;6586.37429444202;6399.776007839703;6417.8716425672155;6423.389777971085;6425.040362689238;6439.388258115471;4874.635102171398;4897.926531102107;4900.656954013328;4912.336834527293;4922.507749225048;6581.243157036811;6592.736290548516;6621.337866213533;6650.567713098633;6650.567713098633;6381.416260771824;6384.626530826399;6409.551331406757;6413.198350206224;6416.679166041773;6343.3339499351905;6377.362263773585;6396.456301214263;6412.6793660317735;6452.22573291208;6362.491000719839;6389;6406.295307516262;6442.581232219891;6444.8388790280615;6343.365663433619;6355.841103972438;6359.8092057238355;6383.680815959091;6432.710528026344;5825;6100;6134.8159555213415;6170.413810687977;6171.290301615371 18:01:54 INFO - PID 2633 | |5;yui.html;881.6120906801008;892.4600616626936;912.863070539419;928.8885333759949;930.8138372325534;17472.475825725218;17629.911850440763;17771.91114044428;18217.180226889788;18599.814001859977;19605.50986225345;19789.703154452658;20795.688064679005;20919.68620470694;20923.476913077142;1011.3224139826316;1038.85456036155;1042.1142029275131;1044.6134930075882;1046.822040253155;1041.5625437316346;1043.7860238651058;1045.994770026149;1046.4349251404233;1052.3896140238644;948.9572969216367;1045.2839804733744;1112.8775834658222;1113.3097479562682;1117.357519426329;1077.7898309829548;1090.6455401994303;1091.6288461922984;1093.1855767453258;1095.1950316517393;798.480987358216;800.5236884053978;803.1446509467398;803.5419810707899;805;18084.728729069073;18337.449876503728;18589.535261618432;18596.535086622807;19656.410307690792;20006.299779507648;20235.494112647302;20569.691454628042;20725.792742072535;20754.584908301902;15449;15606.141662208687;15911.92044039784;15930.522084337488;15943.601409964727;3506.386382383073;3528.329617372691;3531.2937412517344;3548.716102711777;3557.9110522236892;106795;106981;110631.44684276608;111420;112388.43805780918;16208.270627821776;16569.751453728204;16580.75128873068;16581;16581.58546036359;28044.579331310048;29785.85107074451;29839.701602984125;29948.85025574858;30031.849840751092;8676.175763302475;8724.8691269631;8743.56282185888;8747.868781968276;8788.42875213109;4007.3788562772816;4161.91676166475;4191.161767646483;4221.345691417835;4226.1336426032585;4764.2615394613895;4792.185328494094;4811.254255590319;4833.226683730657;4847.224444088999;837.7821766340795;1039.6361273554196;1050.8791488978713;1064.9094826939643;1077.6928575355985;573.8651416917021;672.1497305908031;683.9794806155824;698.9231184569693;715.6636380901073;11686.70783230409;11807.822882656767;12069.758604827854;12321.815172772416;12465;651.4983462733669;684.2439104789137;695.9965200174069;708.0229283588718;710.0733542726688;5071.18860982241;5195.2595880380495;5208.921866172011;5245.55518449663;5338.546223570962;98400.50799745956;100087;102445;102448;104352.47823760833;88619;91494.54252728827;92514.07485925054;92860.53569732243;96409;76528.85206721904;80014.19985800068;80922;81865.18134818575;82409;10781.730456738644;12079.75840483203;12669.303188324731;12698.809517857055;12960.092793504742;34922.65077349194;36237.27525449529;36401.635983639826;37448.812755936044;38530;64531.677341612994;64871.67564162149;65754;69000.96498552625;69161.30838691548;18259.360922367654;18654.34709785151;18686.90656546763;18754.71867921955;18916.337928172998;19887;20352.389428317176;20721.481962951046;20842.47893802667;21268;18500;18706.532336691693;19062.523436914187;19099.8090019098;19401.2239510418;18886.52783680419;19614.921179334702;19630.705539416635;19748.802511974696;20051.799482005576;18196.36312729101;18737.90631046836;19025.33411330597;19109.934568702527;19156.521086972938;12468.563600273947;12643.735626437283;12773.552925647558;12996.350182491027;13041.543545976225;14103;14466.132032078109;14514.782278265624;14751.92624036873;14760.852391475948 18:01:54 INFO - PID 2633 | __end_tp_report 18:01:54 INFO - PID 2633 | __start_cc_report 18:01:54 INFO - PID 2633 | _x_x_mozilla_cycle_collect,373 18:01:54 INFO - PID 2633 | __end_cc_report 18:01:54 INFO - PID 2633 | __startTimestamp1500339714201__endTimestamp 18:01:54 INFO - PID 2633 | 18:01:54 INFO - PID 2633 | ------- Summary: start ------- 18:01:54 INFO - PID 2633 | Number of tests: 6 18:01:54 INFO - PID 2633 | 18:01:54 INFO - PID 2633 | [#0] dojo.html Cycles:165 Average:5967.09 Median:6235.63 stddev:712.99 (11.4%) stddev-sans-first:675.38 18:01:54 INFO - PID 2633 | Values: 2973.0 3069.8 3105.3 3116.8 3124.1 5879.0 5916.1 5926.2 6002.5 6006.7 5970.5 5982.1 5992.8 6003.1 6015.2 5419.6 5427.1 5434.0 5449.7 5481.2 5508.6 5515.5 5530.6 5540.3 5544.9 5508.6 5554.0 5558.2 5563.2 5565.4 5531.0 5532.9 5542.6 5557.7 5560.8 5497.4 5520.6 5595.0 5613.0 5706.8 6078.6 6091.6 6134.6 6163.5 6166.4 6338.0 6489.3 6513.2 6529.2 6579.7 6516.8 6528.1 6532.7 6550.4 6561.9 6076.4 6081.0 6081.5 6086.1 6088.5 6614.0 6668.3 6740.4 6742.1 6827.9 6355.2 6438.6 6450.3 6515.3 6551.3 6534.9 6562.7 6620.5 6647.8 6658.3 6275.9 6339.5 6355.5 6424.7 6495.3 6329.6 6410.1 6527.7 6538.5 6581.6 5202.1 5306.7 5370.4 5400.9 5401.7 4428.4 4471.8 4472.7 4514.3 4520.4 5535.0 5535.6 5535.7 5536.6 5546.4 6454.6 6461.3 6468.5 6474.8 6478.0 5516.8 5517.7 5598.4 5607.4 5611.1 5662.9 5714.1 5715.6 5716.5 5735.2 5378.2 6275.7 6281.9 6398.2 6426.5 6534.9 6551.3 6569.1 6647.9 6654.6 6292.5 6315.6 6380.4 6410.4 6414.5 6252.1 6261.5 6285.8 6298.0 6517.8 5537.6 6433.6 6438.4 6439.8 6440.2 6310.4 6344.5 6349.8 6428.5 6458.3 6333.7 6341.6 6418.9 6439.7 6447.3 6142.5 6286.6 6293.4 6350.9 6376.7 6258.8 6364.2 6375.5 6383.4 6396.9 6006.8 6169.2 6182.3 6191.8 6235.6 18:01:54 INFO - PID 2633 | 18:01:54 INFO - PID 2633 | [#1] ext.html Cycles:180 Average:38644.51 Median:19483.47 stddev:57108.91 (293.1%) stddev-sans-first:57198.44 18:01:54 INFO - PID 2633 | Values: 803.6 848.6 874.8 883.8 1154.3 29640.6 30182.8 39947.6 40449.8 40459.4 40570.2 40863.4 41078.0 41219.6 41318.0 7495.5 7582.0 7651.0 7675.7 7677.5 7505.3 7607.4 7631.0 7635.2 7655.7 7553.1 7589.7 7703.2 7738.0 7742.2 7672.1 7715.6 7741.2 7741.2 7751.3 7540.5 7615.2 7618.5 7620.5 7623.6 36690.3 36919.8 37097.6 37163.3 37200.6 3538.6 3554.7 3572.6 3577.8 3579.1 30567.2 30756.2 30773.8 30776.2 30807.7 4657.5 4697.2 4710.9 4721.2 4769.8 193354.0 193397.0 227307.0 232225.0 233159.0 48311.0 48370.0 48479.8 48528.8 48668.8 49677.3 49745.3 49830.8 50045.2 50070.0 14653.6 14746.0 14752.7 14835.6 14856.8 11926.2 11935.6 11975.3 11991.2 12035.8 13822.2 13852.0 13853.3 13859.2 14046.7 5537.4 5650.8 5670.3 5694.7 5743.7 963.3 980.2 983.0 1001.7 1005.8 21947.6 22057.7 22331.8 22413.7 22443.7 1080.3 1093.4 1097.6 1099.0 1105.1 11481.4 11572.3 11876.3 11903.4 12113.3 232476.0 232511.0 233205.0 233625.0 234587.0 49992.0 50416.7 50484.2 50796.0 50860.0 1298.3 1341.4 1343.8 1449.0 1478.3 26851.7 26854.5 27094.5 27364.0 27391.0 35279.9 35428.3 45798.0 46934.3 48622.3 208337.0 209059.0 209933.0 210264.0 211196.0 34227.0 34421.0 34578.7 34832.8 35809.6 44402.0 44979.3 45332.8 45633.5 45696.1 32005.5 33265.7 33378.7 33380.5 33604.5 32116.5 32831.0 32897.8 33000.7 33002.3 35747.6 35920.8 35967.5 36056.8 36232.8 31358.5 31693.4 31825.5 32080.0 32211.8 23746.6 23761.9 24221.5 24294.9 24557.4 18:01:54 INFO - PID 2633 | 18:01:54 INFO - PID 2633 | [#2] jquery.html Cycles:180 Average:32717.94 Median:21286.73 stddev:79101.03 (371.6%) stddev-sans-first:79286.11 18:01:54 INFO - PID 2633 | Values: 570.2 574.4 580.3 581.4 603.1 16354.1 21213.8 22379.9 22442.2 22501.4 18940.1 19062.3 19506.9 19521.4 21759.2 3875.5 3975.8 3982.3 6366.7 6372.1 6192.9 6316.6 6334.1 6346.3 6357.6 6275.8 6280.4 6284.0 6308.6 6313.8 6288.9 6295.6 6298.4 6313.2 6323.5 5494.2 5722.4 5984.5 6002.2 6029.0 27624.0 27810.0 28211.9 28212.3 28271.4 1889.8 1914.6 1918.5 1929.6 1934.1 17085.7 17765.6 18055.0 18086.9 18473.3 2312.9 2313.4 2353.1 2355.6 2370.1 119187.4 125266.4 125809.0 130110.0 132456.0 14142.9 14250.5 14385.8 14458.3 14681.2 22576.4 22600.4 22606.0 22635.4 22644.0 9641.0 9978.3 10162.3 10331.0 10367.1 9455.2 9571.3 9585.0 9699.1 9789.2 8674.6 8688.6 8692.4 8731.5 8872.1 2566.6 2621.4 2621.7 2647.6 2654.4 950.1 959.5 966.6 982.2 983.2 18084.4 18207.5 18333.4 18510.1 19150.5 1040.9 1046.3 1051.1 1056.1 1061.1 10178.6 10191.4 10336.2 10595.9 10645.4 463604.0 469705.0 471278.0 473229.0 477198.0 105706.5 107694.0 108309.0 110121.0 110374.4 1173.3 1183.6 1205.8 1216.5 1217.6 15645.4 16175.0 16652.0 16825.1 17292.9 50146.2 50267.7 51878.7 52126.5 52259.5 65650.0 65742.3 66307.0 66627.7 67554.7 13024.7 13734.2 13861.2 13898.9 14016.6 21041.7 21244.7 21328.8 21346.4 21893.2 16882.0 17184.7 17270.8 17286.5 17406.7 14715.3 15088.1 15100.2 15686.5 16297.8 17514.4 17566.3 17784.0 17836.5 17850.2 13776.4 13783.8 13804.4 13872.6 13912.7 16994.3 17045.3 17134.7 17163.4 17211.3 18:01:54 INFO - PID 2633 | 18:01:54 INFO - PID 2633 | [#3] mootools.html Cycles:180 Average:8347.56 Median:2635.84 stddev:5609.12 (212.8%) stddev-sans-first:5600.29 18:01:54 INFO - PID 2633 | Values: 1361.4 1391.6 1404.0 1414.2 1422.8 13237.7 13705.5 13810.4 13821.9 13910.1 13901.0 14126.1 14185.6 14195.7 14262.1 2621.5 2681.7 2684.5 2684.6 2687.8 2598.9 2652.0 2661.0 2663.0 2668.9 2626.4 2645.3 2663.6 2668.8 2669.4 2545.6 2560.0 2572.3 2576.9 2585.3 2478.4 2482.2 2483.7 2486.1 2505.7 13101.4 13428.2 13436.6 13453.0 13469.3 7306.0 7583.6 7627.4 7630.2 7669.3 4840.9 4903.9 4949.2 5030.8 5077.2 1879.3 1898.0 1898.1 1930.1 1936.3 20648.9 21207.0 22143.2 22321.3 22375.0 5566.7 5772.8 6353.8 6563.4 6567.6 15609.8 15723.5 15729.8 15731.2 15734.3 7224.9 7429.1 7441.4 7447.3 7452.6 6807.9 6970.9 7038.1 7039.3 7102.7 4816.1 4890.1 4898.1 4937.6 4994.8 1433.8 1448.2 1449.0 1458.9 1471.8 889.8 907.7 917.7 929.4 935.9 7327.6 7430.8 7751.5 8271.1 8340.3 704.5 710.2 734.0 742.8 750.0 4497.7 4572.4 4573.2 4601.6 4606.4 17406.5 17755.7 18212.0 18430.4 18471.8 17735.0 17824.2 18171.2 18324.0 18477.0 9509.2 9893.3 10094.9 10109.5 10276.5 7632.0 7704.7 7827.9 7898.2 8000.1 15108.0 15346.9 15618.7 15872.8 15919.0 15921.9 16388.8 16504.3 16566.8 16653.4 10136.9 10155.3 10164.4 10267.9 10286.6 12542.1 12706.6 12718.7 12744.2 12835.7 10442.6 10517.6 10551.5 10749.7 11015.9 9639.4 9742.1 9750.6 9882.7 9976.1 8416.9 8489.9 8514.5 8519.2 8576.2 6841.7 7040.7 7204.5 7204.8 7223.9 6906.0 7100.1 7195.9 7223.7 7273.2 18:01:54 INFO - PID 2633 | 18:01:54 INFO - PID 2633 | [#4] prototype.html Cycles:180 Average:5401.46 Median:5910.91 stddev:1509.22 (25.5%) stddev-sans-first:1467.83 18:01:54 INFO - PID 2633 | Values: 494.5 500.7 518.3 523.1 532.0 6115.3 6133.2 6157.8 6169.7 6244.2 5835.9 6013.3 6017.1 6036.4 6105.0 4826.6 4845.7 4905.2 4922.2 4939.8 4791.4 4869.4 4926.6 4927.6 4928.7 4810.9 4839.2 4851.4 4855.3 4906.5 4663.2 4830.4 4864.1 4867.5 4871.0 4358.5 4380.2 4395.5 4397.6 4409.4 5860.2 5860.6 5874.4 5876.9 5944.9 5593.1 5620.9 5647.9 5668.3 5672.5 6321.6 6353.5 6415.8 6457.2 6490.9 4824.9 4827.9 4850.3 4851.9 4876.4 6794.4 6804.9 6838.6 6895.5 6949.2 5015.4 5019.0 5028.9 5030.8 5033.7 5019.7 5055.3 5079.5 5091.2 5091.8 5600.9 5602.2 5603.4 5613.7 5625.9 6315.5 6398.2 6414.0 6440.4 6461.6 1735.0 1735.6 1736.6 1752.9 1755.8 1133.8 1205.8 1219.4 1221.2 1222.9 5375.7 5437.9 5474.0 5513.8 5615.7 6409.7 6456.6 6540.7 6604.2 6662.0 5564.2 5583.1 5596.9 5625.4 5639.1 3427.3 3496.8 3505.2 3517.2 3522.9 6316.3 6360.3 6366.0 6415.3 6427.6 6715.5 6727.3 6727.8 6798.0 6840.9 6296.0 6334.5 6375.9 6397.6 6404.6 6364.9 6457.0 6540.8 6588.6 6625.8 6455.5 6487.0 6495.9 6556.0 6586.4 6399.8 6417.9 6423.4 6425.0 6439.4 4874.6 4897.9 4900.7 4912.3 4922.5 6581.2 6592.7 6621.3 6650.6 6650.6 6381.4 6384.6 6409.6 6413.2 6416.7 6343.3 6377.4 6396.5 6412.7 6452.2 6362.5 6389.0 6406.3 6442.6 6444.8 6343.4 6355.8 6359.8 6383.7 6432.7 5825.0 6100.0 6134.8 6170.4 6171.3 18:01:54 INFO - PID 2633 | 18:01:54 INFO - PID 2633 | [#5] yui.html Cycles:180 Average:22488.70 Median:19702.61 stddev:29207.17 (148.2%) stddev-sans-first:29244.04 18:01:54 INFO - PID 2633 | Values: 881.6 892.5 912.9 928.9 930.8 17472.5 17629.9 17771.9 18217.2 18599.8 19605.5 19789.7 20795.7 20919.7 20923.5 1011.3 1038.9 1042.1 1044.6 1046.8 1041.6 1043.8 1046.0 1046.4 1052.4 949.0 1045.3 1112.9 1113.3 1117.4 1077.8 1090.6 1091.6 1093.2 1095.2 798.5 800.5 803.1 803.5 805.0 18084.7 18337.4 18589.5 18596.5 19656.4 20006.3 20235.5 20569.7 20725.8 20754.6 15449.0 15606.1 15911.9 15930.5 15943.6 3506.4 3528.3 3531.3 3548.7 3557.9 106795.0 106981.0 110631.4 111420.0 112388.4 16208.3 16569.8 16580.8 16581.0 16581.6 28044.6 29785.9 29839.7 29948.9 30031.8 8676.2 8724.9 8743.6 8747.9 8788.4 4007.4 4161.9 4191.2 4221.3 4226.1 4764.3 4792.2 4811.3 4833.2 4847.2 837.8 1039.6 1050.9 1064.9 1077.7 573.9 672.1 684.0 698.9 715.7 11686.7 11807.8 12069.8 12321.8 12465.0 651.5 684.2 696.0 708.0 710.1 5071.2 5195.3 5208.9 5245.6 5338.5 98400.5 100087.0 102445.0 102448.0 104352.5 88619.0 91494.5 92514.1 92860.5 96409.0 76528.9 80014.2 80922.0 81865.2 82409.0 10781.7 12079.8 12669.3 12698.8 12960.1 34922.7 36237.3 36401.6 37448.8 38530.0 64531.7 64871.7 65754.0 69001.0 69161.3 18259.4 18654.3 18686.9 18754.7 18916.3 19887.0 20352.4 20721.5 20842.5 21268.0 18500.0 18706.5 19062.5 19099.8 19401.2 18886.5 19614.9 19630.7 19748.8 20051.8 18196.4 18737.9 19025.3 19109.9 19156.5 12468.6 12643.7 12773.6 12996.4 13041.5 14103.0 14466.1 14514.8 14751.9 14760.9 18:01:54 INFO - PID 2633 | -------- Summary: end -------- 18:01:54 INFO - PID 2633 | 18:01:54 INFO - TEST-INFO | 2633: exit 0 18:01:54 INFO - TEST-OK | dromaeo_css | took 1110039ms 18:01:54 INFO - TEST-START | kraken 18:01:54 INFO - Initialising browser for kraken test... 18:01:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57908/getInfo.html -profile /tmp/tmpteW1Nz/profile 18:01:54 INFO - TEST-INFO | started process 3138 (/builds/slave/test/build/application/firefox/firefox http://localhost:57908/getInfo.html) 18:02:00 INFO - TEST-INFO | 3138: exit 0 18:02:00 INFO - Browser initialized. 18:02:00 INFO - Running cycle 1/1 for kraken test... 18:02:00 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpteW1Nz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:02:11 INFO - PID 3340 | RSS: Main: 167497728 18:02:11 INFO - PID 3340 | 18:02:14 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57908/tests/kraken/driver.html?testName=audio-beat-detection) 18:02:15 INFO - PID 3340 | RSS: Main: 173723648 18:02:15 INFO - PID 3340 | 18:02:17 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57908/tests/kraken/driver.html?testName=audio-dft) 18:02:18 INFO - PID 3340 | RSS: Main: 174125056 18:02:18 INFO - PID 3340 | 18:02:21 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57908/tests/kraken/driver.html?testName=audio-fft) 18:02:22 INFO - PID 3340 | RSS: Main: 168640512 18:02:22 INFO - PID 3340 | 18:02:24 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57908/tests/kraken/driver.html?testName=audio-oscillator) 18:02:24 INFO - PID 3340 | RSS: Main: 168898560 18:02:24 INFO - PID 3340 | 18:02:26 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57908/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:02:27 INFO - PID 3340 | RSS: Main: 168689664 18:02:27 INFO - PID 3340 | 18:02:30 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57908/tests/kraken/driver.html?testName=imaging-darkroom) 18:02:31 INFO - PID 3340 | RSS: Main: 172208128 18:02:31 INFO - PID 3340 | 18:02:34 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57908/tests/kraken/driver.html?testName=imaging-desaturate) 18:02:35 INFO - PID 3340 | RSS: Main: 173830144 18:02:35 INFO - PID 3340 | 18:02:37 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57908/tests/kraken/driver.html?testName=json-parse-financial) 18:02:38 INFO - PID 3340 | RSS: Main: 173043712 18:02:38 INFO - PID 3340 | 18:02:40 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57908/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:02:40 INFO - PID 3340 | RSS: Main: 172707840 18:02:40 INFO - PID 3340 | 18:02:42 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57908/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:02:43 INFO - PID 3340 | RSS: Main: 172883968 18:02:43 INFO - PID 3340 | 18:02:45 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57908/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:02:45 INFO - PID 3340 | RSS: Main: 172777472 18:02:45 INFO - PID 3340 | 18:02:48 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:02:49 INFO - PID 3340 | RSS: Main: 172478464 18:02:49 INFO - PID 3340 | 18:02:52 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:02:52 INFO - PID 3340 | RSS: Main: 172961792 18:02:52 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | Cycle 1(1): loaded http://localhost:57908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57908/tests/kraken/driver.html?testName=ai-astar) 18:02:54 INFO - PID 3340 | RSS: Main: 174227456 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | __start_tp_report 18:02:54 INFO - PID 3340 | _x_x_mozilla_page_load 18:02:54 INFO - PID 3340 | _x_x_mozilla_page_load_details 18:02:54 INFO - PID 3340 | |i|pagename|runs| 18:02:54 INFO - PID 3340 | |0;ai-astar;100;107;109;107;110;110;109;109;109;110 18:02:54 INFO - PID 3340 | |1;audio-beat-detection;156;132;147;177;124;175;150;128;170;123 18:02:54 INFO - PID 3340 | |2;audio-dft;164;163;162;165;162;171;163;167;174;165 18:02:54 INFO - PID 3340 | |3;audio-fft;75;75;75;186;75;78;76;76;94;76 18:02:54 INFO - PID 3340 | |4;audio-oscillator;82;81;132;82;85;80;141;82;80;125 18:02:54 INFO - PID 3340 | |5;imaging-gaussian-blur;113;114;115;115;114;114;115;115;115;113 18:02:54 INFO - PID 3340 | |6;imaging-darkroom;152;150;151;149;150;151;150;151;150;150 18:02:54 INFO - PID 3340 | |7;imaging-desaturate;95;94;94;94;94;95;95;94;94;94 18:02:54 INFO - PID 3340 | |8;json-parse-financial;56;55;59;55;58;58;55;56;60;55 18:02:54 INFO - PID 3340 | |9;json-stringify-tinderbox;54;54;54;55;55;54;54;54;55;55 18:02:54 INFO - PID 3340 | |10;stanford-crypto-aes;78;76;76;79;78;78;76;82;76;76 18:02:54 INFO - PID 3340 | |11;stanford-crypto-ccm;128;144;136;132;137;124;134;129;123;146 18:02:54 INFO - PID 3340 | |12;stanford-crypto-pbkdf2;182;183;204;199;186;179;193;191;188;182 18:02:54 INFO - PID 3340 | |13;stanford-crypto-sha256-iterative;69;68;69;73;68;69;68;70;70;70 18:02:54 INFO - PID 3340 | __end_tp_report 18:02:54 INFO - PID 3340 | __start_cc_report 18:02:54 INFO - PID 3340 | _x_x_mozilla_cycle_collect,930 18:02:54 INFO - PID 3340 | __end_cc_report 18:02:54 INFO - PID 3340 | __startTimestamp1500339774908__endTimestamp 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | ------- Summary: start ------- 18:02:54 INFO - PID 3340 | Number of tests: 14 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.00 stddev:3.02 (2.8%) stddev-sans-first:1.17 18:02:54 INFO - PID 3340 | Values: 100.0 107.0 109.0 107.0 110.0 110.0 109.0 109.0 109.0 110.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:153.00 stddev:21.03 (13.7%) stddev-sans-first:22.11 18:02:54 INFO - PID 3340 | Values: 156.0 132.0 147.0 177.0 124.0 175.0 150.0 128.0 170.0 123.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:4.01 (2.4%) stddev-sans-first:4.21 18:02:54 INFO - PID 3340 | Values: 164.0 163.0 162.0 165.0 162.0 171.0 163.0 167.0 174.0 165.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#3] audio-fft Cycles:10 Average:88.60 Median:76.00 stddev:34.71 (45.7%) stddev-sans-first:36.47 18:02:54 INFO - PID 3340 | Values: 75.0 75.0 75.0 186.0 75.0 78.0 76.0 76.0 94.0 76.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:81.50 stddev:24.94 (30.6%) stddev-sans-first:25.86 18:02:54 INFO - PID 3340 | Values: 82.0 81.0 132.0 82.0 85.0 80.0 141.0 82.0 80.0 125.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 18:02:54 INFO - PID 3340 | Values: 113.0 114.0 115.0 115.0 114.0 114.0 115.0 115.0 115.0 113.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 18:02:54 INFO - PID 3340 | Values: 152.0 150.0 151.0 149.0 150.0 151.0 150.0 151.0 150.0 150.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 18:02:54 INFO - PID 3340 | Values: 95.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.89 (3.3%) stddev-sans-first:1.99 18:02:54 INFO - PID 3340 | Values: 56.0 55.0 59.0 55.0 58.0 58.0 55.0 56.0 60.0 55.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 18:02:54 INFO - PID 3340 | Values: 54.0 54.0 54.0 55.0 55.0 54.0 54.0 54.0 55.0 55.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:1.96 (2.5%) stddev-sans-first:2.07 18:02:54 INFO - PID 3340 | Values: 78.0 76.0 76.0 79.0 78.0 78.0 76.0 82.0 76.0 76.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:135.00 stddev:7.73 (5.7%) stddev-sans-first:7.96 18:02:54 INFO - PID 3340 | Values: 128.0 144.0 136.0 132.0 137.0 124.0 134.0 129.0 123.0 146.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.70 Median:189.50 stddev:8.08 (4.3%) stddev-sans-first:8.20 18:02:54 INFO - PID 3340 | Values: 182.0 183.0 204.0 199.0 186.0 179.0 193.0 191.0 188.0 182.0 18:02:54 INFO - PID 3340 | 18:02:54 INFO - PID 3340 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.51 (2.2%) stddev-sans-first:1.59 18:02:54 INFO - PID 3340 | Values: 69.0 68.0 69.0 73.0 68.0 69.0 68.0 70.0 70.0 70.0 18:02:54 INFO - PID 3340 | -------- Summary: end -------- 18:02:54 INFO - PID 3340 | 18:02:55 INFO - PID 3340 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:02:55 INFO - TEST-INFO | 3340: exit 0 18:02:55 INFO - TEST-OK | kraken | took 60846ms 18:02:55 INFO - SUITE-END | took 1170s 18:02:56 INFO - Completed test suite (00:19:31) 18:02:56 INFO - javascript benchmark 18:02:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8238.754185280894, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2972.9702702972963, 3069.831159286239, 3105.2702614885497, 3116.7818252722304, 3124.094012736306, 5878.970605146974, 5916.053431450969, 5926.199963004993, 6002.489788367983, 6006.729697163627, 5970.492508136803, 5982.072778719295, 5992.760289588411, 6003.129546215807, 6015.21802165719, 5419.566434685215, 5427.0773968425465, 5434.0, 5449.7275136243225, 5481.177823326503, 5508.586855985797, 5515.4760297771845, 5530.557555395579, 5540.335159780832, 5544.944550554504, 5508.614396992212, 5554.028045092113, 5558.166275058753, 5563.165525171236, 5565.41563135871, 5530.972345138289, 5532.944670553304, 5542.63972841766, 5557.722113894289, 5560.805371811987, 5497.39528651848, 5520.558355331564, 5594.9720251398885, 5613.045782216992, 5706.77172913083, 6078.6048906820915, 6091.604045737057, 6134.631922084644, 6163.537734669918, 6166.445019948226, 6338.0, 6489.286178520359, 6513.218413790375, 6529.2164940207, 6579.703913323912, 6516.804495865132, 6528.11870397495, 6532.673366331712, 6550.377714117151, 6561.868762624768, 6076.392360763933, 6081.0, 6081.543884208658, 6086.056661217518, 6088.452039316483, 6613.966930165367, 6668.266490686021, 6740.39336459721, 6742.123523941857, 6827.897581536281, 6355.205599300088, 6438.645874476855, 6450.322716114834, 6515.315891831384, 6551.344865513506, 6534.869302614016, 6562.67186640666, 6620.470362370998, 6647.767328143492, 6658.300878407795, 6275.905861412082, 6339.524535659844, 6355.491560675227, 6424.71088801005, 6495.253045899687, 6329.588576742497, 6410.0705397718, 6527.738890444424, 6538.476921846241, 6581.638009909501, 5202.14164662834, 5306.734663266821, 5370.4361042090795, 5400.9459905400445, 5401.702906340189, 4428.4243048403505, 4471.7987690554, 4472.686911916135, 4514.277715565494, 4520.434945631796, 5534.972325138348, 5535.557155427556, 5535.6955367454375, 5536.612437129443, 5546.389897111315, 6454.612723236621, 6461.289258181596, 6468.482521398277, 6474.802161600119, 6477.967610161919, 5516.7517461714315, 5517.668939863621, 5598.412166722517, 5607.355154157242, 5611.074172761449, 5662.915056274159, 5714.085746280575, 5715.5713321500225, 5716.485516303469, 5735.225744524436, 5378.2470454136455, 6275.717592708339, 6281.937180628227, 6398.168238129107, 6426.485881129498, 6534.934650653528, 6551.279359270572, 6569.080328753883, 6647.867042659023, 6654.600723956675, 6292.52806039558, 6315.5894866833505, 6380.3619638035825, 6410.358964103552, 6414.486841052798, 6252.09344645033, 6261.467775239155, 6285.779997700059, 6297.992321228581, 6517.771877984248, 5537.584681148849, 6433.613983161025, 6438.420542151229, 6439.8068057958335, 6440.162778838721, 6310.400511951358, 6344.492440604648, 6349.841253968503, 6428.517861160338, 6458.321876202931, 6333.714982825692, 6341.55609107358, 6418.903716444351, 6439.67801609927, 6447.323031081856, 6142.477889379453, 6286.591371560834, 6293.37066293367, 6350.90473642905, 6376.74493020274, 6258.780942666985, 6364.236291645032, 6375.489960803217, 6383.425491705769, 6396.904046439214, 6006.849828754316, 6169.167162433194, 6182.28903676083, 6191.81424557264, 6235.625862448268], "value": 5914.15021562516, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.6222975201653, 848.5545088828366, 874.7944233105219, 883.8232353529296, 1154.3074155506702, 29640.555391669117, 30182.84908575457, 39947.60052399471, 40449.797751011276, 40459.39310910339, 40570.18859622806, 40863.387049194214, 41078.0, 41219.58780412195, 41318.0, 7495.475316727831, 7582.0, 7650.961745191294, 7675.654595543214, 7677.462577619569, 7505.286997735207, 7607.353374963135, 7631.046119235096, 7635.160132385433, 7655.732049378273, 7553.055868016498, 7589.696412143508, 7703.22967703228, 7738.0, 7742.225777422241, 7672.117706463772, 7715.575643339642, 7741.187175346564, 7741.187175346592, 7751.34113600339, 7540.509866858637, 7615.238476152396, 7618.542887426716, 7620.542767433916, 7623.580703061385, 36690.266194675954, 36919.81540092309, 37097.62902370996, 37163.25673486542, 37200.62799371999, 3538.6461353864665, 3554.733394995386, 3572.6427357264065, 3577.8032208228537, 3579.1052236940764, 30567.235819104477, 30756.2310942226, 30773.846130769427, 30776.230594235098, 30807.691923080707, 4657.534246575349, 4697.248440249544, 4710.858674239778, 4721.220998535237, 4769.833055843029, 193354.0, 193397.0, 227307.0, 232225.0, 233159.0, 48311.0, 48370.0, 48479.75760121247, 48528.75735621299, 48668.7566562172, 49677.25484117741, 49745.25382119271, 49830.75084624554, 50045.24932126021, 50070.0, 14653.560393188221, 14746.0, 14752.704945901021, 14835.629109272355, 14856.777148342784, 11926.224795388272, 11935.641930742091, 11975.28148311104, 11991.22057066288, 12035.819462708067, 13822.170669759847, 13851.961102917321, 13853.307334633228, 13859.168449893039, 14046.719065618834, 5537.390887002426, 5650.802221922295, 5670.347909990322, 5694.743736531866, 5743.741531631086, 963.294967906801, 980.2306836160656, 983.0317137619439, 1001.7044971733357, 1005.8139244239838, 21947.561048778934, 22057.676539407687, 22331.776682233296, 22413.66379504309, 22443.663345049838, 1080.254624309224, 1093.3986307530827, 1097.6487523992246, 1099.0273607857105, 1105.1103861391657, 11481.36852473122, 11572.305661660159, 11876.346800926032, 11903.404829758478, 12113.336619318614, 232476.0, 232511.0, 233205.0, 233625.0, 234587.0, 49992.0, 50416.74791626018, 50484.24273635898, 50796.0, 50860.0, 1298.3118946958127, 1341.3896677011935, 1343.8320209973754, 1448.978265326, 1478.2608695652175, 26851.73148268492, 26854.462910742066, 27094.458110837277, 27364.042258520858, 27391.0, 35279.94160175199, 35428.29143417066, 45798.0, 46934.29598556093, 48622.27066594075, 208337.0, 209059.0, 209933.0, 210264.0, 211196.0, 34227.0, 34421.0, 34578.65421345754, 34832.82583587066, 35809.64190358167, 44402.0, 44979.32531012103, 45332.773336133105, 45633.543664564255, 45696.08607827892, 32005.519917200796, 33265.667343326255, 33378.66621333756, 33380.499292511115, 33604.49593256152, 32116.518252225767, 32831.0, 32897.83551082229, 33000.66999329976, 33002.339953201285, 35747.64252357443, 35920.820395897856, 35967.460488092176, 36056.819715901256, 36232.81883590565, 31358.529622056143, 31693.36613267768, 31825.522617161223, 32080.03759887207, 32211.838940805144, 23746.643800343354, 23761.881190593936, 24221.51556968886, 24294.87852560726, 24557.38606534851], "value": 17125.21995047759, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.2159530645363, 574.4198359656747, 580.3210244014502, 581.4214856218064, 603.1134232677963, 16354.100524471149, 21213.787862121393, 22379.888100559496, 22442.214522491737, 22501.437464063405, 18940.05299735011, 19062.332818351362, 19506.90246548769, 19521.414357569294, 21759.23842665507, 3875.5155605549235, 3975.840966361342, 3982.2632812929555, 6366.745330186787, 6372.107904893319, 6192.876142477147, 6316.621002739827, 6334.144890439778, 6346.270178929436, 6357.554971152022, 6275.843103922392, 6280.434760871521, 6283.963146080914, 6308.558400911938, 6313.810585682414, 6288.8742225155465, 6295.622262664209, 6298.433141017331, 6313.210848643919, 6323.52573556985, 5494.1758736189495, 5722.399148089432, 5984.461398474158, 6002.159697642333, 6029.0353543433275, 27624.0, 27810.02664906739, 28211.85894070537, 28212.294692632644, 28271.43457130846, 1889.8110188980993, 1914.5787926656114, 1918.472420084474, 1929.63336965976, 1934.0523143659645, 17085.658286834318, 17765.644687106316, 18055.0, 18086.90956545222, 18473.2610695572, 2312.861228326306, 2313.35226136682, 2353.1293421434007, 2355.6348765941307, 2370.0519792083305, 119187.40406298, 125266.37366813107, 125809.0, 130110.0, 132455.99999999904, 14142.929285353714, 14250.501232456814, 14385.837654508587, 14458.349374278183, 14681.19253441071, 22576.435589110075, 22600.434989125402, 22606.0, 22635.43411414728, 22644.0, 9641.0, 9978.301518893608, 10162.288639795292, 10331.0, 10367.118794902366, 9455.243580513543, 9571.33000689945, 9584.952075239718, 9699.078587534173, 9789.216862651114, 8674.566271686517, 8688.565571721389, 8692.391532592785, 8731.519766412908, 8872.112788721077, 2566.563684173695, 2621.357767347012, 2621.6760535929234, 2647.5896236083436, 2654.376221587925, 950.12588418655, 959.5154447004358, 966.6181858165985, 982.2142286171035, 983.2036050798876, 18084.367047153286, 18207.45377638673, 18333.3583324583, 18510.074496275134, 19150.521236968907, 1040.9375437473775, 1046.3408052926607, 1051.117061668187, 1056.0970370333407, 1061.0715623829149, 10178.592856285666, 10191.388516689023, 10336.17310615149, 10595.947020265003, 10645.414502202299, 463604.0, 469705.0, 471278.0, 473229.0, 477198.0, 105706.47146764371, 107694.0, 108309.0, 110121.0, 110374.44812775885, 1173.319474704652, 1183.5798291606527, 1205.8070708686569, 1216.519474807464, 1217.6103646833105, 15645.374185032471, 16175.0, 16652.0, 16825.074620895968, 17292.913535432242, 50146.247806282205, 50267.74866125646, 51878.74060629673, 52126.478735212164, 52259.47740522546, 65650.0, 65742.34257657554, 66307.0, 66627.66686166538, 67554.66222669052, 13024.674383140497, 13734.175949443066, 13861.237631929936, 13898.888088953061, 14016.649583760487, 21041.684374734697, 21244.681329779756, 21328.78671213268, 21346.359609211748, 21893.233736819137, 16882.0, 17184.65630687354, 17270.82729172692, 17286.481405557854, 17406.651866962842, 14715.264236788333, 15088.094714317176, 15100.16949067768, 15686.450974216305, 16297.755533666766, 17514.38699645506, 17566.297348105934, 17784.0, 17836.46490605284, 17850.196741146938, 13776.448942042207, 13783.793243101161, 13804.447822087004, 13872.583822485341, 13912.721745565235, 16994.320227191267, 17045.318187272867, 17134.657306854042, 17163.399281025104, 17211.31154753796], "value": 11288.485396025932, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.3873756809435, 1391.6103491022511, 1403.9789403158954, 1414.2292450614414, 1422.7865820126979, 13237.735245295089, 13705.520306789263, 13810.447582096704, 13821.861781382184, 13910.095843770161, 13901.0, 14126.081804682713, 14185.574432767007, 14195.71608567828, 14262.144271343726, 2621.488809682108, 2681.691605465367, 2684.5033668771243, 2684.6375739275145, 2687.811853170279, 2598.8570628615416, 2652.0452637050744, 2660.960085598708, 2663.0279947819004, 2668.8932442702267, 2626.356542647054, 2645.3254420122844, 2663.6004599310063, 2668.8265262757955, 2669.412729199573, 2545.5545279576, 2560.014394458128, 2572.34405226666, 2576.8711564421706, 2585.250277419546, 2478.368016155887, 2482.2429159106464, 2483.6836476667395, 2486.1422809130822, 2505.6617356656984, 13101.41043653038, 13428.19430834153, 13436.596902092855, 13453.0, 13469.326533673375, 7305.963470182668, 7583.582902940336, 7627.351675107622, 7630.198829122917, 7669.271419215165, 4840.927386089176, 4903.877403064952, 4949.232868905326, 5030.84907452777, 5077.238414237894, 1879.2952642758964, 1897.9715304270446, 1898.0889173196942, 1930.1217945834612, 1936.2932529626726, 20648.896755516278, 21206.999999999847, 22143.224987125534, 22321.330360089225, 22374.9931253094, 5566.693831839288, 5772.797952071657, 6353.841153971188, 6563.442107420828, 6567.573107747981, 15609.843901561066, 15723.528294151194, 15729.842701573067, 15731.213439327988, 15734.291956861969, 7224.927750722425, 7429.145648250413, 7441.367483763941, 7447.329740323288, 7452.552846829208, 6807.897881531781, 6970.93029069713, 7038.085048943707, 7039.26087760788, 7102.715891364391, 4816.133096042676, 4890.119778439915, 4898.093852637274, 4937.555619994146, 4994.8251811187165, 1433.8422773494908, 1448.160067161044, 1448.9565313040625, 1458.8541145885538, 1471.830739464954, 889.7686601483531, 907.6777743900952, 917.6879860847343, 929.4237572704966, 935.91108844661, 7327.5969821659255, 7430.814229644302, 7751.534907905544, 8271.090180080186, 8340.332773378115, 704.4822055788991, 710.1974768511549, 733.9853202935911, 742.8180095876545, 750.0399488654531, 4497.662675299365, 4572.4055872736335, 4573.222552166139, 4601.562851529099, 4606.378138951266, 17406.47780566585, 17755.73366399505, 18212.0, 18430.447086587425, 18471.815281847277, 17735.0, 17824.19791109403, 18171.182296796676, 18324.0, 18477.0, 9509.239260859114, 9893.307468477138, 10094.899051009395, 10109.494525273707, 10276.537555810006, 7632.045994250719, 7704.653290601825, 7827.92172078272, 7898.170692077249, 8000.119986801564, 15107.960425342439, 15346.925715200276, 15618.687626247638, 15872.841271587136, 15919.0, 15921.920390397974, 16388.83611163873, 16504.25730842091, 16566.83433165701, 16653.41713040038, 10136.949315253376, 10155.339902906288, 10164.390136591828, 10267.897321026992, 10286.639967601099, 12542.12205145631, 12706.618801435972, 12718.745625087631, 12744.235345879277, 12835.743285134431, 10442.600276625137, 10517.579296828042, 10551.525181366704, 10749.677509674722, 11015.889841101487, 9639.373440726331, 9742.07450292221, 9750.561224744763, 9882.654107106217, 9976.102150806462, 8416.873746893923, 8489.87265191035, 8514.531700756517, 8519.23326900582, 8576.185262400062, 6841.657917104224, 7040.683169257293, 7204.53170543913, 7204.783856484314, 7223.927760722326, 6906.0, 7100.147982241958, 7195.928040719526, 7223.674934627849, 7273.236310187354], "value": 6127.420148337382, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.46103746915855, 500.7220992349246, 518.3417060333375, 523.128990231265, 531.9998403002355, 6115.327313995457, 6133.2026836511195, 6157.815265542035, 6169.660668663222, 6244.188255526781, 5835.912461313083, 6013.308469526006, 6017.127516510103, 6036.4265394787535, 6104.969475152618, 4826.61387089032, 4845.685030473026, 4905.190643543829, 4922.21244600864, 4939.753012349386, 4791.425028996526, 4869.366982292297, 4926.605871530269, 4927.556519913207, 4928.732782919861, 4810.86944568028, 4839.153148199069, 4851.393575803025, 4855.32025516428, 4906.5093490650825, 4663.160631086403, 4830.430110214194, 4864.124457597631, 4867.51324867514, 4870.951290487085, 4358.542353052915, 4380.167768124046, 4395.4725432947935, 4397.582229688174, 4409.382686423904, 5860.208871802295, 5860.619059761102, 5874.38725184013, 5876.882462350772, 5944.940550594482, 5593.105103183471, 5620.887582248373, 5647.8588035299035, 5668.348139963874, 5672.461116193955, 6321.60924596588, 6353.491720662336, 6415.807525774234, 6457.16056912603, 6490.902636460457, 4824.903501929977, 4827.9034419311765, 4850.296706977504, 4851.878703032417, 4876.439209490918, 6794.3545363190415, 6804.897926531106, 6838.589684618939, 6895.5173137879865, 6949.235584085746, 5015.448300686921, 5018.974905125524, 5028.899422011539, 5030.84907452777, 5033.697978121324, 5019.7490125494305, 5055.34280543527, 5079.517445842639, 5091.2363145527725, 5091.847244582668, 5600.943990560124, 5602.243697100839, 5603.439656034364, 5613.747381367848, 5625.943740562624, 6315.5263355247625, 6398.2322121344805, 6413.967930160413, 6440.355964403522, 6461.578452740389, 1734.965300693979, 1735.5747841778846, 1736.6179440523065, 1752.8510076643372, 1755.824417558234, 1133.8469306643663, 1205.8372119763894, 1219.439058033297, 1221.2184202110657, 1222.87771222877, 5375.650582712111, 5437.918431223535, 5473.959947609941, 5513.807016754395, 5615.719214039282, 6409.67951602418, 6456.580322279036, 6540.70566824494, 6604.2074951005225, 6661.966690166518, 5564.165375193753, 5583.078791999355, 5596.888062238732, 5625.4374562544235, 5639.125935480007, 3427.2974040321674, 3496.8426420811124, 3505.158761897177, 3517.2437925846066, 3522.876699315512, 6316.315565884573, 6360.268569114519, 6365.968170159213, 6415.326390728999, 6427.618062116668, 6715.5299129060495, 6727.29363416844, 6727.831804204836, 6798.0, 6840.897386539206, 6296.024116261895, 6334.461570766352, 6375.872482550323, 6397.584157029778, 6404.647744374104, 6364.936350636434, 6457.0, 6540.771073012612, 6588.571742836701, 6625.768098116543, 6455.548111632141, 6486.99451585005, 6495.9025614614875, 6555.96722016406, 6586.37429444202, 6399.776007839703, 6417.8716425672155, 6423.389777971085, 6425.040362689238, 6439.388258115471, 4874.635102171398, 4897.926531102107, 4900.656954013328, 4912.336834527293, 4922.507749225048, 6581.243157036811, 6592.736290548516, 6621.337866213533, 6650.567713098633, 6650.567713098633, 6381.416260771824, 6384.626530826399, 6409.551331406757, 6413.198350206224, 6416.679166041773, 6343.3339499351905, 6377.362263773585, 6396.456301214263, 6412.6793660317735, 6452.22573291208, 6362.491000719839, 6389.0, 6406.295307516262, 6442.581232219891, 6444.8388790280615, 6343.365663433619, 6355.841103972438, 6359.8092057238355, 6383.680815959091, 6432.710528026344, 5825.0, 6100.0, 6134.8159555213415, 6170.413810687977, 6171.290301615371], "value": 4960.500612266475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.6120906801008, 892.4600616626936, 912.863070539419, 928.8885333759949, 930.8138372325534, 17472.475825725218, 17629.911850440763, 17771.91114044428, 18217.180226889788, 18599.814001859977, 19605.50986225345, 19789.703154452658, 20795.688064679005, 20919.68620470694, 20923.476913077142, 1011.3224139826316, 1038.85456036155, 1042.1142029275131, 1044.6134930075882, 1046.822040253155, 1041.5625437316346, 1043.7860238651058, 1045.994770026149, 1046.4349251404233, 1052.3896140238644, 948.9572969216367, 1045.2839804733744, 1112.8775834658222, 1113.3097479562682, 1117.357519426329, 1077.7898309829548, 1090.6455401994303, 1091.6288461922984, 1093.1855767453258, 1095.1950316517393, 798.480987358216, 800.5236884053978, 803.1446509467398, 803.5419810707899, 805.0, 18084.728729069073, 18337.449876503728, 18589.535261618432, 18596.535086622807, 19656.410307690792, 20006.299779507648, 20235.494112647302, 20569.691454628042, 20725.792742072535, 20754.584908301902, 15449.0, 15606.141662208687, 15911.92044039784, 15930.522084337488, 15943.601409964727, 3506.386382383073, 3528.329617372691, 3531.2937412517344, 3548.716102711777, 3557.9110522236892, 106795.0, 106981.0, 110631.44684276608, 111420.0, 112388.43805780918, 16208.270627821776, 16569.751453728204, 16580.75128873068, 16581.0, 16581.58546036359, 28044.579331310048, 29785.85107074451, 29839.701602984125, 29948.85025574858, 30031.849840751092, 8676.175763302475, 8724.8691269631, 8743.56282185888, 8747.868781968276, 8788.42875213109, 4007.3788562772816, 4161.91676166475, 4191.161767646483, 4221.345691417835, 4226.1336426032585, 4764.2615394613895, 4792.185328494094, 4811.254255590319, 4833.226683730657, 4847.224444088999, 837.7821766340795, 1039.6361273554196, 1050.8791488978713, 1064.9094826939643, 1077.6928575355985, 573.8651416917021, 672.1497305908031, 683.9794806155824, 698.9231184569693, 715.6636380901073, 11686.70783230409, 11807.822882656767, 12069.758604827854, 12321.815172772416, 12465.0, 651.4983462733669, 684.2439104789137, 695.9965200174069, 708.0229283588718, 710.0733542726688, 5071.18860982241, 5195.2595880380495, 5208.921866172011, 5245.55518449663, 5338.546223570962, 98400.50799745956, 100087.0, 102445.0, 102448.0, 104352.47823760833, 88619.0, 91494.54252728827, 92514.07485925054, 92860.53569732243, 96409.0, 76528.85206721904, 80014.19985800068, 80922.0, 81865.18134818575, 82409.0, 10781.730456738644, 12079.75840483203, 12669.303188324731, 12698.809517857055, 12960.092793504742, 34922.65077349194, 36237.27525449529, 36401.635983639826, 37448.812755936044, 38530.0, 64531.677341612994, 64871.67564162149, 65754.0, 69000.96498552625, 69161.30838691548, 18259.360922367654, 18654.34709785151, 18686.90656546763, 18754.71867921955, 18916.337928172998, 19887.0, 20352.389428317176, 20721.481962951046, 20842.47893802667, 21268.0, 18500.0, 18706.532336691693, 19062.523436914187, 19099.8090019098, 19401.2239510418, 18886.52783680419, 19614.921179334702, 19630.705539416635, 19748.802511974696, 20051.799482005576, 18196.36312729101, 18737.90631046836, 19025.33411330597, 19109.934568702527, 19156.521086972938, 12468.563600273947, 12643.735626437283, 12773.552925647558, 12996.350182491027, 13041.543545976225, 14103.0, 14466.132032078109, 14514.782278265624, 14751.92624036873, 14760.852391475948], "value": 8998.58558895618, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 109.0, 107.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 147.0, 177.0, 124.0, 175.0, 150.0, 128.0, 170.0, 123.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 165.0, 162.0, 171.0, 163.0, 167.0, 174.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 186.0, 75.0, 78.0, 76.0, 76.0, 94.0, 76.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 132.0, 82.0, 85.0, 80.0, 141.0, 82.0, 80.0, 125.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 115.0, 114.0, 114.0, 115.0, 115.0, 115.0, 113.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 151.0, 149.0, 150.0, 151.0, 150.0, 151.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 59.0, 55.0, 58.0, 58.0, 55.0, 56.0, 60.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 79.0, 78.0, 78.0, 76.0, 82.0, 76.0, 76.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 144.0, 136.0, 132.0, 137.0, 124.0, 134.0, 129.0, 123.0, 146.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 204.0, 199.0, 186.0, 179.0, 193.0, 191.0, 188.0, 182.0], "value": 188.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 73.0, 68.0, 69.0, 68.0, 70.0, 70.0, 70.0], "value": 69.4, "unit": "score"}]}]} 18:02:56 INFO - Return code: 0 18:02:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:02:56 INFO - # TBPL SUCCESS # 18:02:56 INFO - Running post-action listener: _package_coverage_data 18:02:56 INFO - Running post-action listener: _resource_record_post_action 18:02:56 INFO - [mozharness: 2017-07-18 01:02:56.220097Z] Finished run-tests step (success) 18:02:56 INFO - Running post-run listener: _resource_record_post_run 18:02:56 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 452521984; Read time: 12; Write time: 299404 18:02:56 INFO - TinderboxPrint: CPU usage
13.1% 18:02:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:02:56 INFO - TinderboxPrint: I/O write bytes / time
452,521,984 / 299,404 18:02:56 INFO - TinderboxPrint: CPU idle
8,241.5 (86.9%) 18:02:56 INFO - TinderboxPrint: CPU user
1,195.3 (12.6%) 18:02:56 INFO - TinderboxPrint: Swap in / out
0 / 0 18:02:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107384832; Read time: 0; Write time: 83740 18:02:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:02:56 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 331763712; Read time: 0; Write time: 206360 18:02:56 INFO - Running post-run listener: _upload_blobber_files 18:02:56 INFO - Blob upload gear active. 18:02:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:02:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:02:56 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:02:56 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:02:57 INFO - Traceback (most recent call last): 18:02:57 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 18:02:57 INFO - main() 18:02:57 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 18:02:57 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 18:02:57 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 18:02:57 INFO - return set(response.json().get('whitelist', [])) 18:02:57 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 18:02:57 INFO - return json.loads(self.text or self.content, **kwargs) 18:02:57 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 18:02:57 INFO - return _default_decoder.decode(s) 18:02:57 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 18:02:57 INFO - obj, end = self.raw_decode(s) 18:02:57 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 18:02:57 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 18:02:57 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 18:02:57 ERROR - Return code: 1 18:02:57 INFO - Setting buildbot property blobber_files to {} 18:02:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:02:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:02:57 INFO - Contents: 18:02:57 INFO - blobber_files:{} 18:02:57 INFO - Running post-run listener: copy_logs_to_upload_dir 18:02:57 INFO - Copying logs to upload dir... 18:02:57 INFO - mkdir: /builds/slave/test/build/upload/logs 18:02:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.068228 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-07-17 18:02:56.462943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 18:02:56.468053) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/aeKol2JgST-iGC51osM4Tg/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 18:02:56.518572) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:02:56.518924) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1500338532.630042-769492182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:02:56.568631) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 18:02:56.568975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 18:02:56.569295) ========= ========= Total master_lag: 0.17 =========