builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1495812969.39 results: success (0) revision: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:09.392994) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:09.393470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:09.393747) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:09.410597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:09.410975) ========= 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=14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-26 08:36:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.1M=0s 2017-05-26 08:36:09 (69.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145768 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:09.571178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:09.571660) ========= 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=14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014578 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:09.622244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:09.622609) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9104506c0a5eaac89b6c22c804c83ccee7d6e662 --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 9104506c0a5eaac89b6c22c804c83ccee7d6e662 --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=14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-26 08:36:10,107 truncating revision to first 12 chars 2017-05-26 08:36:10,108 Setting DEBUG logging. 2017-05-26 08:36:10,108 attempt 1/10 2017-05-26 08:36:10,108 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9104506c0a5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 08:36:10,391 unpacking tar archive at: mozilla-central-9104506c0a5e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576601 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:10.212243) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:10.212672) ========= script_repo_revision: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:10.213181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:10.213509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:10.222609) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-26 08:36:10.223011) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:36:10 INFO - MultiFileLogger online at 20170526 08:36:10 in /builds/slave/test 08:36:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:36:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:36:10 INFO - {'append_to_log': False, 08:36:10 INFO - 'base_work_dir': '/builds/slave/test', 08:36:10 INFO - 'blob_upload_branch': 'Firefox', 08:36:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:36:10 INFO - 'branch': 'Firefox', 08:36:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:36:10 INFO - 'config_files': ('talos/linux_config.py',), 08:36:10 INFO - 'default_actions': ('clobber', 08:36:10 INFO - 'read-buildbot-config', 08:36:10 INFO - 'download-and-extract', 08:36:10 INFO - 'populate-webroot', 08:36:10 INFO - 'create-virtualenv', 08:36:10 INFO - 'install', 08:36:10 INFO - 'run-tests'), 08:36:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:36:10 INFO - 'download_minidump_stackwalk': True, 08:36:10 INFO - 'download_symbols': 'ondemand', 08:36:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:36:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:36:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:36:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:36:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:36:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:36:10 INFO - 'gecko_profile': False, 08:36:10 INFO - 'gecko_profile_interval': 0, 08:36:10 INFO - 'installer_path': 'installer.exe', 08:36:10 INFO - 'log_level': 'info', 08:36:10 INFO - 'log_name': 'talos', 08:36:10 INFO - 'log_to_console': True, 08:36:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:36:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:36:10 INFO - 'opt_config_files': (), 08:36:10 INFO - 'pip_index': False, 08:36:10 INFO - 'suite': 'dromaeojs-e10s', 08:36:10 INFO - 'system_bits': '32', 08:36:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:36:10 INFO - 'title': 'talos-linux64-ix-036', 08:36:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:36:10 INFO - 'use_talos_json': True, 08:36:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:36:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:36:10 INFO - 'work_dir': 'build'} 08:36:10 INFO - [mozharness: 2017-05-26 15:36:10.811593Z] Running clobber step. 08:36:10 INFO - Running pre-action listener: _resource_record_pre_action 08:36:10 INFO - Running main action method: clobber 08:36:10 INFO - rmtree: /builds/slave/test/build 08:36:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:36:11 INFO - Running post-action listener: _resource_record_post_action 08:36:11 INFO - [mozharness: 2017-05-26 15:36:11.828558Z] Finished clobber step (success) 08:36:11 INFO - [mozharness: 2017-05-26 15:36:11.828660Z] Running read-buildbot-config step. 08:36:11 INFO - Running pre-action listener: _resource_record_pre_action 08:36:11 INFO - Running main action method: read_buildbot_config 08:36:11 INFO - Using buildbot properties: 08:36:11 INFO - { 08:36:11 INFO - "project": "", 08:36:11 INFO - "product": "firefox", 08:36:11 INFO - "who": "cbook@mozilla.com", 08:36:11 INFO - "installer_path": "public/build/target.tar.bz2", 08:36:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 08:36:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:36:11 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 08:36:11 INFO - "stage_platform": "linux64-stylo", 08:36:11 INFO - "basedir": "/builds/slave/test", 08:36:11 INFO - "buildnumber": 110, 08:36:11 INFO - "platform": "ubuntu64_hw_stylo", 08:36:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:36:11 INFO - "slavebuilddir": "test", 08:36:11 INFO - "taskId": "HX54CFyfR_u4EJTcGTK85w", 08:36:11 INFO - "branch": "mozilla-central", 08:36:11 INFO - "script_repo_revision": "production", 08:36:11 INFO - "revision": "9104506c0a5eaac89b6c22c804c83ccee7d6e662", 08:36:11 INFO - "slavename": "talos-linux64-ix-036", 08:36:11 INFO - "repo_path": "mozilla-central" 08:36:11 INFO - } 08:36:11 INFO - Finding installer, test and symbols from parent task. 08:36:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HX54CFyfR_u4EJTcGTK85w'}, attempt #1 08:36:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HX54CFyfR_u4EJTcGTK85w'}, attempt #1 08:36:12 INFO - Task dependencies: Gr7t4aqqQ4283WRlslzqMw 08:36:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw'}, attempt #1 08:36:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 08:36:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/test_packages.json 08:36:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.crashreporter-symbols.zip 08:36:13 INFO - Running post-action listener: _resource_record_post_action 08:36:13 INFO - [mozharness: 2017-05-26 15:36:13.249929Z] Finished read-buildbot-config step (success) 08:36:13 INFO - [mozharness: 2017-05-26 15:36:13.250151Z] Running download-and-extract step. 08:36:13 INFO - Running pre-action listener: _resource_record_pre_action 08:36:13 INFO - Running main action method: download_and_extract 08:36:13 INFO - mkdir: /builds/slave/test/build/tests 08:36:13 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')]} 08:36:13 INFO - trying https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.test_packages.json 08:36:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:36:13 INFO - Downloaded 986 bytes. 08:36:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:36:13 INFO - Using the following test package requirements: 08:36:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:36:13 INFO - u'common': [u'target.common.tests.zip'], 08:36:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:36:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:36:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:36:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:36:13 INFO - u'mozbase': [u'target.common.tests.zip'], 08:36:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:36:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:36:13 INFO - u'web-platform': [u'target.common.tests.zip', 08:36:13 INFO - u'target.web-platform.tests.zip'], 08:36:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:36:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:36:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip 08:36:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:36:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip into memory 08:36:14 INFO - Content-Length response header: 63525236 08:36:14 INFO - Bytes received: 63525236 08:36:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:36:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip 08:36:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:36:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip into memory 08:36:27 INFO - Content-Length response header: 63525236 08:36:27 INFO - Bytes received: 63525236 08:36:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.talos.tests.zip 08:36:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:36:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.talos.tests.zip into memory 08:36:39 INFO - Content-Length response header: 14411888 08:36:39 INFO - Bytes received: 14411888 08:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:40 INFO - trying https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 08:36:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:36:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:36:41 INFO - Downloaded 55889332 bytes. 08:36:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 08:36:41 INFO - mkdir: /builds/slave/test/properties 08:36:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:36:41 INFO - Writing to file /builds/slave/test/properties/build_url 08:36:41 INFO - Contents: 08:36:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 08:36:41 INFO - Running post-action listener: _resource_record_post_action 08:36:41 INFO - Running post-action listener: set_extra_try_arguments 08:36:41 INFO - [mozharness: 2017-05-26 15:36:41.093845Z] Finished download-and-extract step (success) 08:36:41 INFO - [mozharness: 2017-05-26 15:36:41.093943Z] Running populate-webroot step. 08:36:41 INFO - Running pre-action listener: _resource_record_pre_action 08:36:41 INFO - Running main action method: populate_webroot 08:36:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:36:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:36:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:36:41 INFO - '--tppagecycles', 08:36:41 INFO - '7'], 08:36:41 INFO - 'tests': ['tsvgm']}}, 08:36:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:36:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:36:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:36:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:36:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:36:41 INFO - 'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:36:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:36:41 INFO - 'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['damp', 'tps']}, 08:36:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:36:41 INFO - 'tests': ['damp', 'tps']}, 08:36:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['dromaeo_dom']}, 08:36:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:36:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:36:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:36:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:36:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:36:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['a11yr', 08:36:41 INFO - 'ts_paint', 08:36:41 INFO - 'tpaint', 08:36:41 INFO - 'sessionrestore', 08:36:41 INFO - 'sessionrestore_no_auto_restore', 08:36:41 INFO - 'tabpaint']}, 08:36:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:36:41 INFO - 'ts_paint', 08:36:41 INFO - 'tpaint', 08:36:41 INFO - 'sessionrestore', 08:36:41 INFO - 'sessionrestore_no_auto_restore', 08:36:41 INFO - 'tabpaint']}, 08:36:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:36:41 INFO - 'ts_paint', 08:36:41 INFO - 'tpaint', 08:36:41 INFO - 'sessionrestore', 08:36:41 INFO - 'sessionrestore_no_auto_restore', 08:36:41 INFO - 'tabpaint']}, 08:36:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:36:41 INFO - 'ts_paint', 08:36:41 INFO - 'tpaint', 08:36:41 INFO - 'sessionrestore', 08:36:41 INFO - 'sessionrestore_no_auto_restore', 08:36:41 INFO - 'tabpaint']}, 08:36:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['a11yr', 08:36:41 INFO - 'ts_paint', 08:36:41 INFO - 'tpaint', 08:36:41 INFO - 'sessionrestore', 08:36:41 INFO - 'sessionrestore_no_auto_restore', 08:36:41 INFO - 'tabpaint']}, 08:36:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['a11yr', 08:36:41 INFO - 'ts_paint', 08:36:41 INFO - 'tpaint', 08:36:41 INFO - 'sessionrestore', 08:36:41 INFO - 'sessionrestore_no_auto_restore', 08:36:41 INFO - 'tabpaint']}, 08:36:41 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:36:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:36:41 INFO - 'bloom_basic_ref']}, 08:36:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['tsvgx', 08:36:41 INFO - 'tsvgr_opacity', 08:36:41 INFO - 'tart', 08:36:41 INFO - 'tscrollx', 08:36:41 INFO - 'cart', 08:36:41 INFO - 'tsvg_static']}, 08:36:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:36:41 INFO - 'tsvgr_opacity', 08:36:41 INFO - 'tart', 08:36:41 INFO - 'tscrollx', 08:36:41 INFO - 'cart', 08:36:41 INFO - 'tsvg_static']}, 08:36:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:36:41 INFO - 'talos_options': ['--disable-e10s'], 08:36:41 INFO - 'tests': ['tp5o']}, 08:36:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:36:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:36:41 INFO - 'talos_options': ['--disable-e10s', 08:36:41 INFO - '--xperf_path', 08:36:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:41 INFO - 'tests': ['tp5n']}, 08:36:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:36:41 INFO - 'talos_options': ['--xperf_path', 08:36:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:41 INFO - 'tests': ['tp5n']}}, 08:36:41 INFO - 'talos.zip': {'path': '', 08:36:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:36:41 INFO - Running post-action listener: _resource_record_post_action 08:36:41 INFO - [mozharness: 2017-05-26 15:36:41.107875Z] Finished populate-webroot step (success) 08:36:41 INFO - [mozharness: 2017-05-26 15:36:41.107964Z] Running create-virtualenv step. 08:36:41 INFO - Running pre-action listener: _resource_record_pre_action 08:36:41 INFO - Running main action method: create_virtualenv 08:36:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:36:41 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 08:36:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:36:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:36:41 INFO - Using real prefix '/usr' 08:36:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:36:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:36:43 INFO - Installing pip.................done. 08:36:43 INFO - Return code: 0 08:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:36:43 INFO - Reading from file tmpfile_stdout 08:36:43 INFO - Output received: 08:36:43 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) 08:36:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, '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': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', '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 08:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:36:43 INFO - Using env: {'DISPLAY': ':0', 08:36:43 INFO - 'HOME': '/home/cltbld', 08:36:43 INFO - 'LANG': 'en_US.UTF-8', 08:36:43 INFO - 'LANGUAGE': 'en_US:en', 08:36:43 INFO - 'LOGNAME': 'cltbld', 08:36:43 INFO - 'MAIL': '/var/mail/cltbld', 08:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:43 INFO - 'MOZ_NO_REMOTE': '1', 08:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:43 INFO - 'NO_EM_RESTART': '1', 08:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:43 INFO - 'PWD': '/builds/slave/test', 08:36:43 INFO - 'SHELL': '/bin/bash', 08:36:43 INFO - 'SHLVL': '1', 08:36:43 INFO - 'TERM': 'linux', 08:36:43 INFO - 'TMOUT': '86400', 08:36:43 INFO - 'USER': 'cltbld', 08:36:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:43 INFO - '_': '/tools/buildbot/bin/python'} 08:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:44 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 08:36:44 INFO - Cleaning up... 08:36:44 INFO - Return code: 0 08:36:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:36: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')]} 08:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36: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')]} 08:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, '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': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', '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 08:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:36:44 INFO - Using env: {'DISPLAY': ':0', 08:36:44 INFO - 'HOME': '/home/cltbld', 08:36:44 INFO - 'LANG': 'en_US.UTF-8', 08:36:44 INFO - 'LANGUAGE': 'en_US:en', 08:36:44 INFO - 'LOGNAME': 'cltbld', 08:36:44 INFO - 'MAIL': '/var/mail/cltbld', 08:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:44 INFO - 'MOZ_NO_REMOTE': '1', 08:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:44 INFO - 'NO_EM_RESTART': '1', 08:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:44 INFO - 'PWD': '/builds/slave/test', 08:36:44 INFO - 'SHELL': '/bin/bash', 08:36:44 INFO - 'SHLVL': '1', 08:36:44 INFO - 'TERM': 'linux', 08:36:44 INFO - 'TMOUT': '86400', 08:36:44 INFO - 'USER': 'cltbld', 08:36:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:44 INFO - '_': '/tools/buildbot/bin/python'} 08:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:44 INFO - Downloading/unpacking psutil>=3.1.1 08:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:36:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:45 INFO - Installing collected packages: psutil 08:36:45 INFO - Running setup.py install for psutil 08:36:45 INFO - building 'psutil._psutil_linux' extension 08:36:45 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 08:36:45 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 08:36:45 INFO - building 'psutil._psutil_posix' extension 08:36:45 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 08:36:45 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 08:36:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:46 INFO - Successfully installed psutil 08:36:46 INFO - Cleaning up... 08:36:46 INFO - Return code: 0 08:36:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:46 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 0xb4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, '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': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', '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 08:36:46 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 08:36:46 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 08:36:46 INFO - Using env: {'DISPLAY': ':0', 08:36:46 INFO - 'HOME': '/home/cltbld', 08:36:46 INFO - 'LANG': 'en_US.UTF-8', 08:36:46 INFO - 'LANGUAGE': 'en_US:en', 08:36:46 INFO - 'LOGNAME': 'cltbld', 08:36:46 INFO - 'MAIL': '/var/mail/cltbld', 08:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:46 INFO - 'MOZ_NO_REMOTE': '1', 08:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:46 INFO - 'NO_EM_RESTART': '1', 08:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:46 INFO - 'PWD': '/builds/slave/test', 08:36:46 INFO - 'SHELL': '/bin/bash', 08:36:46 INFO - 'SHLVL': '1', 08:36:46 INFO - 'TERM': 'linux', 08:36:46 INFO - 'TMOUT': '86400', 08:36:46 INFO - 'USER': 'cltbld', 08:36:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:46 INFO - '_': '/tools/buildbot/bin/python'} 08:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:36:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:36:47 INFO - Installing collected packages: mozsystemmonitor 08:36:47 INFO - Running setup.py install for mozsystemmonitor 08:36:47 INFO - Successfully installed mozsystemmonitor 08:36:47 INFO - Cleaning up... 08:36:47 INFO - Return code: 0 08:36:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:47 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 0xb4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, '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': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', '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 08:36:47 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 08:36:47 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 08:36:47 INFO - Using env: {'DISPLAY': ':0', 08:36:47 INFO - 'HOME': '/home/cltbld', 08:36:47 INFO - 'LANG': 'en_US.UTF-8', 08:36:47 INFO - 'LANGUAGE': 'en_US:en', 08:36:47 INFO - 'LOGNAME': 'cltbld', 08:36:47 INFO - 'MAIL': '/var/mail/cltbld', 08:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:47 INFO - 'MOZ_NO_REMOTE': '1', 08:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:47 INFO - 'NO_EM_RESTART': '1', 08:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:47 INFO - 'PWD': '/builds/slave/test', 08:36:47 INFO - 'SHELL': '/bin/bash', 08:36:47 INFO - 'SHLVL': '1', 08:36:47 INFO - 'TERM': 'linux', 08:36:47 INFO - 'TMOUT': '86400', 08:36:47 INFO - 'USER': 'cltbld', 08:36:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:47 INFO - '_': '/tools/buildbot/bin/python'} 08:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:47 INFO - Downloading/unpacking jsonschema==2.5.1 08:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:36:48 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 08:36:48 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 08:36:48 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 08:36:48 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 08:36:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:49 INFO - warning: no files found matching '*.txt' 08:36:49 INFO - no previously-included directories found matching 'build' 08:36:49 INFO - no previously-included directories found matching 'dist' 08:36:49 INFO - no previously-included directories found matching '.git*' 08:36:49 INFO - Installing collected packages: jsonschema, functools32 08:36:49 INFO - Running setup.py install for functools32 08:36:49 INFO - warning: no files found matching '*.txt' 08:36:49 INFO - no previously-included directories found matching 'build' 08:36:49 INFO - no previously-included directories found matching 'dist' 08:36:49 INFO - no previously-included directories found matching '.git*' 08:36:49 INFO - Successfully installed jsonschema functools32 08:36:49 INFO - Cleaning up... 08:36:49 INFO - Return code: 0 08:36:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:49 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 0xb4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, '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': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', '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 08:36:49 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 08:36:49 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 08:36:49 INFO - Using env: {'DISPLAY': ':0', 08:36:49 INFO - 'HOME': '/home/cltbld', 08:36:49 INFO - 'LANG': 'en_US.UTF-8', 08:36:49 INFO - 'LANGUAGE': 'en_US:en', 08:36:49 INFO - 'LOGNAME': 'cltbld', 08:36:49 INFO - 'MAIL': '/var/mail/cltbld', 08:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:49 INFO - 'MOZ_NO_REMOTE': '1', 08:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:49 INFO - 'NO_EM_RESTART': '1', 08:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:49 INFO - 'PWD': '/builds/slave/test', 08:36:49 INFO - 'SHELL': '/bin/bash', 08:36:49 INFO - 'SHLVL': '1', 08:36:49 INFO - 'TERM': 'linux', 08:36:49 INFO - 'TMOUT': '86400', 08:36:49 INFO - 'USER': 'cltbld', 08:36:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:49 INFO - '_': '/tools/buildbot/bin/python'} 08:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:36:49 INFO - Cleaning up... 08:36:49 INFO - Return code: 0 08:36:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:49 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 0xb4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, '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': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', '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 08:36:49 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 08:36:49 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 08:36:49 INFO - Using env: {'DISPLAY': ':0', 08:36:49 INFO - 'HOME': '/home/cltbld', 08:36:49 INFO - 'LANG': 'en_US.UTF-8', 08:36:49 INFO - 'LANGUAGE': 'en_US:en', 08:36:49 INFO - 'LOGNAME': 'cltbld', 08:36:49 INFO - 'MAIL': '/var/mail/cltbld', 08:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:49 INFO - 'MOZ_NO_REMOTE': '1', 08:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:49 INFO - 'NO_EM_RESTART': '1', 08:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:49 INFO - 'PWD': '/builds/slave/test', 08:36:49 INFO - 'SHELL': '/bin/bash', 08:36:49 INFO - 'SHLVL': '1', 08:36:49 INFO - 'TERM': 'linux', 08:36:49 INFO - 'TMOUT': '86400', 08:36:49 INFO - 'USER': 'cltbld', 08:36:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:49 INFO - '_': '/tools/buildbot/bin/python'} 08:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:36: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 08:36: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 08:36: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 08:36: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 08:36:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:36:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:36:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:36: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 08:36: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 08:36: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 08:36: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 08:36:51 INFO - Downloading docopt-0.6.1.tar.gz 08:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:36:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:36:51 INFO - Running setup.py install for blobuploader 08:36:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:36:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:36:51 INFO - Running setup.py install for requests 08:36:51 INFO - Running setup.py install for docopt 08:36:51 INFO - Successfully installed blobuploader requests docopt 08:36:51 INFO - Cleaning up... 08:36:51 INFO - Return code: 0 08:36:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:51 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 0xb4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, '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': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', '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 08:36:51 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 08:36:51 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 08:36:51 INFO - Using env: {'DISPLAY': ':0', 08:36:51 INFO - 'HOME': '/home/cltbld', 08:36:51 INFO - 'LANG': 'en_US.UTF-8', 08:36:51 INFO - 'LANGUAGE': 'en_US:en', 08:36:51 INFO - 'LOGNAME': 'cltbld', 08:36:51 INFO - 'MAIL': '/var/mail/cltbld', 08:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:51 INFO - 'MOZ_NO_REMOTE': '1', 08:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:51 INFO - 'NO_EM_RESTART': '1', 08:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:51 INFO - 'PWD': '/builds/slave/test', 08:36:51 INFO - 'SHELL': '/bin/bash', 08:36:51 INFO - 'SHLVL': '1', 08:36:51 INFO - 'TERM': 'linux', 08:36:51 INFO - 'TMOUT': '86400', 08:36:51 INFO - 'USER': 'cltbld', 08:36:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:51 INFO - '_': '/tools/buildbot/bin/python'} 08:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:52 INFO - Running setup.py (path:/tmp/pip-zzHw7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:52 INFO - Running setup.py (path:/tmp/pip-Jtt00K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:52 INFO - Running setup.py (path:/tmp/pip-IGZcaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:52 INFO - Running setup.py (path:/tmp/pip-dDPehl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:52 INFO - Running setup.py (path:/tmp/pip-csc4rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:52 INFO - Running setup.py (path:/tmp/pip-RO8QDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:52 INFO - Running setup.py (path:/tmp/pip-wNol80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:52 INFO - Running setup.py (path:/tmp/pip-mWsi2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:52 INFO - Running setup.py (path:/tmp/pip-S7ebuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:52 INFO - Running setup.py (path:/tmp/pip-T9CpZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:52 INFO - Running setup.py (path:/tmp/pip-RJ3fSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:52 INFO - Running setup.py (path:/tmp/pip-Q8Y4AQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:53 INFO - Running setup.py (path:/tmp/pip-Kt6NNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:53 INFO - Running setup.py (path:/tmp/pip-4gJVir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:53 INFO - Running setup.py (path:/tmp/pip-NTfHxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:53 INFO - Running setup.py (path:/tmp/pip-YH94ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:53 INFO - Running setup.py (path:/tmp/pip-Ml_RH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:36:53 INFO - Running setup.py install for manifestparser 08:36:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:36:53 INFO - Running setup.py install for mozcrash 08:36:53 INFO - Running setup.py install for mozdebug 08:36:53 INFO - Running setup.py install for mozdevice 08:36:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:36:53 INFO - Running setup.py install for mozfile 08:36:53 INFO - Running setup.py install for mozhttpd 08:36:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:36:53 INFO - Running setup.py install for mozinfo 08:36:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Running setup.py install for mozInstall 08:36:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Running setup.py install for mozleak 08:36:54 INFO - Running setup.py install for mozlog 08:36:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Running setup.py install for moznetwork 08:36:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Running setup.py install for mozprocess 08:36:54 INFO - Running setup.py install for mozprofile 08:36:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Running setup.py install for mozrunner 08:36:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:36:54 INFO - Running setup.py install for mozscreenshot 08:36:54 INFO - Running setup.py install for moztest 08:36:55 INFO - Running setup.py install for mozversion 08:36:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:36:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:55 INFO - Cleaning up... 08:36:55 INFO - Return code: 0 08:36:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:55 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')]} 08:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:55 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')]} 08:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:55 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 0xb4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, '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': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', '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 08:36:55 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 08:36:55 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 08:36:55 INFO - Using env: {'DISPLAY': ':0', 08:36:55 INFO - 'HOME': '/home/cltbld', 08:36:55 INFO - 'LANG': 'en_US.UTF-8', 08:36:55 INFO - 'LANGUAGE': 'en_US:en', 08:36:55 INFO - 'LOGNAME': 'cltbld', 08:36:55 INFO - 'MAIL': '/var/mail/cltbld', 08:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:55 INFO - 'MOZ_NO_REMOTE': '1', 08:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:55 INFO - 'NO_EM_RESTART': '1', 08:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:55 INFO - 'PWD': '/builds/slave/test', 08:36:55 INFO - 'SHELL': '/bin/bash', 08:36:55 INFO - 'SHLVL': '1', 08:36:55 INFO - 'TERM': 'linux', 08:36:55 INFO - 'TMOUT': '86400', 08:36:55 INFO - 'USER': 'cltbld', 08:36:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:55 INFO - '_': '/tools/buildbot/bin/python'} 08:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:55 INFO - Running setup.py (path:/tmp/pip-AQxVKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:55 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)) 08:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:55 INFO - Running setup.py (path:/tmp/pip-dBEwsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:55 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)) 08:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:55 INFO - Running setup.py (path:/tmp/pip-4fsoHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:55 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)) 08:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:55 INFO - Running setup.py (path:/tmp/pip-M4dkqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:55 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)) 08:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:55 INFO - Running setup.py (path:/tmp/pip-q0aSgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:55 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)) 08:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:55 INFO - Running setup.py (path:/tmp/pip-cFGvU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:55 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)) 08:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:55 INFO - Running setup.py (path:/tmp/pip-Oex0YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:55 INFO - Running setup.py (path:/tmp/pip-p9uYov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:55 INFO - Running setup.py (path:/tmp/pip-OeMYRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:56 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)) 08:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:56 INFO - Running setup.py (path:/tmp/pip-qR3z6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:56 INFO - Running setup.py (path:/tmp/pip-kxg0xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:56 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)) 08:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:56 INFO - Running setup.py (path:/tmp/pip-jJINiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:56 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)) 08:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:56 INFO - Running setup.py (path:/tmp/pip-3526yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:56 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)) 08:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:56 INFO - Running setup.py (path:/tmp/pip-_5NLY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:56 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)) 08:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:56 INFO - Running setup.py (path:/tmp/pip-ATxC_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:56 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)) 08:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:56 INFO - Running setup.py (path:/tmp/pip-pBOQLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:56 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)) 08:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:56 INFO - Running setup.py (path:/tmp/pip-c8YzNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:56 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)) 08:36:56 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)) 08:36:56 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)) 08:36:56 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)) 08:36:56 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)) 08:36:56 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)) 08:36:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:56 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 08:36:56 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 08:36:56 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 08:36:56 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 08:36:57 INFO - Downloading blessings-1.6.tar.gz 08:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:57 INFO - Installing collected packages: blessings 08:36:57 INFO - Running setup.py install for blessings 08:36:58 INFO - Successfully installed blessings 08:36:58 INFO - Cleaning up... 08:36:58 INFO - Return code: 0 08:36:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:58 INFO - Reading from file tmpfile_stdout 08:36:58 INFO - Current package versions: 08:36:58 INFO - argparse == 1.2.1 08:36:58 INFO - blessings == 1.6 08:36:58 INFO - blobuploader == 1.2.4 08:36:58 INFO - docopt == 0.6.1 08:36:58 INFO - functools32 == 3.2.3-2 08:36:58 INFO - jsonschema == 2.5.1 08:36:58 INFO - manifestparser == 1.1 08:36:58 INFO - mozInstall == 1.12 08:36:58 INFO - mozcrash == 1.0 08:36:58 INFO - mozdebug == 0.1 08:36:58 INFO - mozdevice == 0.51 08:36:58 INFO - mozfile == 1.2 08:36:58 INFO - mozhttpd == 0.7 08:36:58 INFO - mozinfo == 0.9 08:36:58 INFO - mozleak == 0.1 08:36:58 INFO - mozlog == 3.4 08:36:58 INFO - moznetwork == 0.27 08:36:58 INFO - mozprocess == 0.25 08:36:58 INFO - mozprofile == 0.28 08:36:58 INFO - mozrunner == 6.13 08:36:58 INFO - mozscreenshot == 0.1 08:36:58 INFO - mozsystemmonitor == 0.3 08:36:58 INFO - moztest == 0.8 08:36:58 INFO - mozversion == 1.4 08:36:58 INFO - psutil == 3.1.1 08:36:58 INFO - requests == 1.2.3 08:36:58 INFO - wsgiref == 0.1.2 08:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:58 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')]} 08:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:58 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')]} 08:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:58 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 0xb4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, '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': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', '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 08:36:58 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 08:36:58 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 08:36:58 INFO - Using env: {'DISPLAY': ':0', 08:36:58 INFO - 'HOME': '/home/cltbld', 08:36:58 INFO - 'LANG': 'en_US.UTF-8', 08:36:58 INFO - 'LANGUAGE': 'en_US:en', 08:36:58 INFO - 'LOGNAME': 'cltbld', 08:36:58 INFO - 'MAIL': '/var/mail/cltbld', 08:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:58 INFO - 'MOZ_NO_REMOTE': '1', 08:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:58 INFO - 'NO_EM_RESTART': '1', 08:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:58 INFO - 'PWD': '/builds/slave/test', 08:36:58 INFO - 'SHELL': '/bin/bash', 08:36:58 INFO - 'SHLVL': '1', 08:36:58 INFO - 'TERM': 'linux', 08:36:58 INFO - 'TMOUT': '86400', 08:36:58 INFO - 'USER': 'cltbld', 08:36:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:58 INFO - '_': '/tools/buildbot/bin/python'} 08:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:58 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)) 08:36:58 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)) 08:36:58 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)) 08:36:58 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)) 08:36:58 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)) 08:36:58 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)) 08:36:58 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)) 08:36:58 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)) 08:36:58 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)) 08:36:58 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:36:58 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 08:36:58 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 08:36:58 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 08:36:58 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 08:36:59 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:36:59 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)) 08:36:59 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)) 08:36:59 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)) 08:36:59 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)) 08:36:59 INFO - Installing collected packages: marionette-driver 08:36:59 INFO - Running setup.py install for marionette-driver 08:36:59 INFO - Successfully installed marionette-driver 08:36:59 INFO - Cleaning up... 08:36:59 INFO - Return code: 0 08:36:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36:59 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')]} 08:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:59 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')]} 08:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:59 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 0xb4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, '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': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', '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 08:36:59 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 08:36:59 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 08:36:59 INFO - Using env: {'DISPLAY': ':0', 08:36:59 INFO - 'HOME': '/home/cltbld', 08:36:59 INFO - 'LANG': 'en_US.UTF-8', 08:36:59 INFO - 'LANGUAGE': 'en_US:en', 08:36:59 INFO - 'LOGNAME': 'cltbld', 08:36:59 INFO - 'MAIL': '/var/mail/cltbld', 08:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:59 INFO - 'MOZ_NO_REMOTE': '1', 08:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:59 INFO - 'NO_EM_RESTART': '1', 08:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:59 INFO - 'PWD': '/builds/slave/test', 08:36:59 INFO - 'SHELL': '/bin/bash', 08:36:59 INFO - 'SHLVL': '1', 08:36:59 INFO - 'TERM': 'linux', 08:36:59 INFO - 'TMOUT': '86400', 08:36:59 INFO - 'USER': 'cltbld', 08:36:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:59 INFO - '_': '/tools/buildbot/bin/python'} 08:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:37:00 INFO - Cleaning up... 08:37:00 INFO - Return code: 0 08:37:00 INFO - Running post-action listener: _resource_record_post_action 08:37:00 INFO - Running post-action listener: _start_resource_monitoring 08:37:00 INFO - Starting resource monitoring. 08:37:00 INFO - [mozharness: 2017-05-26 15:37:00.093297Z] Finished create-virtualenv step (success) 08:37:00 INFO - [mozharness: 2017-05-26 15:37:00.093937Z] Running install step. 08:37:00 INFO - Running pre-action listener: _resource_record_pre_action 08:37:00 INFO - Running main action method: install 08:37:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:37:00 INFO - Reading from file tmpfile_stdout 08:37:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:37:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:37:00 INFO - Reading from file tmpfile_stdout 08:37:00 INFO - Output received: 08:37:00 INFO - Usage: mozinstall [options] installer 08:37:00 INFO - Options: 08:37:00 INFO - -h, --help show this help message and exit 08:37:00 INFO - -d DEST, --destination=DEST 08:37:00 INFO - Directory to install application into. [default: 08:37:00 INFO - "/builds/slave/test"] 08:37:00 INFO - --app=APP Application being installed. [default: firefox] 08:37:00 INFO - mkdir: /builds/slave/test/build/application 08:37:00 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'] 08:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:37:16 INFO - Reading from file tmpfile_stdout 08:37:16 INFO - Output received: 08:37:16 INFO - /builds/slave/test/build/application/firefox/firefox 08:37:16 INFO - Running post-action listener: _resource_record_post_action 08:37:16 INFO - [mozharness: 2017-05-26 15:37:16.378282Z] Finished install step (success) 08:37:16 INFO - [mozharness: 2017-05-26 15:37:16.378559Z] Running run-tests step. 08:37:16 INFO - Running pre-action listener: _resource_record_pre_action 08:37:16 INFO - Running main action method: run_tests 08:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:37:16 INFO - Python 2.7.3 08:37:16 INFO - Return code: 0 08:37:16 INFO - grabbing minidump binary from tooltool 08:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:16 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 0xeba7a0>, '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 0xebb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebbb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:37:16 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 08:37:16 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 08:37:16 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 08:37:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:37:16 INFO - Return code: 0 08:37:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:37:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:37:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:37:16 INFO - ENV: RUST_BACKTRACE is now 1 08:37:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:37:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 08:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 08:37:16 INFO - Using env: {'DISPLAY': ':0', 08:37:16 INFO - 'HOME': '/home/cltbld', 08:37:16 INFO - 'LANG': 'en_US.UTF-8', 08:37:16 INFO - 'LANGUAGE': 'en_US:en', 08:37:16 INFO - 'LOGNAME': 'cltbld', 08:37:16 INFO - 'MAIL': '/var/mail/cltbld', 08:37:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:37:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:16 INFO - 'MOZ_NO_REMOTE': '1', 08:37:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:16 INFO - 'NO_EM_RESTART': '1', 08:37:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:16 INFO - 'PWD': '/builds/slave/test', 08:37:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:37:16 INFO - 'RUST_BACKTRACE': '1', 08:37:16 INFO - 'SHELL': '/bin/bash', 08:37:16 INFO - 'SHLVL': '1', 08:37:16 INFO - 'TERM': 'linux', 08:37:16 INFO - 'TMOUT': '86400', 08:37:16 INFO - 'USER': 'cltbld', 08:37:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518', 08:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:16 INFO - '_': '/tools/buildbot/bin/python'} 08:37:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 08:37:16 INFO - mozversion application_buildid: 20170526145708 08:37:16 INFO - mozversion application_changeset: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 08:37:16 INFO - mozversion application_display_name: Nightly 08:37:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:37:16 INFO - mozversion application_name: Firefox 08:37:16 INFO - mozversion application_remotingname: firefox 08:37:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:37:16 INFO - mozversion application_vendor: Mozilla 08:37:16 INFO - mozversion application_version: 55.0a1 08:37:16 INFO - mozversion platform_buildid: 20170526145708 08:37:16 INFO - mozversion platform_changeset: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 08:37:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:37:16 INFO - mozversion platform_version: 55.0a1 08:37:16 INFO - using testdate: 1495813036 08:37:16 INFO - actual date: 1495813036 08:37:16 INFO - starting webserver on 'localhost:43811' 08:37:16 INFO - SUITE-START | Running 2 tests 08:37:16 INFO - TEST-START | dromaeo_css 08:37:16 INFO - operating with platform_type : linux_ 08:37:16 INFO - Initialising browser for dromaeo_css test... 08:37:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43811/getInfo.html -profile /tmp/tmpEqwtWg/profile 08:37:16 INFO - TEST-INFO | started process 11692 (/builds/slave/test/build/application/firefox/firefox http://localhost:43811/getInfo.html) 08:37:51 INFO - TEST-INFO | 11692: killed by SIGTERM 08:37:51 INFO - Browser initialized. 08:37:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:37:51 INFO - TEST-INFO | started process 11912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEqwtWg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:03 INFO - PID 11912 | RSS: Main: 172408832 08:38:03 INFO - PID 11912 | 08:41:08 INFO - PID 11912 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43811/tests/dromaeo/cssquery-ext.html) 08:41:10 INFO - PID 11912 | RSS: Main: 169975808 08:41:10 INFO - PID 11912 | 08:44:11 INFO - PID 11912 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-ext.html (next: http://localhost:43811/tests/dromaeo/cssquery-jquery.html) 08:44:12 INFO - PID 11912 | RSS: Main: 176799744 08:44:12 INFO - PID 11912 | 08:47:14 INFO - PID 11912 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43811/tests/dromaeo/cssquery-mootools.html) 08:47:14 INFO - PID 11912 | RSS: Main: 174739456 08:47:14 INFO - PID 11912 | 08:50:16 INFO - PID 11912 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43811/tests/dromaeo/cssquery-prototype.html) 08:50:17 INFO - PID 11912 | RSS: Main: 178794496 08:50:17 INFO - PID 11912 | 08:53:20 INFO - PID 11912 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43811/tests/dromaeo/cssquery-yui.html) 08:53:20 INFO - PID 11912 | RSS: Main: 178077696 08:53:20 INFO - PID 11912 | 08:56:22 INFO - PID 11912 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-yui.html (next: http://localhost:43811/tests/dromaeo/cssquery-dojo.html) 08:56:22 INFO - PID 11912 | RSS: Main: 174505984 08:56:22 INFO - PID 11912 | 08:56:22 INFO - PID 11912 | __start_tp_report 08:56:22 INFO - PID 11912 | _x_x_mozilla_page_load 08:56:22 INFO - PID 11912 | _x_x_mozilla_page_load_details 08:56:22 INFO - PID 11912 | |i|pagename|runs| 08:56:22 INFO - PID 11912 | |0;dojo.html;2741.0269354379207;2742.9588556171648;2745.2176129803006;2772.209920172751;2784.484870298995;5162.148245539491;5348.491893270138;5360.303160589123;5382.2464854920345;5395.136778115502;5313.707746073965;5330.1205301125265;5339.092354299769;5356.598255130862;5441.401445840955;4749.216379297412;4761.738104404257;4782.354382158416;4788.209945359029;4820.542048505404;4752.881177970544;4794.2329227323635;4815.470298267188;4817.108834865544;4862.927056094161;4699.036697477009;4713.505081966378;4729.55069268419;4751.928721069186;4771.498992605779;4739.478657347689;4779.139754844126;4781.832635857763;4818.734969576672;4819.879503012417;4721.150192965265;4731.36126622905;4736.478987311393;4752.762361881927;4777.928331075037;5340.546053585411;5370.3287089113865;5394.568434525228;5408.296921400193;5415.079436495806;5680.744366503517;5750.856228594319;5760.798372056958;5820.941790582082;5826.067829147359;5795.246617939683;5796.5072968797285;5804.216430781875;5807.825765227008;5811.796587119473;5395.352557693023;5397.4062853086125;5400.972995135038;5408.59435542328;5409.459054094637;5762.366139724627;5787.450192231731;5895.823125306248;5927.881442371128;5938.762449501972;5685.891251205975;5740.856478588069;5742.712864356766;5774.711264436762;5799.768009279666;5812.070068788974;5819.79630712923;5834.27071616048;5837.445442682938;5837.7664893404635;5566.942280966684;5648.661080335193;5790;5799.797007104731;5801.448862358069;5734.7132643368495;5770.336411312669;5842.941570584239;5855.033919403336;5855.355910849803;4855.878603034952;4858.708477491362;4867.294242334912;4869.245266983623;4910.017996400734;4140.565240649748;4144.585541445831;4149.25313443577;4171.416001759756;4206.684498662613;4810.8797280068275;4877.6829506081995;4880.731559764176;4905.533974272438;4919.089968355794;5799.768009279582;5811.88376232473;5814.5348372130975;5823.970880145657;5858.238429004287;4841.467438581753;4881.048195601824;4886.193778026586;4905.1416002200185;4928.211486162197;5022.84931452057;5044.293798868088;5093;5102.795888164432;5113.181890897513;5309.920351194658;5325.174597937326;5334;5370.812021579226;5385.703786291791;5620.269364982526;5714.342850572238;5731.598788084794;5743.3395159557185;5772.509336706427;5298.364196296469;5325.973370133124;5355.946440535545;5394.460553944574;5439.5920305976415;5660.179274005329;5669.744861481161;5718.370979192202;5729.799457018984;5750.48245657876;5673.858153546194;5743.684097374685;5750.913736293875;5801.709914504342;5843.357230704704;5572.554195664418;5591.4688104629995;5628.099504079328;5664.178694089252;5671.319441666861;5616.550675945996;5617.185508101221;5624.212610234652;5629.493345598752;5631;5454.209139674805;5485.341758988788;5555.0834112371;5555.8888822222525;5558.305211848519;5679.318481782213;5681.176229446624;5694.430556944272;5708.543316534584;5729.3984131665575;5453.536449401845;5464.836054918359;5474.3704473986;5517.255170552085;5521.558275337883 08:56:22 INFO - PID 11912 | |1;ext.html;704.8731228378892;732.8607564562733;751.2037240525042;1043.7390652336917;1064.9627263045795;31489.21276968074;32528.18679533013;32541.837290813542;32545.51181732276;32586.185345366317;34208.828955855184;34557.48163777539;34580.48129278063;34598.827005865;34647.13382165447;6589.505787065966;6768.8307792305095;6818.420434263081;6959.478039147059;6959.8956015659805;6699.162604674416;6787.287334829846;6793.116894803668;6801.625910574917;6824;6792.864142717142;6815.38661520463;6821.249662537117;6827.658617069152;6830.214525329576;6735.427488663469;6748.089007983908;6765.2219994700745;6781.898271525931;6828.897566536506;6671.166104236971;6733.562318449285;6733.562318449285;6739.932600673979;6741.764038258638;30817.38365232683;30904.53643195354;30913.845430772926;30916.53625195624;31158.844205779053;3078.2766049978236;3101.2401961519345;3112.004158669204;3129.5149251865996;3130.311331507065;24081.63877541838;24148.517029659484;24164.879175604186;24369.14707985212;24414.389640259134;2599.129291687287;2615.738426157388;2626.619140224676;2642.471505698849;2651.469706058796;152036.2398188002;152170;157430;160548.19725901412;160753;40258.79870600628;40407;40489.79755101206;40492;40626.79686601548;42217.57782422198;42338.15323693571;42435.363469547985;42472.57527424748;42556.57443425588;12798.424070916644;12806.167599106027;12820.743585128244;12853.550125745554;12862;10331.070203681706;10339.121174700234;10341.793164136825;10345.482725863676;10367.274290799722;12811.295378754072;12874.420651070724;12933;13017.609471715863;13157.144785588906;5393.2449457076045;5398.541124004503;5403.594730395157;5460.426655201147;5552.751640290476;867.197841996151;900.8603666431713;912.1243606138181;925.842606756853;949.3307218411004;20448.693269600968;21018.949052547312;21127.683084753742;21192.046357913932;21367.337870156374;975.6438899801522;979.4955597867104;1001.3891526169031;1015.3958394755109;1015.7968406318765;10813.783724325469;11181.496832642388;11194.10447164225;11220.607278745205;11397.145214108976;185572;186549;187348.06325968282;187428;187694;41123;41673.166536669094;41740.791296043935;41788.37317440241;41893.79053104715;1214.8420705308254;1248.2510493703705;1251.255502975728;1251.3680591301334;1255.7362953779625;19353.612927741084;20011.199552017755;20598.485037873572;20678.276260330815;20690.793092068885;29824.25439364033;29962.850185749805;29993;30006.849965750906;30079;151980;152418;153058;153287.23356383594;154035.22982385015;28043.71956280411;28654;28866.567001494575;29840.850795745882;29951.101466956025;35254.64745352514;35287.82356088306;35405.468917965736;35682.10794730153;35775.46336804898;25249;26836.59745103864;26954;27336.589951151145;27444.313892152855;26385.868070659522;27061.86469067642;27638.723612763613;27686.584701229094;28282.575761363183;30581.694183058775;30583.847080765343;30595.08214753561;30601.23496912595;30608.387832242784;26030;26201;26686.19941401761;27432.588511172748;27832.582511262754;21573.46066348291;22777.430564236027;22785.89853826327;22790.31629051131;22973.88513057424 08:56:22 INFO - PID 11912 | |2;jquery.html;404.6722155054408;406.932856078747;422.08618341291105;429.19954285258;429.96560275177984;17037.659246815056;17662.586993040542;17707.645847083066;18395.264189432408;19036.80963190371;18735.531611709714;19105.904470477664;19228.230870765186;19298.614027719435;19413.708794368096;5316.441773613773;5352.330958630171;5449.945500545004;5482.671039737608;5548.72256387179;5328.653637513549;5403.864903377427;5408.080626293539;5409.29679141711;5418.539424148952;5168.741562921858;5300.734963251842;5369.40936496985;5372.435894231108;5376.677399356051;5372.086745253297;5422.213779002042;5423.159410291371;5424.647397919122;5429.484199001088;4890.119778439879;4891.730954797485;4912.459629440758;4916.778744956486;4958.20668693011;21956.23153189647;22331.44171395728;22540;22557.43606409853;22948.770512294832;1604.085671167435;1653.0081950829526;1654.33826469412;1654.5201891451466;1655.4454257823643;14738.747206487462;14885.776713349309;14946.62633434162;15261.465848695354;15351.923240383838;2062.7834077421803;2067.700183473403;2078.615456140619;2078.7193728846714;2095.6437405641077;89898.5505072477;90859.54570227173;91545;92159.53920230355;92177.53911230469;10803.83794243087;11104.500297486633;11162.609308674157;11305.26515776472;11411.942940285246;15343.846561534241;15452.768208476882;15538.611534711497;15565.22173891301;15599.454019109276;7620.5808680523105;7792.337651299589;7815;7965.561894095765;7973.60131993398;7178.533395329287;7188.353048225685;7237.493375463667;7338.633068346561;7417.888731669029;6952.470456499663;6952.756653517103;7004.789856304319;7106.751263705849;7272.272772722686;2025.9493512662007;2061.80412860778;2062.3812856143095;2063.401613532059;2156;805.7059173401666;890.398980688046;897.9820403591891;900.243795212012;903.8779764731677;17427.128643567772;18126.81873181278;18506.907465462587;18525.90737046306;18661.720074198896;885.7431344910033;889.3952112563389;904.8914130304406;911.1844898815656;923.0677016213673;9285.675001375055;9902;9919.256055795844;9967.55146018431;9976.102150806317;370620;373889;376428;377445;379251;81519;87060.12939870647;88076.5596172015;89016.5549172263;89243.55378223068;1073.973150671224;1089.0797276301355;1134.8865113488584;1137.3517095255625;1139.0887290167832;17992.730109048112;18247.270109196015;18860;18865.24539018424;19082.236710531422;40629.796851015555;41119;41207.79396103;41314;42521;51326.48673513217;51451.48548514467;51825.740871295406;53336.73331633317;53827.46172538224;8217.219364160395;8452.8022714096;8613.3109351253;8622.310215182895;8708.34687398435;12558.43487043067;13230.941524678195;13497.257650828906;13721.794173087612;13997;11544.249623774764;11658.475368608264;11731.296122232694;11934.701632459259;12180.390980451119;10850.45747712627;11263.66209013731;11352.148588856035;11369.147313951322;11593.710157246136;11396.715082123013;11536.365499897585;11576.305421674726;11583.76832463329;12065.276083435023;8150.673973041249;8428.45215061019;8532.616032278438;8576.785580360542;8622.956885215533;11246.775064498828;11278.774424511628;11453.141014424118;11551.884481155417;11681.88318116842 08:56:22 INFO - PID 11912 | |3;mootools.html;1212.4665147335172;1275.2922128218847;1281.0328202207336;1288.8517820450645;1292.515306759965;10429.687109386712;10649.52077156528;10878.347299162037;10906.50920708568;10906.836397454044;10722.571097156124;10929.617463388782;10950.39772812495;10963.61627343043;10991.340519568812;2270.0919632147147;2314.8148148148193;2316.698829152216;2333.6382860656627;2336.158982766203;2168.728908886389;2231.520223152022;2237.9328620141423;2240.249516412004;2245.9663105053437;2213.147938043857;2224.010315409643;2229.7993180613744;2243.674667173259;2249.4151520604596;2013.043804193004;2024.8683835550642;2024.9493762655977;2025.605007023631;2026.3313106674761;2079.105984426696;2082.55225126597;2184.8907554622206;2193.1885202475187;2200.526886719347;10631.84052239217;10698.78602427947;10702.357858528514;10754.623588174376;10759.784804303948;5585.748641311151;5805.622634528784;5806.82579522615;5810.244668193108;5841.766329346821;3106.673799251069;3186.5060915558124;3203.5034569641743;3205.8397080146133;3243.659415761358;1004.9949750251202;1016.9847452288221;1023.1661196125209;1024.515549791752;1028.4806172882647;15641;16064.839351606568;16102.677946441123;16144.112073835935;16157.515274541782;4909.729964851896;5068.695878247243;5194.142966410575;5326.46735326472;5361.463853614608;13141.34293285351;13156.802647960289;13161.670958226121;13172.341382931007;13206.537771177962;5755.395683453261;5866.882662346729;5867.207926929896;5869.06095024794;5870.7945221917025;5173;5237.790488380499;5275.340582427197;5290.68255904647;5309.230161626542;4194.140201258796;4248.808803603845;4314.697971142053;4335.913281734348;4342.848000319974;1315.467235769515;1353.9864601354057;1360.1702961193664;1369.7671395862728;1372.1629805818443;642.4667525953447;661.2825084782968;686.6944209826679;690.5545922879714;694.1427337238506;5264.499872512105;5269.683818970874;5332.120200167006;5470.863228419242;5532.640378375473;568.4372471253429;572.5791543215734;580.0255570641278;582.7989343676425;843.6414523827349;3803.8098095095133;3851.9422208666892;3861.1698484825897;3880.708946828999;3945.270125026879;13443.663908402172;13815.51645692416;14188.290585470892;14252.786208206886;14360.784588231185;13915.930420347833;14111.576652700436;14144.71710565783;14152.575422737335;14152.716945661236;7760.495567788189;7951.840963180704;7975.5613441261285;7982.401319901031;7994.040715114107;6196.907046394217;6359.173307470184;6371.5221358397375;6440.5491615588335;6523.11937888398;12564.560240391542;12641.620751377473;12747.61757147287;12786.61640150797;12919.418626162033;12955.935220323838;13189.93405033007;13225.338733063116;13226.735465290449;13333;8527.53098579584;8679.826403472021;8890.24432923183;8890.59992300361;8900.376973611785;9954.054364835329;9964.651237206954;10062.899371006197;10071.748206294902;10106.8483972739;8434.451760635538;8486.83026339482;8536.061033286209;8635.222829945335;8746.956265218632;8216.178382161976;8241.093479717347;8242.381821363542;8275.586220689062;8451.197136272045;7419.591922444318;7587.734429294948;7595;7597.582132982518;7614.16244213125;5360.499060263132;5362.016054060023;5373.408925018323;5508.724563771715;5640.88718225625;5317.441668624893;5412.484504338791;5415.160650099241;5509.586780991362;5569.248151499658 08:56:22 INFO - PID 11912 | |4;prototype.html;384.5078299776284;385.08158043067283;386.1215734204684;391.47737770076947;394.0483731787734;5466.699331536769;5510.878311849941;5521.723913804309;5523.861903452405;5527.889442211163;5255.686736142374;5344.679319240839;5360.91958620621;5406.459354064592;5412.648177868436;4243;4253.128108737701;4263.978680106595;4275.978620106911;4289.935650965238;4225.767582782945;4234.534201237861;4251.532331443539;4257.6806739494505;4258.233517966764;4116.629503344699;4214.473190851144;4230.725002874803;4239.894002649928;4242.369730766929;4235.618794308496;4238.618524332809;4242.363645453176;4249.80875860587;4260.297050986584;3796.791176485292;3823.4073718573386;3825.196708691178;3825.488931871895;3829.4064420014943;5087.923681144785;5343.225232341289;5354.759035843396;5361.973190134025;5370.812021579265;4857.562819346276;4893.68191067583;4894.975525122387;4906.460289368202;4918.262260660894;5824.88350232993;5825.388334224887;5826.096515334736;5841.503472204825;5862.50168735658;3947.230290093433;4074.7555146691293;4105.753654780723;4115.73247738896;4123.36087906375;5917.733701983421;6044.788432404889;6069.726862291208;6076.240469941257;6186.81439556814;4176.206520761107;4184.330507118846;4211.578842115764;4212.389203565466;4225.218334608107;4253.829846806155;4259.637930775857;4262.829486820555;4273.059926816096;4282.807273672693;4803.831865884677;4887.877803054952;4900.779464924087;4909.828156014522;4913.87715307113;5778;5849.660135945655;5860.882782344414;5874.206982057368;5893.469587737039;1437.5974727076227;1444.1768192130594;1445.3712635003808;1445.978310325346;1450.9564713058626;926.6108234541508;981.9754506137403;989.1295659819313;999.2405771613626;1001.9248556358302;5001.724905130252;5036.219385995177;5044.495550444926;5048.192289233705;5051.494850514919;5991.2510936132985;5994.730237139339;5996.700164991733;6002.9794934861175;6020.217371741734;4898.53463920927;4917.631177661689;4925.236588328815;4979.925301120486;4980.576650984707;3157;3177.872885084617;3188.3463889902514;3195.8082515049173;3209.3902158589794;5470.863228419322;5594.20985284705;5607.52336051432;5616.354119276254;5616.775328986795;6079.875223083744;6150.661713605705;6162.845928851725;6175.289841668266;6209.720562574605;5588.38527761954;5590.009345000487;5590.301212348457;5599.832005039774;5610.382857885629;5885.588008839341;6013.879722405615;6037.305709843425;6056.939430605814;6074.997625391761;5910.881782364243;5946;5954.642721436728;5967.343592204767;5985.730642121202;5396;5574.174987138531;5581.609287349846;5608.579356548194;5627.549796016391;4170.72890262132;4210.136921930935;4224.4930608327195;4226.598473145046;4234.661227101763;5898.4101589840675;6070.785842831363;6096.573239873166;6103.145559621567;6126.23422072241;5844.824655260349;5864.589478736618;5882.323532793613;5893.5874488787085;5906.084556893688;5822.737976791139;5851.765929362778;5859.296884373903;5866.882662346815;5888.175655408332;5640.689762062962;5714.742836572447;5764.106563482667;5777.768889244383;5807;5904.202932604044;5904.350521442724;5907.556933229939;5914.852128696817;5915.733791979285;5602.1036634138345;5684.005299072728;5696.857578560569;5702.315722113373;5711.628744131618 08:56:22 INFO - PID 11912 | |5;yui.html;729.4784229276066;732.8167958010497;744.3524134003418;746.153116213098;750.1673142811478;11305.152113591472;11724.648260552198;13438.932805335971;14182.645433864145;14211.28943552822;15127.773083403757;15872.444464443746;15901.602459938507;15913.04521728697;15932;895.9238464730489;915.4507295622607;918.2562124679031;919.7562645898843;919.8252332056887;911.3438324406417;912.7900582865944;913.0139449394671;913.3789023464042;913.8172365526921;951.8810148731409;958.9808203835919;960.2126256469697;960.3373672166183;962.0523784072683;934.3039435620473;947.6114792934898;954.3224310739383;954.7422196007109;957.4638202606562;674.6491824251411;677.4140368581191;681.6455443169524;681.7647911470535;686.0977814174345;14505.129692218396;14791.778123328158;14793.40826366944;14802.481913133097;14806.407743690348;15363.4622788203;15794.684106317809;15834.366625334973;15881.602959926095;15902.920485397615;12829.358532073453;12958.740825183539;13042.543510977164;13174.868251317555;13219.66950826237;3011.578379026938;3040.6047213862057;3043.1022848259818;3043.3913217356617;3052.267455810612;82618;83368;83514.16485835185;83546;84063;12962.351882405843;13103.410346534429;13187.73624527504;13217.273049982152;13222.669433264246;23319.650205246933;23892.761072389054;24202.15292464755;24210.87894560516;24223;5958.791442299499;6002.069679199731;6013.54898382623;6017.69911504423;6064.090386442069;2897.203269101014;2995.445842519141;2999.7450216731386;3004.9549256761165;3015.5627434021944;3788.299164654548;3858.78776667286;3864.8067596620617;3865.2269546090893;3866.7293289469467;709.3651182191909;718.4575645387699;761.5735188294462;822.5681517203396;823.5799742131436;583.285475292763;589.7611467355728;593.7476572456688;596.6360520082746;616.7255571270741;9564.13922746956;10537.84193237102;10938.343699378063;11197;11331.490082946288;606.2385832532767;612.9877402452015;621.9191505104308;632.9715162817685;636.1507387637556;4557.316402539645;4566.543345665474;4604.7927843247135;4756.286557016475;4759.286107083896;73283.26716732765;74261;74907.62546187235;74986;76304.61847690726;67318;67483.32516674869;67735.32264677389;67933.66033169802;71354.64322678457;59353.70323148357;60714;60967.695161524796;62891.371086289466;64622.67688661526;10269.435181065113;10669.093127084285;11147.609833655782;11370.488328025092;11383.829242561535;28247.29381765472;28449.43101138007;28484.43031139324;29026.7097329024;29482.11553653394;35779.46330805092;36222.8188859054;36709;36865.63134368622;37572.62427375691;13622.318884055956;13854.792178117135;13924.2341671205;14012.159270443399;14337.498187563386;15994.040357578582;16154.67690646204;16177.326666169305;16342.754858677366;16547.586310342336;14110.576682699535;14255.144691318554;14359.497417590752;14745.336459859118;14780.852191478378;14851.851481485479;14984.700305993601;15054.849451505344;15095.094294342374;15385;13750.862491374959;13780.517681881487;13813;13963.162210267417;14107.929460353043;10415.479226038819;10447.582096716047;10488.790224195625;10953.659133963898;10990.615328463466;10949.397783121685;11456.82814757796;11640.592579259684;11669.35818529989;11683.707907302385 08:56:22 INFO - PID 11912 | __end_tp_report 08:56:22 INFO - PID 11912 | __start_cc_report 08:56:22 INFO - PID 11912 | _x_x_mozilla_cycle_collect,331 08:56:22 INFO - PID 11912 | __end_cc_report 08:56:22 INFO - PID 11912 | __startTimestamp1495814182923__endTimestamp 08:56:22 INFO - PID 11912 | 08:56:22 INFO - PID 11912 | ------- Summary: start ------- 08:56:22 INFO - PID 11912 | Number of tests: 6 08:56:22 INFO - PID 11912 | 08:56:22 INFO - PID 11912 | [#0] dojo.html Cycles:165 Average:5278.06 Median:5415.08 stddev:624.65 (11.5%) stddev-sans-first:594.02 08:56:22 INFO - PID 11912 | Values: 2741.0 2743.0 2745.2 2772.2 2784.5 5162.1 5348.5 5360.3 5382.2 5395.1 5313.7 5330.1 5339.1 5356.6 5441.4 4749.2 4761.7 4782.4 4788.2 4820.5 4752.9 4794.2 4815.5 4817.1 4862.9 4699.0 4713.5 4729.6 4751.9 4771.5 4739.5 4779.1 4781.8 4818.7 4819.9 4721.2 4731.4 4736.5 4752.8 4777.9 5340.5 5370.3 5394.6 5408.3 5415.1 5680.7 5750.9 5760.8 5820.9 5826.1 5795.2 5796.5 5804.2 5807.8 5811.8 5395.4 5397.4 5401.0 5408.6 5409.5 5762.4 5787.5 5895.8 5927.9 5938.8 5685.9 5740.9 5742.7 5774.7 5799.8 5812.1 5819.8 5834.3 5837.4 5837.8 5566.9 5648.7 5790.0 5799.8 5801.4 5734.7 5770.3 5842.9 5855.0 5855.4 4855.9 4858.7 4867.3 4869.2 4910.0 4140.6 4144.6 4149.3 4171.4 4206.7 4810.9 4877.7 4880.7 4905.5 4919.1 5799.8 5811.9 5814.5 5824.0 5858.2 4841.5 4881.0 4886.2 4905.1 4928.2 5022.8 5044.3 5093.0 5102.8 5113.2 5309.9 5325.2 5334.0 5370.8 5385.7 5620.3 5714.3 5731.6 5743.3 5772.5 5298.4 5326.0 5355.9 5394.5 5439.6 5660.2 5669.7 5718.4 5729.8 5750.5 5673.9 5743.7 5750.9 5801.7 5843.4 5572.6 5591.5 5628.1 5664.2 5671.3 5616.6 5617.2 5624.2 5629.5 5631.0 5454.2 5485.3 5555.1 5555.9 5558.3 5679.3 5681.2 5694.4 5708.5 5729.4 5453.5 5464.8 5474.4 5517.3 5521.6 08:56:22 INFO - PID 11912 | 08:56:22 INFO - PID 11912 | [#1] ext.html Cycles:180 Average:30816.84 Median:29956.98 stddev:42926.73 (143.3%) stddev-sans-first:42987.60 08:56:22 INFO - PID 11912 | Values: 704.9 732.9 751.2 1043.7 1065.0 31489.2 32528.2 32541.8 32545.5 32586.2 34208.8 34557.5 34580.5 34598.8 34647.1 6589.5 6768.8 6818.4 6959.5 6959.9 6699.2 6787.3 6793.1 6801.6 6824.0 6792.9 6815.4 6821.2 6827.7 6830.2 6735.4 6748.1 6765.2 6781.9 6828.9 6671.2 6733.6 6733.6 6739.9 6741.8 30817.4 30904.5 30913.8 30916.5 31158.8 3078.3 3101.2 3112.0 3129.5 3130.3 24081.6 24148.5 24164.9 24369.1 24414.4 2599.1 2615.7 2626.6 2642.5 2651.5 152036.2 152170.0 157430.0 160548.2 160753.0 40258.8 40407.0 40489.8 40492.0 40626.8 42217.6 42338.2 42435.4 42472.6 42556.6 12798.4 12806.2 12820.7 12853.6 12862.0 10331.1 10339.1 10341.8 10345.5 10367.3 12811.3 12874.4 12933.0 13017.6 13157.1 5393.2 5398.5 5403.6 5460.4 5552.8 867.2 900.9 912.1 925.8 949.3 20448.7 21018.9 21127.7 21192.0 21367.3 975.6 979.5 1001.4 1015.4 1015.8 10813.8 11181.5 11194.1 11220.6 11397.1 185572.0 186549.0 187348.1 187428.0 187694.0 41123.0 41673.2 41740.8 41788.4 41893.8 1214.8 1248.3 1251.3 1251.4 1255.7 19353.6 20011.2 20598.5 20678.3 20690.8 29824.3 29962.9 29993.0 30006.8 30079.0 151980.0 152418.0 153058.0 153287.2 154035.2 28043.7 28654.0 28866.6 29840.9 29951.1 35254.6 35287.8 35405.5 35682.1 35775.5 25249.0 26836.6 26954.0 27336.6 27444.3 26385.9 27061.9 27638.7 27686.6 28282.6 30581.7 30583.8 30595.1 30601.2 30608.4 26030.0 26201.0 26686.2 27432.6 27832.6 21573.5 22777.4 22785.9 22790.3 22973.9 08:56:22 INFO - PID 11912 | 08:56:22 INFO - PID 11912 | [#2] jquery.html Cycles:180 Average:25827.90 Median:405.80 stddev:62784.83 (15471.8%) stddev-sans-first:62931.94 08:56:22 INFO - PID 11912 | Values: 404.7 406.9 422.1 429.2 430.0 17037.7 17662.6 17707.6 18395.3 19036.8 18735.5 19105.9 19228.2 19298.6 19413.7 5316.4 5352.3 5449.9 5482.7 5548.7 5328.7 5403.9 5408.1 5409.3 5418.5 5168.7 5300.7 5369.4 5372.4 5376.7 5372.1 5422.2 5423.2 5424.6 5429.5 4890.1 4891.7 4912.5 4916.8 4958.2 21956.2 22331.4 22540.0 22557.4 22948.8 1604.1 1653.0 1654.3 1654.5 1655.4 14738.7 14885.8 14946.6 15261.5 15351.9 2062.8 2067.7 2078.6 2078.7 2095.6 89898.6 90859.5 91545.0 92159.5 92177.5 10803.8 11104.5 11162.6 11305.3 11411.9 15343.8 15452.8 15538.6 15565.2 15599.5 7620.6 7792.3 7815.0 7965.6 7973.6 7178.5 7188.4 7237.5 7338.6 7417.9 6952.5 6952.8 7004.8 7106.8 7272.3 2025.9 2061.8 2062.4 2063.4 2156.0 805.7 890.4 898.0 900.2 903.9 17427.1 18126.8 18506.9 18525.9 18661.7 885.7 889.4 904.9 911.2 923.1 9285.7 9902.0 9919.3 9967.6 9976.1 370620.0 373889.0 376428.0 377445.0 379251.0 81519.0 87060.1 88076.6 89016.6 89243.6 1074.0 1089.1 1134.9 1137.4 1139.1 17992.7 18247.3 18860.0 18865.2 19082.2 40629.8 41119.0 41207.8 41314.0 42521.0 51326.5 51451.5 51825.7 53336.7 53827.5 8217.2 8452.8 8613.3 8622.3 8708.3 12558.4 13230.9 13497.3 13721.8 13997.0 11544.2 11658.5 11731.3 11934.7 12180.4 10850.5 11263.7 11352.1 11369.1 11593.7 11396.7 11536.4 11576.3 11583.8 12065.3 8150.7 8428.5 8532.6 8576.8 8623.0 11246.8 11278.8 11453.1 11551.9 11681.9 08:56:22 INFO - PID 11912 | 08:56:22 INFO - PID 11912 | [#3] mootools.html Cycles:180 Average:6629.90 Median:3204.67 stddev:4396.51 (137.2%) stddev-sans-first:4390.00 08:56:22 INFO - PID 11912 | Values: 1212.5 1275.3 1281.0 1288.9 1292.5 10429.7 10649.5 10878.3 10906.5 10906.8 10722.6 10929.6 10950.4 10963.6 10991.3 2270.1 2314.8 2316.7 2333.6 2336.2 2168.7 2231.5 2237.9 2240.2 2246.0 2213.1 2224.0 2229.8 2243.7 2249.4 2013.0 2024.9 2024.9 2025.6 2026.3 2079.1 2082.6 2184.9 2193.2 2200.5 10631.8 10698.8 10702.4 10754.6 10759.8 5585.7 5805.6 5806.8 5810.2 5841.8 3106.7 3186.5 3203.5 3205.8 3243.7 1005.0 1017.0 1023.2 1024.5 1028.5 15641.0 16064.8 16102.7 16144.1 16157.5 4909.7 5068.7 5194.1 5326.5 5361.5 13141.3 13156.8 13161.7 13172.3 13206.5 5755.4 5866.9 5867.2 5869.1 5870.8 5173.0 5237.8 5275.3 5290.7 5309.2 4194.1 4248.8 4314.7 4335.9 4342.8 1315.5 1354.0 1360.2 1369.8 1372.2 642.5 661.3 686.7 690.6 694.1 5264.5 5269.7 5332.1 5470.9 5532.6 568.4 572.6 580.0 582.8 843.6 3803.8 3851.9 3861.2 3880.7 3945.3 13443.7 13815.5 14188.3 14252.8 14360.8 13915.9 14111.6 14144.7 14152.6 14152.7 7760.5 7951.8 7975.6 7982.4 7994.0 6196.9 6359.2 6371.5 6440.5 6523.1 12564.6 12641.6 12747.6 12786.6 12919.4 12955.9 13189.9 13225.3 13226.7 13333.0 8527.5 8679.8 8890.2 8890.6 8900.4 9954.1 9964.7 10062.9 10071.7 10106.8 8434.5 8486.8 8536.1 8635.2 8747.0 8216.2 8241.1 8242.4 8275.6 8451.2 7419.6 7587.7 7595.0 7597.6 7614.2 5360.5 5362.0 5373.4 5508.7 5640.9 5317.4 5412.5 5415.2 5509.6 5569.2 08:56:22 INFO - PID 11912 | 08:56:22 INFO - PID 11912 | [#4] prototype.html Cycles:180 Average:4810.89 Median:5409.55 stddev:1411.13 (26.1%) stddev-sans-first:1375.42 08:56:22 INFO - PID 11912 | Values: 384.5 385.1 386.1 391.5 394.0 5466.7 5510.9 5521.7 5523.9 5527.9 5255.7 5344.7 5360.9 5406.5 5412.6 4243.0 4253.1 4264.0 4276.0 4289.9 4225.8 4234.5 4251.5 4257.7 4258.2 4116.6 4214.5 4230.7 4239.9 4242.4 4235.6 4238.6 4242.4 4249.8 4260.3 3796.8 3823.4 3825.2 3825.5 3829.4 5087.9 5343.2 5354.8 5362.0 5370.8 4857.6 4893.7 4895.0 4906.5 4918.3 5824.9 5825.4 5826.1 5841.5 5862.5 3947.2 4074.8 4105.8 4115.7 4123.4 5917.7 6044.8 6069.7 6076.2 6186.8 4176.2 4184.3 4211.6 4212.4 4225.2 4253.8 4259.6 4262.8 4273.1 4282.8 4803.8 4887.9 4900.8 4909.8 4913.9 5778.0 5849.7 5860.9 5874.2 5893.5 1437.6 1444.2 1445.4 1446.0 1451.0 926.6 982.0 989.1 999.2 1001.9 5001.7 5036.2 5044.5 5048.2 5051.5 5991.3 5994.7 5996.7 6003.0 6020.2 4898.5 4917.6 4925.2 4979.9 4980.6 3157.0 3177.9 3188.3 3195.8 3209.4 5470.9 5594.2 5607.5 5616.4 5616.8 6079.9 6150.7 6162.8 6175.3 6209.7 5588.4 5590.0 5590.3 5599.8 5610.4 5885.6 6013.9 6037.3 6056.9 6075.0 5910.9 5946.0 5954.6 5967.3 5985.7 5396.0 5574.2 5581.6 5608.6 5627.5 4170.7 4210.1 4224.5 4226.6 4234.7 5898.4 6070.8 6096.6 6103.1 6126.2 5844.8 5864.6 5882.3 5893.6 5906.1 5822.7 5851.8 5859.3 5866.9 5888.2 5640.7 5714.7 5764.1 5777.8 5807.0 5904.2 5904.4 5907.6 5914.9 5915.7 5602.1 5684.0 5696.9 5702.3 5711.6 08:56:22 INFO - PID 11912 | 08:56:22 INFO - PID 11912 | [#5] yui.html Cycles:180 Average:16891.02 Median:3041.85 stddev:21402.40 (703.6%) stddev-sans-first:21428.03 08:56:22 INFO - PID 11912 | Values: 729.5 732.8 744.4 746.2 750.2 11305.2 11724.6 13438.9 14182.6 14211.3 15127.8 15872.4 15901.6 15913.0 15932.0 895.9 915.5 918.3 919.8 919.8 911.3 912.8 913.0 913.4 913.8 951.9 959.0 960.2 960.3 962.1 934.3 947.6 954.3 954.7 957.5 674.6 677.4 681.6 681.8 686.1 14505.1 14791.8 14793.4 14802.5 14806.4 15363.5 15794.7 15834.4 15881.6 15902.9 12829.4 12958.7 13042.5 13174.9 13219.7 3011.6 3040.6 3043.1 3043.4 3052.3 82618.0 83368.0 83514.2 83546.0 84063.0 12962.4 13103.4 13187.7 13217.3 13222.7 23319.7 23892.8 24202.2 24210.9 24223.0 5958.8 6002.1 6013.5 6017.7 6064.1 2897.2 2995.4 2999.7 3005.0 3015.6 3788.3 3858.8 3864.8 3865.2 3866.7 709.4 718.5 761.6 822.6 823.6 583.3 589.8 593.7 596.6 616.7 9564.1 10537.8 10938.3 11197.0 11331.5 606.2 613.0 621.9 633.0 636.2 4557.3 4566.5 4604.8 4756.3 4759.3 73283.3 74261.0 74907.6 74986.0 76304.6 67318.0 67483.3 67735.3 67933.7 71354.6 59353.7 60714.0 60967.7 62891.4 64622.7 10269.4 10669.1 11147.6 11370.5 11383.8 28247.3 28449.4 28484.4 29026.7 29482.1 35779.5 36222.8 36709.0 36865.6 37572.6 13622.3 13854.8 13924.2 14012.2 14337.5 15994.0 16154.7 16177.3 16342.8 16547.6 14110.6 14255.1 14359.5 14745.3 14780.9 14851.9 14984.7 15054.8 15095.1 15385.0 13750.9 13780.5 13813.0 13963.2 14107.9 10415.5 10447.6 10488.8 10953.7 10990.6 10949.4 11456.8 11640.6 11669.4 11683.7 08:56:22 INFO - PID 11912 | -------- Summary: end -------- 08:56:22 INFO - PID 11912 | 08:56:23 INFO - TEST-INFO | 11912: exit 0 08:56:23 INFO - TEST-OK | dromaeo_css | took 1147084ms 08:56:23 INFO - TEST-START | kraken 08:56:23 INFO - operating with platform_type : linux_ 08:56:23 INFO - Initialising browser for kraken test... 08:56:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43811/getInfo.html -profile /tmp/tmpaKMZIz/profile 08:56:23 INFO - TEST-INFO | started process 12328 (/builds/slave/test/build/application/firefox/firefox http://localhost:43811/getInfo.html) 08:56:58 INFO - TEST-INFO | 12328: killed by SIGTERM 08:56:58 INFO - Browser initialized. 08:56:58 INFO - Running cycle 1/1 for kraken test... 08:56:58 INFO - TEST-INFO | started process 12554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaKMZIz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:10 INFO - PID 12554 | RSS: Main: 172605440 08:57:10 INFO - PID 12554 | 08:57:13 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43811/tests/kraken/driver.html?testName=audio-beat-detection) 08:57:14 INFO - PID 12554 | RSS: Main: 179609600 08:57:14 INFO - PID 12554 | 08:57:17 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43811/tests/kraken/driver.html?testName=audio-dft) 08:57:17 INFO - PID 12554 | RSS: Main: 178028544 08:57:17 INFO - PID 12554 | 08:57:20 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43811/tests/kraken/driver.html?testName=audio-fft) 08:57:21 INFO - PID 12554 | RSS: Main: 175575040 08:57:21 INFO - PID 12554 | 08:57:23 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43811/tests/kraken/driver.html?testName=audio-oscillator) 08:57:24 INFO - PID 12554 | RSS: Main: 176037888 08:57:24 INFO - PID 12554 | 08:57:26 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43811/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:57:26 INFO - PID 12554 | RSS: Main: 176308224 08:57:26 INFO - PID 12554 | 08:57:29 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43811/tests/kraken/driver.html?testName=imaging-darkroom) 08:57:30 INFO - PID 12554 | RSS: Main: 177655808 08:57:30 INFO - PID 12554 | 08:57:34 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43811/tests/kraken/driver.html?testName=imaging-desaturate) 08:57:34 INFO - PID 12554 | RSS: Main: 176336896 08:57:34 INFO - PID 12554 | 08:57:37 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43811/tests/kraken/driver.html?testName=json-parse-financial) 08:57:38 INFO - PID 12554 | RSS: Main: 176922624 08:57:38 INFO - PID 12554 | 08:57:39 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43811/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:57:40 INFO - PID 12554 | RSS: Main: 177160192 08:57:40 INFO - PID 12554 | 08:57:42 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:57:42 INFO - PID 12554 | RSS: Main: 176693248 08:57:42 INFO - PID 12554 | 08:57:45 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:57:45 INFO - PID 12554 | RSS: Main: 176926720 08:57:45 INFO - PID 12554 | 08:57:48 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:57:49 INFO - PID 12554 | RSS: Main: 177160192 08:57:49 INFO - PID 12554 | 08:57:52 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:57:53 INFO - PID 12554 | RSS: Main: 176934912 08:57:53 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43811/tests/kraken/driver.html?testName=ai-astar) 08:57:55 INFO - PID 12554 | RSS: Main: 178192384 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | __start_tp_report 08:57:55 INFO - PID 12554 | _x_x_mozilla_page_load 08:57:55 INFO - PID 12554 | _x_x_mozilla_page_load_details 08:57:55 INFO - PID 12554 | |i|pagename|runs| 08:57:55 INFO - PID 12554 | |0;ai-astar;103;111;110;109;110;110;112;110;111;111 08:57:55 INFO - PID 12554 | |1;audio-beat-detection;146;129;123;173;122;122;128;137;147;124 08:57:55 INFO - PID 12554 | |2;audio-dft;165;163;167;166;169;166;168;165;163;168 08:57:55 INFO - PID 12554 | |3;audio-fft;73;74;74;116;75;78;77;76;96;76 08:57:55 INFO - PID 12554 | |4;audio-oscillator;85;83;114;83;83;82;98;84;83;110 08:57:55 INFO - PID 12554 | |5;imaging-gaussian-blur;114;115;115;114;122;115;114;115;115;113 08:57:55 INFO - PID 12554 | |6;imaging-darkroom;150;150;153;151;151;150;151;151;158;150 08:57:55 INFO - PID 12554 | |7;imaging-desaturate;100;96;95;94;95;95;99;95;94;95 08:57:55 INFO - PID 12554 | |8;json-parse-financial;54;56;55;57;56;54;56;56;56;56 08:57:55 INFO - PID 12554 | |9;json-stringify-tinderbox;56;57;58;57;56;56;56;56;57;56 08:57:55 INFO - PID 12554 | |10;stanford-crypto-aes;89;88;88;88;88;88;90;91;126;87 08:57:55 INFO - PID 12554 | |11;stanford-crypto-ccm;145;142;142;130;135;131;136;145;145;145 08:57:55 INFO - PID 12554 | |12;stanford-crypto-pbkdf2;189;191;195;192;196;189;190;190;196;204 08:57:55 INFO - PID 12554 | |13;stanford-crypto-sha256-iterative;73;76;76;72;74;72;72;76;74;75 08:57:55 INFO - PID 12554 | __end_tp_report 08:57:55 INFO - PID 12554 | __start_cc_report 08:57:55 INFO - PID 12554 | _x_x_mozilla_cycle_collect,904 08:57:55 INFO - PID 12554 | __end_cc_report 08:57:55 INFO - PID 12554 | __startTimestamp1495814275296__endTimestamp 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | ------- Summary: start ------- 08:57:55 INFO - PID 12554 | Number of tests: 14 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.50 (2.3%) stddev-sans-first:0.88 08:57:55 INFO - PID 12554 | Values: 103.0 111.0 110.0 109.0 110.0 110.0 112.0 110.0 111.0 111.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:133.00 stddev:16.33 (12.3%) stddev-sans-first:16.84 08:57:55 INFO - PID 12554 | Values: 146.0 129.0 123.0 173.0 122.0 122.0 128.0 137.0 147.0 124.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.50 stddev:2.05 (1.2%) stddev-sans-first:2.15 08:57:55 INFO - PID 12554 | Values: 165.0 163.0 167.0 166.0 169.0 166.0 168.0 165.0 163.0 168.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:13.83 (18.2%) stddev-sans-first:14.32 08:57:55 INFO - PID 12554 | Values: 73.0 74.0 74.0 116.0 75.0 78.0 77.0 76.0 96.0 76.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.00 stddev:12.29 (14.8%) stddev-sans-first:12.87 08:57:55 INFO - PID 12554 | Values: 85.0 83.0 114.0 83.0 83.0 82.0 98.0 84.0 83.0 110.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:2.49 (2.2%) stddev-sans-first:2.60 08:57:55 INFO - PID 12554 | Values: 114.0 115.0 115.0 114.0 122.0 115.0 114.0 115.0 115.0 113.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:2.46 (1.6%) stddev-sans-first:2.55 08:57:55 INFO - PID 12554 | Values: 150.0 150.0 153.0 151.0 151.0 150.0 151.0 151.0 158.0 150.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.04 (2.2%) stddev-sans-first:1.50 08:57:55 INFO - PID 12554 | Values: 100.0 96.0 95.0 94.0 95.0 95.0 99.0 95.0 94.0 95.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:0.97 (1.7%) stddev-sans-first:0.83 08:57:55 INFO - PID 12554 | Values: 54.0 56.0 55.0 57.0 56.0 54.0 56.0 56.0 56.0 56.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 08:57:55 INFO - PID 12554 | Values: 56.0 57.0 58.0 57.0 56.0 56.0 56.0 56.0 57.0 56.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#10] stanford-crypto-aes Cycles:10 Average:92.30 Median:88.00 stddev:11.90 (13.5%) stddev-sans-first:12.56 08:57:55 INFO - PID 12554 | Values: 89.0 88.0 88.0 88.0 88.0 88.0 90.0 91.0 126.0 87.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:143.50 stddev:6.04 (4.2%) stddev-sans-first:6.08 08:57:55 INFO - PID 12554 | Values: 145.0 142.0 142.0 130.0 135.0 131.0 136.0 145.0 145.0 145.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.20 Median:193.50 stddev:4.69 (2.4%) stddev-sans-first:4.72 08:57:55 INFO - PID 12554 | Values: 189.0 191.0 195.0 192.0 196.0 189.0 190.0 190.0 196.0 204.0 08:57:55 INFO - PID 12554 | 08:57:55 INFO - PID 12554 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:74.50 stddev:1.70 (2.3%) stddev-sans-first:1.76 08:57:55 INFO - PID 12554 | Values: 73.0 76.0 76.0 72.0 74.0 72.0 72.0 76.0 74.0 75.0 08:57:55 INFO - PID 12554 | -------- Summary: end -------- 08:57:55 INFO - PID 12554 | 08:57:56 INFO - TEST-INFO | 12554: exit 0 08:57:56 INFO - TEST-OK | kraken | took 92702ms 08:57:56 INFO - SUITE-END | took 1239s 08:57:56 INFO - Completed test suite (00:20:40) 08:57:56 INFO - javascript benchmark 08:57:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6868.286186930157, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2741.0269354379207, 2742.9588556171648, 2745.2176129803006, 2772.209920172751, 2784.484870298995, 5162.148245539491, 5348.491893270138, 5360.303160589123, 5382.2464854920345, 5395.136778115502, 5313.707746073965, 5330.1205301125265, 5339.092354299769, 5356.598255130862, 5441.401445840955, 4749.216379297412, 4761.738104404257, 4782.354382158416, 4788.209945359029, 4820.542048505404, 4752.881177970544, 4794.2329227323635, 4815.470298267188, 4817.108834865544, 4862.927056094161, 4699.036697477009, 4713.505081966378, 4729.55069268419, 4751.928721069186, 4771.498992605779, 4739.478657347689, 4779.139754844126, 4781.832635857763, 4818.734969576672, 4819.879503012417, 4721.150192965265, 4731.36126622905, 4736.478987311393, 4752.762361881927, 4777.928331075037, 5340.546053585411, 5370.3287089113865, 5394.568434525228, 5408.296921400193, 5415.079436495806, 5680.744366503517, 5750.856228594319, 5760.798372056958, 5820.941790582082, 5826.067829147359, 5795.246617939683, 5796.5072968797285, 5804.216430781875, 5807.825765227008, 5811.796587119473, 5395.352557693023, 5397.4062853086125, 5400.972995135038, 5408.59435542328, 5409.459054094637, 5762.366139724627, 5787.450192231731, 5895.823125306248, 5927.881442371128, 5938.762449501972, 5685.891251205975, 5740.856478588069, 5742.712864356766, 5774.711264436762, 5799.768009279666, 5812.070068788974, 5819.79630712923, 5834.27071616048, 5837.445442682938, 5837.7664893404635, 5566.942280966684, 5648.661080335193, 5790.0, 5799.797007104731, 5801.448862358069, 5734.7132643368495, 5770.336411312669, 5842.941570584239, 5855.033919403336, 5855.355910849803, 4855.878603034952, 4858.708477491362, 4867.294242334912, 4869.245266983623, 4910.017996400734, 4140.565240649748, 4144.585541445831, 4149.25313443577, 4171.416001759756, 4206.684498662613, 4810.8797280068275, 4877.6829506081995, 4880.731559764176, 4905.533974272438, 4919.089968355794, 5799.768009279582, 5811.88376232473, 5814.5348372130975, 5823.970880145657, 5858.238429004287, 4841.467438581753, 4881.048195601824, 4886.193778026586, 4905.1416002200185, 4928.211486162197, 5022.84931452057, 5044.293798868088, 5093.0, 5102.795888164432, 5113.181890897513, 5309.920351194658, 5325.174597937326, 5334.0, 5370.812021579226, 5385.703786291791, 5620.269364982526, 5714.342850572238, 5731.598788084794, 5743.3395159557185, 5772.509336706427, 5298.364196296469, 5325.973370133124, 5355.946440535545, 5394.460553944574, 5439.5920305976415, 5660.179274005329, 5669.744861481161, 5718.370979192202, 5729.799457018984, 5750.48245657876, 5673.858153546194, 5743.684097374685, 5750.913736293875, 5801.709914504342, 5843.357230704704, 5572.554195664418, 5591.4688104629995, 5628.099504079328, 5664.178694089252, 5671.319441666861, 5616.550675945996, 5617.185508101221, 5624.212610234652, 5629.493345598752, 5631.0, 5454.209139674805, 5485.341758988788, 5555.0834112371, 5555.8888822222525, 5558.305211848519, 5679.318481782213, 5681.176229446624, 5694.430556944272, 5708.543316534584, 5729.3984131665575, 5453.536449401845, 5464.836054918359, 5474.3704473986, 5517.255170552085, 5521.558275337883], "value": 5232.076617571884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.8731228378892, 732.8607564562733, 751.2037240525042, 1043.7390652336917, 1064.9627263045795, 31489.21276968074, 32528.18679533013, 32541.837290813542, 32545.51181732276, 32586.185345366317, 34208.828955855184, 34557.48163777539, 34580.48129278063, 34598.827005865, 34647.13382165447, 6589.505787065966, 6768.8307792305095, 6818.420434263081, 6959.478039147059, 6959.8956015659805, 6699.162604674416, 6787.287334829846, 6793.116894803668, 6801.625910574917, 6824.0, 6792.864142717142, 6815.38661520463, 6821.249662537117, 6827.658617069152, 6830.214525329576, 6735.427488663469, 6748.089007983908, 6765.2219994700745, 6781.898271525931, 6828.897566536506, 6671.166104236971, 6733.562318449285, 6733.562318449285, 6739.932600673979, 6741.764038258638, 30817.38365232683, 30904.53643195354, 30913.845430772926, 30916.53625195624, 31158.844205779053, 3078.2766049978236, 3101.2401961519345, 3112.004158669204, 3129.5149251865996, 3130.311331507065, 24081.63877541838, 24148.517029659484, 24164.879175604186, 24369.14707985212, 24414.389640259134, 2599.129291687287, 2615.738426157388, 2626.619140224676, 2642.471505698849, 2651.469706058796, 152036.2398188002, 152170.0, 157430.0, 160548.19725901412, 160753.0, 40258.79870600628, 40407.0, 40489.79755101206, 40492.0, 40626.79686601548, 42217.57782422198, 42338.15323693571, 42435.363469547985, 42472.57527424748, 42556.57443425588, 12798.424070916644, 12806.167599106027, 12820.743585128244, 12853.550125745554, 12862.0, 10331.070203681706, 10339.121174700234, 10341.793164136825, 10345.482725863676, 10367.274290799722, 12811.295378754072, 12874.420651070724, 12933.0, 13017.609471715863, 13157.144785588906, 5393.2449457076045, 5398.541124004503, 5403.594730395157, 5460.426655201147, 5552.751640290476, 867.197841996151, 900.8603666431713, 912.1243606138181, 925.842606756853, 949.3307218411004, 20448.693269600968, 21018.949052547312, 21127.683084753742, 21192.046357913932, 21367.337870156374, 975.6438899801522, 979.4955597867104, 1001.3891526169031, 1015.3958394755109, 1015.7968406318765, 10813.783724325469, 11181.496832642388, 11194.10447164225, 11220.607278745205, 11397.145214108976, 185572.0, 186549.0, 187348.06325968282, 187428.0, 187694.0, 41123.0, 41673.166536669094, 41740.791296043935, 41788.37317440241, 41893.79053104715, 1214.8420705308254, 1248.2510493703705, 1251.255502975728, 1251.3680591301334, 1255.7362953779625, 19353.612927741084, 20011.199552017755, 20598.485037873572, 20678.276260330815, 20690.793092068885, 29824.25439364033, 29962.850185749805, 29993.0, 30006.849965750906, 30079.0, 151980.0, 152418.0, 153058.0, 153287.23356383594, 154035.22982385015, 28043.71956280411, 28654.0, 28866.567001494575, 29840.850795745882, 29951.101466956025, 35254.64745352514, 35287.82356088306, 35405.468917965736, 35682.10794730153, 35775.46336804898, 25249.0, 26836.59745103864, 26954.0, 27336.589951151145, 27444.313892152855, 26385.868070659522, 27061.86469067642, 27638.723612763613, 27686.584701229094, 28282.575761363183, 30581.694183058775, 30583.847080765343, 30595.08214753561, 30601.23496912595, 30608.387832242784, 26030.0, 26201.0, 26686.19941401761, 27432.588511172748, 27832.582511262754, 21573.46066348291, 22777.430564236027, 22785.89853826327, 22790.31629051131, 22973.88513057424], "value": 14453.214667144104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.6722155054408, 406.932856078747, 422.08618341291105, 429.19954285258, 429.96560275177984, 17037.659246815056, 17662.586993040542, 17707.645847083066, 18395.264189432408, 19036.80963190371, 18735.531611709714, 19105.904470477664, 19228.230870765186, 19298.614027719435, 19413.708794368096, 5316.441773613773, 5352.330958630171, 5449.945500545004, 5482.671039737608, 5548.72256387179, 5328.653637513549, 5403.864903377427, 5408.080626293539, 5409.29679141711, 5418.539424148952, 5168.741562921858, 5300.734963251842, 5369.40936496985, 5372.435894231108, 5376.677399356051, 5372.086745253297, 5422.213779002042, 5423.159410291371, 5424.647397919122, 5429.484199001088, 4890.119778439879, 4891.730954797485, 4912.459629440758, 4916.778744956486, 4958.20668693011, 21956.23153189647, 22331.44171395728, 22540.0, 22557.43606409853, 22948.770512294832, 1604.085671167435, 1653.0081950829526, 1654.33826469412, 1654.5201891451466, 1655.4454257823643, 14738.747206487462, 14885.776713349309, 14946.62633434162, 15261.465848695354, 15351.923240383838, 2062.7834077421803, 2067.700183473403, 2078.615456140619, 2078.7193728846714, 2095.6437405641077, 89898.5505072477, 90859.54570227173, 91545.0, 92159.53920230355, 92177.53911230469, 10803.83794243087, 11104.500297486633, 11162.609308674157, 11305.26515776472, 11411.942940285246, 15343.846561534241, 15452.768208476882, 15538.611534711497, 15565.22173891301, 15599.454019109276, 7620.5808680523105, 7792.337651299589, 7815.0, 7965.561894095765, 7973.60131993398, 7178.533395329287, 7188.353048225685, 7237.493375463667, 7338.633068346561, 7417.888731669029, 6952.470456499663, 6952.756653517103, 7004.789856304319, 7106.751263705849, 7272.272772722686, 2025.9493512662007, 2061.80412860778, 2062.3812856143095, 2063.401613532059, 2156.0, 805.7059173401666, 890.398980688046, 897.9820403591891, 900.243795212012, 903.8779764731677, 17427.128643567772, 18126.81873181278, 18506.907465462587, 18525.90737046306, 18661.720074198896, 885.7431344910033, 889.3952112563389, 904.8914130304406, 911.1844898815656, 923.0677016213673, 9285.675001375055, 9902.0, 9919.256055795844, 9967.55146018431, 9976.102150806317, 370620.0, 373889.0, 376428.0, 377445.0, 379251.0, 81519.0, 87060.12939870647, 88076.5596172015, 89016.5549172263, 89243.55378223068, 1073.973150671224, 1089.0797276301355, 1134.8865113488584, 1137.3517095255625, 1139.0887290167832, 17992.730109048112, 18247.270109196015, 18860.0, 18865.24539018424, 19082.236710531422, 40629.796851015555, 41119.0, 41207.79396103, 41314.0, 42521.0, 51326.48673513217, 51451.48548514467, 51825.740871295406, 53336.73331633317, 53827.46172538224, 8217.219364160395, 8452.8022714096, 8613.3109351253, 8622.310215182895, 8708.34687398435, 12558.43487043067, 13230.941524678195, 13497.257650828906, 13721.794173087612, 13997.0, 11544.249623774764, 11658.475368608264, 11731.296122232694, 11934.701632459259, 12180.390980451119, 10850.45747712627, 11263.66209013731, 11352.148588856035, 11369.147313951322, 11593.710157246136, 11396.715082123013, 11536.365499897585, 11576.305421674726, 11583.76832463329, 12065.276083435023, 8150.673973041249, 8428.45215061019, 8532.616032278438, 8576.785580360542, 8622.956885215533, 11246.775064498828, 11278.774424511628, 11453.141014424118, 11551.884481155417, 11681.88318116842], "value": 9093.112115019328, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.4665147335172, 1275.2922128218847, 1281.0328202207336, 1288.8517820450645, 1292.515306759965, 10429.687109386712, 10649.52077156528, 10878.347299162037, 10906.50920708568, 10906.836397454044, 10722.571097156124, 10929.617463388782, 10950.39772812495, 10963.61627343043, 10991.340519568812, 2270.0919632147147, 2314.8148148148193, 2316.698829152216, 2333.6382860656627, 2336.158982766203, 2168.728908886389, 2231.520223152022, 2237.9328620141423, 2240.249516412004, 2245.9663105053437, 2213.147938043857, 2224.010315409643, 2229.7993180613744, 2243.674667173259, 2249.4151520604596, 2013.043804193004, 2024.8683835550642, 2024.9493762655977, 2025.605007023631, 2026.3313106674761, 2079.105984426696, 2082.55225126597, 2184.8907554622206, 2193.1885202475187, 2200.526886719347, 10631.84052239217, 10698.78602427947, 10702.357858528514, 10754.623588174376, 10759.784804303948, 5585.748641311151, 5805.622634528784, 5806.82579522615, 5810.244668193108, 5841.766329346821, 3106.673799251069, 3186.5060915558124, 3203.5034569641743, 3205.8397080146133, 3243.659415761358, 1004.9949750251202, 1016.9847452288221, 1023.1661196125209, 1024.515549791752, 1028.4806172882647, 15641.0, 16064.839351606568, 16102.677946441123, 16144.112073835935, 16157.515274541782, 4909.729964851896, 5068.695878247243, 5194.142966410575, 5326.46735326472, 5361.463853614608, 13141.34293285351, 13156.802647960289, 13161.670958226121, 13172.341382931007, 13206.537771177962, 5755.395683453261, 5866.882662346729, 5867.207926929896, 5869.06095024794, 5870.7945221917025, 5173.0, 5237.790488380499, 5275.340582427197, 5290.68255904647, 5309.230161626542, 4194.140201258796, 4248.808803603845, 4314.697971142053, 4335.913281734348, 4342.848000319974, 1315.467235769515, 1353.9864601354057, 1360.1702961193664, 1369.7671395862728, 1372.1629805818443, 642.4667525953447, 661.2825084782968, 686.6944209826679, 690.5545922879714, 694.1427337238506, 5264.499872512105, 5269.683818970874, 5332.120200167006, 5470.863228419242, 5532.640378375473, 568.4372471253429, 572.5791543215734, 580.0255570641278, 582.7989343676425, 843.6414523827349, 3803.8098095095133, 3851.9422208666892, 3861.1698484825897, 3880.708946828999, 3945.270125026879, 13443.663908402172, 13815.51645692416, 14188.290585470892, 14252.786208206886, 14360.784588231185, 13915.930420347833, 14111.576652700436, 14144.71710565783, 14152.575422737335, 14152.716945661236, 7760.495567788189, 7951.840963180704, 7975.5613441261285, 7982.401319901031, 7994.040715114107, 6196.907046394217, 6359.173307470184, 6371.5221358397375, 6440.5491615588335, 6523.11937888398, 12564.560240391542, 12641.620751377473, 12747.61757147287, 12786.61640150797, 12919.418626162033, 12955.935220323838, 13189.93405033007, 13225.338733063116, 13226.735465290449, 13333.0, 8527.53098579584, 8679.826403472021, 8890.24432923183, 8890.59992300361, 8900.376973611785, 9954.054364835329, 9964.651237206954, 10062.899371006197, 10071.748206294902, 10106.8483972739, 8434.451760635538, 8486.83026339482, 8536.061033286209, 8635.222829945335, 8746.956265218632, 8216.178382161976, 8241.093479717347, 8242.381821363542, 8275.586220689062, 8451.197136272045, 7419.591922444318, 7587.734429294948, 7595.0, 7597.582132982518, 7614.16244213125, 5360.499060263132, 5362.016054060023, 5373.408925018323, 5508.724563771715, 5640.88718225625, 5317.441668624893, 5412.484504338791, 5415.160650099241, 5509.586780991362, 5569.248151499658], "value": 4880.228083249341, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.5078299776284, 385.08158043067283, 386.1215734204684, 391.47737770076947, 394.0483731787734, 5466.699331536769, 5510.878311849941, 5521.723913804309, 5523.861903452405, 5527.889442211163, 5255.686736142374, 5344.679319240839, 5360.91958620621, 5406.459354064592, 5412.648177868436, 4243.0, 4253.128108737701, 4263.978680106595, 4275.978620106911, 4289.935650965238, 4225.767582782945, 4234.534201237861, 4251.532331443539, 4257.6806739494505, 4258.233517966764, 4116.629503344699, 4214.473190851144, 4230.725002874803, 4239.894002649928, 4242.369730766929, 4235.618794308496, 4238.618524332809, 4242.363645453176, 4249.80875860587, 4260.297050986584, 3796.791176485292, 3823.4073718573386, 3825.196708691178, 3825.488931871895, 3829.4064420014943, 5087.923681144785, 5343.225232341289, 5354.759035843396, 5361.973190134025, 5370.812021579265, 4857.562819346276, 4893.68191067583, 4894.975525122387, 4906.460289368202, 4918.262260660894, 5824.88350232993, 5825.388334224887, 5826.096515334736, 5841.503472204825, 5862.50168735658, 3947.230290093433, 4074.7555146691293, 4105.753654780723, 4115.73247738896, 4123.36087906375, 5917.733701983421, 6044.788432404889, 6069.726862291208, 6076.240469941257, 6186.81439556814, 4176.206520761107, 4184.330507118846, 4211.578842115764, 4212.389203565466, 4225.218334608107, 4253.829846806155, 4259.637930775857, 4262.829486820555, 4273.059926816096, 4282.807273672693, 4803.831865884677, 4887.877803054952, 4900.779464924087, 4909.828156014522, 4913.87715307113, 5778.0, 5849.660135945655, 5860.882782344414, 5874.206982057368, 5893.469587737039, 1437.5974727076227, 1444.1768192130594, 1445.3712635003808, 1445.978310325346, 1450.9564713058626, 926.6108234541508, 981.9754506137403, 989.1295659819313, 999.2405771613626, 1001.9248556358302, 5001.724905130252, 5036.219385995177, 5044.495550444926, 5048.192289233705, 5051.494850514919, 5991.2510936132985, 5994.730237139339, 5996.700164991733, 6002.9794934861175, 6020.217371741734, 4898.53463920927, 4917.631177661689, 4925.236588328815, 4979.925301120486, 4980.576650984707, 3157.0, 3177.872885084617, 3188.3463889902514, 3195.8082515049173, 3209.3902158589794, 5470.863228419322, 5594.20985284705, 5607.52336051432, 5616.354119276254, 5616.775328986795, 6079.875223083744, 6150.661713605705, 6162.845928851725, 6175.289841668266, 6209.720562574605, 5588.38527761954, 5590.009345000487, 5590.301212348457, 5599.832005039774, 5610.382857885629, 5885.588008839341, 6013.879722405615, 6037.305709843425, 6056.939430605814, 6074.997625391761, 5910.881782364243, 5946.0, 5954.642721436728, 5967.343592204767, 5985.730642121202, 5396.0, 5574.174987138531, 5581.609287349846, 5608.579356548194, 5627.549796016391, 4170.72890262132, 4210.136921930935, 4224.4930608327195, 4226.598473145046, 4234.661227101763, 5898.4101589840675, 6070.785842831363, 6096.573239873166, 6103.145559621567, 6126.23422072241, 5844.824655260349, 5864.589478736618, 5882.323532793613, 5893.5874488787085, 5906.084556893688, 5822.737976791139, 5851.765929362778, 5859.296884373903, 5866.882662346815, 5888.175655408332, 5640.689762062962, 5714.742836572447, 5764.106563482667, 5777.768889244383, 5807.0, 5904.202932604044, 5904.350521442724, 5907.556933229939, 5914.852128696817, 5915.733791979285, 5602.1036634138345, 5684.005299072728, 5696.857578560569, 5702.315722113373, 5711.628744131618], "value": 4374.719126471853, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.4784229276066, 732.8167958010497, 744.3524134003418, 746.153116213098, 750.1673142811478, 11305.152113591472, 11724.648260552198, 13438.932805335971, 14182.645433864145, 14211.28943552822, 15127.773083403757, 15872.444464443746, 15901.602459938507, 15913.04521728697, 15932.0, 895.9238464730489, 915.4507295622607, 918.2562124679031, 919.7562645898843, 919.8252332056887, 911.3438324406417, 912.7900582865944, 913.0139449394671, 913.3789023464042, 913.8172365526921, 951.8810148731409, 958.9808203835919, 960.2126256469697, 960.3373672166183, 962.0523784072683, 934.3039435620473, 947.6114792934898, 954.3224310739383, 954.7422196007109, 957.4638202606562, 674.6491824251411, 677.4140368581191, 681.6455443169524, 681.7647911470535, 686.0977814174345, 14505.129692218396, 14791.778123328158, 14793.40826366944, 14802.481913133097, 14806.407743690348, 15363.4622788203, 15794.684106317809, 15834.366625334973, 15881.602959926095, 15902.920485397615, 12829.358532073453, 12958.740825183539, 13042.543510977164, 13174.868251317555, 13219.66950826237, 3011.578379026938, 3040.6047213862057, 3043.1022848259818, 3043.3913217356617, 3052.267455810612, 82618.0, 83368.0, 83514.16485835185, 83546.0, 84063.0, 12962.351882405843, 13103.410346534429, 13187.73624527504, 13217.273049982152, 13222.669433264246, 23319.650205246933, 23892.761072389054, 24202.15292464755, 24210.87894560516, 24223.0, 5958.791442299499, 6002.069679199731, 6013.54898382623, 6017.69911504423, 6064.090386442069, 2897.203269101014, 2995.445842519141, 2999.7450216731386, 3004.9549256761165, 3015.5627434021944, 3788.299164654548, 3858.78776667286, 3864.8067596620617, 3865.2269546090893, 3866.7293289469467, 709.3651182191909, 718.4575645387699, 761.5735188294462, 822.5681517203396, 823.5799742131436, 583.285475292763, 589.7611467355728, 593.7476572456688, 596.6360520082746, 616.7255571270741, 9564.13922746956, 10537.84193237102, 10938.343699378063, 11197.0, 11331.490082946288, 606.2385832532767, 612.9877402452015, 621.9191505104308, 632.9715162817685, 636.1507387637556, 4557.316402539645, 4566.543345665474, 4604.7927843247135, 4756.286557016475, 4759.286107083896, 73283.26716732765, 74261.0, 74907.62546187235, 74986.0, 76304.61847690726, 67318.0, 67483.32516674869, 67735.32264677389, 67933.66033169802, 71354.64322678457, 59353.70323148357, 60714.0, 60967.695161524796, 62891.371086289466, 64622.67688661526, 10269.435181065113, 10669.093127084285, 11147.609833655782, 11370.488328025092, 11383.829242561535, 28247.29381765472, 28449.43101138007, 28484.43031139324, 29026.7097329024, 29482.11553653394, 35779.46330805092, 36222.8188859054, 36709.0, 36865.63134368622, 37572.62427375691, 13622.318884055956, 13854.792178117135, 13924.2341671205, 14012.159270443399, 14337.498187563386, 15994.040357578582, 16154.67690646204, 16177.326666169305, 16342.754858677366, 16547.586310342336, 14110.576682699535, 14255.144691318554, 14359.497417590752, 14745.336459859118, 14780.852191478378, 14851.851481485479, 14984.700305993601, 15054.849451505344, 15095.094294342374, 15385.0, 13750.862491374959, 13780.517681881487, 13813.0, 13963.162210267417, 14107.929460353043, 10415.479226038819, 10447.582096716047, 10488.790224195625, 10953.659133963898, 10990.615328463466, 10949.397783121685, 11456.82814757796, 11640.592579259684, 11669.35818529989, 11683.707907302385], "value": 7150.204957360386, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 109.0, 110.0, 110.0, 112.0, 110.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 129.0, 123.0, 173.0, 122.0, 122.0, 128.0, 137.0, 147.0, 124.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 167.0, 166.0, 169.0, 166.0, 168.0, 165.0, 163.0, 168.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 116.0, 75.0, 78.0, 77.0, 76.0, 96.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 114.0, 83.0, 83.0, 82.0, 98.0, 84.0, 83.0, 110.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 122.0, 115.0, 114.0, 115.0, 115.0, 113.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 153.0, 151.0, 151.0, 150.0, 151.0, 151.0, 158.0, 150.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 95.0, 94.0, 95.0, 95.0, 99.0, 95.0, 94.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 57.0, 56.0, 54.0, 56.0, 56.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 57.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 88.0, 88.0, 88.0, 90.0, 91.0, 126.0, 87.0], "value": 92.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 142.0, 142.0, 130.0, 135.0, 131.0, 136.0, 145.0, 145.0, 145.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 191.0, 195.0, 192.0, 196.0, 189.0, 190.0, 190.0, 196.0, 204.0], "value": 193.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 76.0, 72.0, 74.0, 72.0, 72.0, 76.0, 74.0, 75.0], "value": 74.0, "unit": "score"}]}]} 08:57:57 INFO - Return code: 0 08:57:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:57:57 INFO - # TBPL SUCCESS # 08:57:57 INFO - Running post-action listener: _resource_record_post_action 08:57:57 INFO - [mozharness: 2017-05-26 15:57:57.093545Z] Finished run-tests step (success) 08:57:57 INFO - Running post-run listener: _resource_record_post_run 08:57:57 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 12288; Write bytes: 408268800; Read time: 320; Write time: 293848 08:57:57 INFO - TinderboxPrint: CPU usage
12.7% 08:57:57 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 320 08:57:57 INFO - TinderboxPrint: I/O write bytes / time
408,268,800 / 293,848 08:57:57 INFO - TinderboxPrint: CPU idle
8,752.2 (87.3%) 08:57:57 INFO - TinderboxPrint: CPU user
1,218.6 (12.2%) 08:57:57 INFO - TinderboxPrint: Swap in / out
0 / 0 08:57:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 98844672; Read time: 80; Write time: 89396 08:57:57 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309010432; Read time: 224; Write time: 204424 08:57:57 INFO - Running post-run listener: _upload_blobber_files 08:57:57 INFO - Blob upload gear active. 08:57:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:57:57 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 08:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:57:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:57:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:57:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:59 INFO - (blobuploader) - INFO - Done attempting. 08:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:59 INFO - (blobuploader) - INFO - Done attempting. 08:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:00 INFO - (blobuploader) - INFO - Done attempting. 08:58:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:10 INFO - (blobuploader) - INFO - Done attempting. 08:58:10 INFO - (blobuploader) - INFO - Iteration through files over. 08:58:10 INFO - Return code: 0 08:58:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:58:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:58:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cd6dd1ad27bf4adf5a626e63f69b159d468fedc05354eb0a0cc18611da42d09927dcc98bf2846f1dfeb31be06ad98c91a1c9d03c2251a2ccebf7e8cdc440720", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e4d3980461360aa61e38cade7b535054585e8bec5e2c0aa81cf599deac6e6c692b09087c093867dee036777382adce9a74ca70e9bdac97ed9ccd7b53f3dc70c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aff6b4d93c8e99a3b0e22b8493f588d622ef6c5a1c0d1d4db2b6f7617ad34ad2891c036f9629ebbe12c0c065605f3842e5eb580c423e20222580765c40da726a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fa58aae717253ab2677890ded61a840181fa964e554859a6ad8bd340e0d421e30d4d0e403925ef4a04db3878a239355051cae827ada726f017a225de2b2306b"} 08:58:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:58:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:58:10 INFO - Contents: 08:58:10 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cd6dd1ad27bf4adf5a626e63f69b159d468fedc05354eb0a0cc18611da42d09927dcc98bf2846f1dfeb31be06ad98c91a1c9d03c2251a2ccebf7e8cdc440720", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e4d3980461360aa61e38cade7b535054585e8bec5e2c0aa81cf599deac6e6c692b09087c093867dee036777382adce9a74ca70e9bdac97ed9ccd7b53f3dc70c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aff6b4d93c8e99a3b0e22b8493f588d622ef6c5a1c0d1d4db2b6f7617ad34ad2891c036f9629ebbe12c0c065605f3842e5eb580c423e20222580765c40da726a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fa58aae717253ab2677890ded61a840181fa964e554859a6ad8bd340e0d421e30d4d0e403925ef4a04db3878a239355051cae827ada726f017a225de2b2306b"} 08:58:10 INFO - Running post-run listener: copy_logs_to_upload_dir 08:58:10 INFO - Copying logs to upload dir... 08:58:10 INFO - mkdir: /builds/slave/test/build/upload/logs 08:58:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1320.312434 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-26 08:58:10.563692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 08:58:10.567816) ========= 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=14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cd6dd1ad27bf4adf5a626e63f69b159d468fedc05354eb0a0cc18611da42d09927dcc98bf2846f1dfeb31be06ad98c91a1c9d03c2251a2ccebf7e8cdc440720", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e4d3980461360aa61e38cade7b535054585e8bec5e2c0aa81cf599deac6e6c692b09087c093867dee036777382adce9a74ca70e9bdac97ed9ccd7b53f3dc70c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aff6b4d93c8e99a3b0e22b8493f588d622ef6c5a1c0d1d4db2b6f7617ad34ad2891c036f9629ebbe12c0c065605f3842e5eb580c423e20222580765c40da726a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fa58aae717253ab2677890ded61a840181fa964e554859a6ad8bd340e0d421e30d4d0e403925ef4a04db3878a239355051cae827ada726f017a225de2b2306b"} build_url:https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cd6dd1ad27bf4adf5a626e63f69b159d468fedc05354eb0a0cc18611da42d09927dcc98bf2846f1dfeb31be06ad98c91a1c9d03c2251a2ccebf7e8cdc440720", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e4d3980461360aa61e38cade7b535054585e8bec5e2c0aa81cf599deac6e6c692b09087c093867dee036777382adce9a74ca70e9bdac97ed9ccd7b53f3dc70c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aff6b4d93c8e99a3b0e22b8493f588d622ef6c5a1c0d1d4db2b6f7617ad34ad2891c036f9629ebbe12c0c065605f3842e5eb580c423e20222580765c40da726a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fa58aae717253ab2677890ded61a840181fa964e554859a6ad8bd340e0d421e30d4d0e403925ef4a04db3878a239355051cae827ada726f017a225de2b2306b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 08:58:10.596429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:58:10.596755) ========= 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=14ef55db36f7623abb31b9cf000001d5-1495812664.274680-1213222518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:58:10.680948) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 08:58:10.681278) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 08:58:10.681600) ========= ========= Total master_lag: 0.19 =========