builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1498130970.3 results: success (0) revision: 71733bc984a1355ad99a0df00c9d6f73c369fbe9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:30.301651) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:30.302161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:30.302531) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:30.323567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:30.323968) ========= 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=41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-22 04:29:30-- 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% 49.4M=0s 2017-06-22 04:29:30 (49.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.562143 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:30.899319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:30.902885) ========= 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=41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017027 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:30.953576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-22 04:29:30.953995) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 71733bc984a1355ad99a0df00c9d6f73c369fbe9 --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 71733bc984a1355ad99a0df00c9d6f73c369fbe9 --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=41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-22 04:29:30,904 truncating revision to first 12 chars 2017-06-22 04:29:30,904 Setting DEBUG logging. 2017-06-22 04:29:30,904 attempt 1/10 2017-06-22 04:29:30,904 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/71733bc984a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-22 04:29:31,944 unpacking tar archive at: mozilla-central-71733bc984a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.408931 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-22 04:29:32.399982) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:32.400390) ========= script_repo_revision: 71733bc984a1355ad99a0df00c9d6f73c369fbe9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:32.404038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:32.404466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-22 04:29:32.414891) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-06-22 04:29:32.415274) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:29:32 INFO - MultiFileLogger online at 20170622 04:29:32 in /builds/slave/test 04:29:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:29:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:29:32 INFO - {'append_to_log': False, 04:29:32 INFO - 'base_work_dir': '/builds/slave/test', 04:29:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:29:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:29:32 INFO - 'branch': 'Firefox-Non-PGO', 04:29:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:29:32 INFO - 'config_files': ('talos/linux_config.py',), 04:29:32 INFO - 'default_actions': ('clobber', 04:29:32 INFO - 'read-buildbot-config', 04:29:32 INFO - 'download-and-extract', 04:29:32 INFO - 'populate-webroot', 04:29:32 INFO - 'create-virtualenv', 04:29:32 INFO - 'install', 04:29:32 INFO - 'setup-mitmproxy', 04:29:32 INFO - 'run-tests'), 04:29:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:29:32 INFO - 'download_minidump_stackwalk': True, 04:29:32 INFO - 'download_symbols': 'ondemand', 04:29:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:29:32 INFO - 'tooltool.py': '/tools/tooltool.py', 04:29:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:29:32 INFO - '/tools/misc-python/virtualenv.py')}, 04:29:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:29:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:29:32 INFO - 'gecko_profile': False, 04:29:32 INFO - 'gecko_profile_interval': 0, 04:29:32 INFO - 'installer_path': 'installer.exe', 04:29:32 INFO - 'log_level': 'info', 04:29:32 INFO - 'log_name': 'talos', 04:29:32 INFO - 'log_to_console': True, 04:29:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:29:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:29:32 INFO - 'opt_config_files': (), 04:29:32 INFO - 'pip_index': False, 04:29:32 INFO - 'suite': 'dromaeojs-e10s', 04:29:32 INFO - 'system_bits': '32', 04:29:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:29:32 INFO - 'title': 'talos-linux64-ix-024', 04:29:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:29:32 INFO - 'use_talos_json': True, 04:29:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:29:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:29:32 INFO - 'work_dir': 'build'} 04:29:32 INFO - [mozharness: 2017-06-22 11:29:32.467888Z] Running clobber step. 04:29:32 INFO - Running pre-action listener: _resource_record_pre_action 04:29:32 INFO - Running main action method: clobber 04:29:32 INFO - rmtree: /builds/slave/test/build 04:29:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:29:34 INFO - Running post-action listener: _resource_record_post_action 04:29:34 INFO - [mozharness: 2017-06-22 11:29:34.008966Z] Finished clobber step (success) 04:29:34 INFO - [mozharness: 2017-06-22 11:29:34.009065Z] Running read-buildbot-config step. 04:29:34 INFO - Running pre-action listener: _resource_record_pre_action 04:29:34 INFO - Running main action method: read_buildbot_config 04:29:34 INFO - Using buildbot properties: 04:29:34 INFO - { 04:29:34 INFO - "project": "", 04:29:34 INFO - "product": "firefox", 04:29:34 INFO - "who": "cbook@mozilla.com", 04:29:34 INFO - "installer_path": "public/build/target.tar.bz2", 04:29:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:29:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:29:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:29:34 INFO - "stage_platform": "linux64", 04:29:34 INFO - "basedir": "/builds/slave/test", 04:29:34 INFO - "buildnumber": 681, 04:29:34 INFO - "platform": "ubuntu64_hw", 04:29:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:29:34 INFO - "slavebuilddir": "test", 04:29:34 INFO - "taskId": "Jnv63u1DQbaizsKlFxM15A", 04:29:34 INFO - "branch": "mozilla-central", 04:29:34 INFO - "script_repo_revision": "production", 04:29:34 INFO - "revision": "71733bc984a1355ad99a0df00c9d6f73c369fbe9", 04:29:34 INFO - "slavename": "talos-linux64-ix-024", 04:29:34 INFO - "repo_path": "mozilla-central" 04:29:34 INFO - } 04:29:34 INFO - Finding installer, test and symbols from parent task. 04:29:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jnv63u1DQbaizsKlFxM15A'}, attempt #1 04:29:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jnv63u1DQbaizsKlFxM15A'}, attempt #1 04:29:35 INFO - Task dependencies: IEtcVmmuTh6uo_TFnq8Mdw 04:29:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw'}, attempt #1 04:29:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.tar.bz2 04:29:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/test_packages.json 04:29:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.crashreporter-symbols.zip 04:29:36 INFO - Running post-action listener: _resource_record_post_action 04:29:36 INFO - [mozharness: 2017-06-22 11:29:36.126023Z] Finished read-buildbot-config step (success) 04:29:36 INFO - [mozharness: 2017-06-22 11:29:36.126246Z] Running download-and-extract step. 04:29:36 INFO - Running pre-action listener: _resource_record_pre_action 04:29:36 INFO - Running main action method: download_and_extract 04:29:36 INFO - mkdir: /builds/slave/test/build/tests 04:29:36 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')]} 04:29:36 INFO - trying https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.test_packages.json 04:29:36 INFO - Downloading https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:29:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:29:37 INFO - Downloaded 989 bytes. 04:29:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:29:37 INFO - Using the following test package requirements: 04:29:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:29:37 INFO - u'common': [u'target.common.tests.zip'], 04:29:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:29:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:29:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:29:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:29:37 INFO - u'mozbase': [u'target.common.tests.zip'], 04:29:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:29:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:29:37 INFO - u'web-platform': [u'target.common.tests.zip', 04:29:37 INFO - u'target.web-platform.tests.tar.gz'], 04:29:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:29:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:29:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.common.tests.zip 04:29:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:29:37 INFO - Fetch https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.common.tests.zip into memory 04:29:39 INFO - Content-Length response header: 67968029 04:29:39 INFO - Bytes received: 67968029 04:29:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:29:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.common.tests.zip 04:29:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:29:50 INFO - Fetch https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.common.tests.zip into memory 04:29:52 INFO - Content-Length response header: 67968029 04:29:52 INFO - Bytes received: 67968029 04:30:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.talos.tests.zip 04:30:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:30:04 INFO - Fetch https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.talos.tests.zip into memory 04:30:10 INFO - Content-Length response header: 14441318 04:30:10 INFO - Bytes received: 14441318 04:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:10 INFO - trying https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.tar.bz2 04:30:10 INFO - Downloading https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:30:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:30:13 INFO - Downloaded 61511457 bytes. 04:30:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.tar.bz2 04:30:13 INFO - mkdir: /builds/slave/test/properties 04:30:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:13 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:13 INFO - Contents: 04:30:13 INFO - build_url:https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.tar.bz2 04:30:13 INFO - Running post-action listener: _resource_record_post_action 04:30:13 INFO - Running post-action listener: set_extra_try_arguments 04:30:13 INFO - [mozharness: 2017-06-22 11:30:13.254572Z] Finished download-and-extract step (success) 04:30:13 INFO - [mozharness: 2017-06-22 11:30:13.254724Z] Running populate-webroot step. 04:30:13 INFO - Running pre-action listener: _resource_record_pre_action 04:30:13 INFO - Running main action method: populate_webroot 04:30:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:13 INFO - '--tppagecycles', 04:30:13 INFO - '7'], 04:30:13 INFO - 'tests': ['tsvgm']}}, 04:30:13 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:30:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:30:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:30:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:30:13 INFO - 'talos_options': ['--disable-e10s'], 04:30:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:30:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:30:13 INFO - 'talos_options': ['--disable-e10s'], 04:30:13 INFO - 'tests': ['damp', 'tps']}, 04:30:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:30:13 INFO - 'tests': ['damp', 'tps']}, 04:30:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:30:13 INFO - 'tests': ['dromaeo_dom']}, 04:30:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:30:13 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:30:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:30:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:30:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:30:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:30:13 INFO - 'tests': ['a11yr', 04:30:13 INFO - 'ts_paint', 04:30:13 INFO - 'tpaint', 04:30:13 INFO - 'sessionrestore', 04:30:13 INFO - 'sessionrestore_no_auto_restore', 04:30:13 INFO - 'tabpaint']}, 04:30:13 INFO - 'other-e10s': {'tests': ['a11yr', 04:30:13 INFO - 'ts_paint', 04:30:13 INFO - 'tpaint', 04:30:13 INFO - 'sessionrestore', 04:30:13 INFO - 'sessionrestore_no_auto_restore', 04:30:13 INFO - 'tabpaint']}, 04:30:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:30:13 INFO - 'ts_paint', 04:30:13 INFO - 'tpaint', 04:30:13 INFO - 'sessionrestore', 04:30:13 INFO - 'sessionrestore_no_auto_restore', 04:30:13 INFO - 'tabpaint']}, 04:30:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:30:13 INFO - 'ts_paint', 04:30:13 INFO - 'tpaint', 04:30:13 INFO - 'sessionrestore', 04:30:13 INFO - 'sessionrestore_no_auto_restore', 04:30:13 INFO - 'tabpaint']}, 04:30:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:30:13 INFO - 'tests': ['a11yr', 04:30:13 INFO - 'ts_paint', 04:30:13 INFO - 'tpaint', 04:30:13 INFO - 'sessionrestore', 04:30:13 INFO - 'sessionrestore_no_auto_restore', 04:30:13 INFO - 'tabpaint']}, 04:30:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:30:13 INFO - 'tests': ['a11yr', 04:30:13 INFO - 'ts_paint', 04:30:13 INFO - 'tpaint', 04:30:13 INFO - 'sessionrestore', 04:30:13 INFO - 'sessionrestore_no_auto_restore', 04:30:13 INFO - 'tabpaint']}, 04:30:13 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:30:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:30:13 INFO - 'bloom_basic_ref']}, 04:30:13 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:30:13 INFO - 'talos_options': ['--mitmproxy', 04:30:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:30:13 INFO - '--firstNonBlankPaint'], 04:30:13 INFO - 'tests': ['quantum_pageload_google', 04:30:13 INFO - 'quantum_pageload_youtube', 04:30:13 INFO - 'quantum_pageload_amazon', 04:30:13 INFO - 'quantum_pageload_facebook']}, 04:30:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:30:13 INFO - 'tests': ['tsvgx', 04:30:13 INFO - 'tsvgr_opacity', 04:30:13 INFO - 'tart', 04:30:13 INFO - 'tscrollx', 04:30:13 INFO - 'cart', 04:30:13 INFO - 'tsvg_static']}, 04:30:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:30:13 INFO - 'tsvgr_opacity', 04:30:13 INFO - 'tart', 04:30:13 INFO - 'tscrollx', 04:30:13 INFO - 'cart', 04:30:13 INFO - 'tsvg_static']}, 04:30:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:30:13 INFO - 'talos_options': ['--disable-e10s'], 04:30:13 INFO - 'tests': ['tp5o']}, 04:30:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:30:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:30:13 INFO - 'talos_options': ['--disable-e10s', 04:30:13 INFO - '--xperf_path', 04:30:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:13 INFO - 'tests': ['tp5n']}, 04:30:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:30:13 INFO - 'talos_options': ['--xperf_path', 04:30:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:13 INFO - 'tests': ['tp5n']}}, 04:30:13 INFO - 'talos.zip': {'path': '', 04:30:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:13 INFO - Running post-action listener: _resource_record_post_action 04:30:13 INFO - [mozharness: 2017-06-22 11:30:13.274123Z] Finished populate-webroot step (success) 04:30:13 INFO - [mozharness: 2017-06-22 11:30:13.274214Z] Running create-virtualenv step. 04:30:13 INFO - Running pre-action listener: _resource_record_pre_action 04:30:13 INFO - Running main action method: create_virtualenv 04:30:13 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:13 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 04:30:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:30:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:13 INFO - Using real prefix '/usr' 04:30:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:15 INFO - Installing pip.................done. 04:30:15 INFO - Return code: 0 04:30:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:30:16 INFO - Reading from file tmpfile_stdout 04:30:16 INFO - Output received: 04:30:16 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) 04:30:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30: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')]} 04:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:16 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 0x20a83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2282a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, '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': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', '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 04:30:16 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 04:30:16 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 04:30:16 INFO - Using env: {'DISPLAY': ':0', 04:30:16 INFO - 'HOME': '/home/cltbld', 04:30:16 INFO - 'LANG': 'en_US.UTF-8', 04:30:16 INFO - 'LANGUAGE': 'en_US:en', 04:30:16 INFO - 'LOGNAME': 'cltbld', 04:30:16 INFO - 'MAIL': '/var/mail/cltbld', 04:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:16 INFO - 'MOZ_NO_REMOTE': '1', 04:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:16 INFO - 'NO_EM_RESTART': '1', 04:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:16 INFO - 'PWD': '/builds/slave/test', 04:30:16 INFO - 'SHELL': '/bin/bash', 04:30:16 INFO - 'SHLVL': '1', 04:30:16 INFO - 'TERM': 'linux', 04:30:16 INFO - 'TMOUT': '86400', 04:30:16 INFO - 'USER': 'cltbld', 04:30:16 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:16 INFO - '_': '/tools/buildbot/bin/python'} 04:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:16 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 04:30:16 INFO - Cleaning up... 04:30:16 INFO - Return code: 0 04:30:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30: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')]} 04:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:16 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 0x20a83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2282a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, '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': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', '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 04:30:16 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 04:30:16 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 04:30:16 INFO - Using env: {'DISPLAY': ':0', 04:30:16 INFO - 'HOME': '/home/cltbld', 04:30:16 INFO - 'LANG': 'en_US.UTF-8', 04:30:16 INFO - 'LANGUAGE': 'en_US:en', 04:30:16 INFO - 'LOGNAME': 'cltbld', 04:30:16 INFO - 'MAIL': '/var/mail/cltbld', 04:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:16 INFO - 'MOZ_NO_REMOTE': '1', 04:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:16 INFO - 'NO_EM_RESTART': '1', 04:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:16 INFO - 'PWD': '/builds/slave/test', 04:30:16 INFO - 'SHELL': '/bin/bash', 04:30:16 INFO - 'SHLVL': '1', 04:30:16 INFO - 'TERM': 'linux', 04:30:16 INFO - 'TMOUT': '86400', 04:30:16 INFO - 'USER': 'cltbld', 04:30:16 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:16 INFO - '_': '/tools/buildbot/bin/python'} 04:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:16 INFO - Downloading/unpacking psutil>=3.1.1 04:30:16 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 04:30:16 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 04:30:16 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 04:30:16 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 04:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:19 INFO - Installing collected packages: psutil 04:30:19 INFO - Running setup.py install for psutil 04:30:19 INFO - building 'psutil._psutil_linux' extension 04:30:19 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 04:30:19 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 04:30:19 INFO - building 'psutil._psutil_posix' extension 04:30:19 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 04:30:19 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 04:30:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:19 INFO - Successfully installed psutil 04:30:19 INFO - Cleaning up... 04:30:19 INFO - Return code: 0 04:30:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:30:19 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')]} 04:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:19 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')]} 04:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:19 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 0x20a83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2282a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, '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': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', '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 04:30:19 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 04:30:19 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 04:30:19 INFO - Using env: {'DISPLAY': ':0', 04:30:19 INFO - 'HOME': '/home/cltbld', 04:30:19 INFO - 'LANG': 'en_US.UTF-8', 04:30:19 INFO - 'LANGUAGE': 'en_US:en', 04:30:19 INFO - 'LOGNAME': 'cltbld', 04:30:19 INFO - 'MAIL': '/var/mail/cltbld', 04:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:19 INFO - 'MOZ_NO_REMOTE': '1', 04:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:19 INFO - 'NO_EM_RESTART': '1', 04:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:19 INFO - 'PWD': '/builds/slave/test', 04:30:19 INFO - 'SHELL': '/bin/bash', 04:30:19 INFO - 'SHLVL': '1', 04:30:19 INFO - 'TERM': 'linux', 04:30:19 INFO - 'TMOUT': '86400', 04:30:19 INFO - 'USER': 'cltbld', 04:30:19 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:19 INFO - '_': '/tools/buildbot/bin/python'} 04:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:30:19 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 04:30:19 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 04:30:19 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 04:30:19 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 04:30:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:30:21 INFO - Installing collected packages: mozsystemmonitor 04:30:21 INFO - Running setup.py install for mozsystemmonitor 04:30:21 INFO - Successfully installed mozsystemmonitor 04:30:21 INFO - Cleaning up... 04:30:21 INFO - Return code: 0 04:30:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:30:21 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')]} 04:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:21 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')]} 04:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:21 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 0x20a83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2282a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, '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': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', '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 04:30:21 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 04:30:21 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 04:30:21 INFO - Using env: {'DISPLAY': ':0', 04:30:21 INFO - 'HOME': '/home/cltbld', 04:30:21 INFO - 'LANG': 'en_US.UTF-8', 04:30:21 INFO - 'LANGUAGE': 'en_US:en', 04:30:21 INFO - 'LOGNAME': 'cltbld', 04:30:21 INFO - 'MAIL': '/var/mail/cltbld', 04:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:21 INFO - 'MOZ_NO_REMOTE': '1', 04:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:21 INFO - 'NO_EM_RESTART': '1', 04:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:21 INFO - 'PWD': '/builds/slave/test', 04:30:21 INFO - 'SHELL': '/bin/bash', 04:30:21 INFO - 'SHLVL': '1', 04:30:21 INFO - 'TERM': 'linux', 04:30:21 INFO - 'TMOUT': '86400', 04:30:21 INFO - 'USER': 'cltbld', 04:30:21 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:21 INFO - '_': '/tools/buildbot/bin/python'} 04:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:21 INFO - Downloading/unpacking jsonschema==2.5.1 04:30:21 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 04:30:21 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 04:30:21 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 04:30:21 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 04:30:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:30:22 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 04:30:22 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 04:30:22 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 04:30:22 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 04:30:23 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:23 INFO - warning: no files found matching '*.txt' 04:30:23 INFO - no previously-included directories found matching 'build' 04:30:23 INFO - no previously-included directories found matching 'dist' 04:30:23 INFO - no previously-included directories found matching '.git*' 04:30:23 INFO - Installing collected packages: jsonschema, functools32 04:30:23 INFO - Running setup.py install for functools32 04:30:23 INFO - warning: no files found matching '*.txt' 04:30:23 INFO - no previously-included directories found matching 'build' 04:30:23 INFO - no previously-included directories found matching 'dist' 04:30:23 INFO - no previously-included directories found matching '.git*' 04:30:23 INFO - Successfully installed jsonschema functools32 04:30:23 INFO - Cleaning up... 04:30:23 INFO - Return code: 0 04:30:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:30:23 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')]} 04:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:23 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')]} 04:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:23 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 0x20a83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2282a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, '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': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', '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 04:30:23 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 04:30:23 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 04:30:23 INFO - Using env: {'DISPLAY': ':0', 04:30:23 INFO - 'HOME': '/home/cltbld', 04:30:23 INFO - 'LANG': 'en_US.UTF-8', 04:30:23 INFO - 'LANGUAGE': 'en_US:en', 04:30:23 INFO - 'LOGNAME': 'cltbld', 04:30:23 INFO - 'MAIL': '/var/mail/cltbld', 04:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:23 INFO - 'MOZ_NO_REMOTE': '1', 04:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:23 INFO - 'NO_EM_RESTART': '1', 04:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:23 INFO - 'PWD': '/builds/slave/test', 04:30:23 INFO - 'SHELL': '/bin/bash', 04:30:23 INFO - 'SHLVL': '1', 04:30:23 INFO - 'TERM': 'linux', 04:30:23 INFO - 'TMOUT': '86400', 04:30:23 INFO - 'USER': 'cltbld', 04:30:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:23 INFO - '_': '/tools/buildbot/bin/python'} 04:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:30:23 INFO - Cleaning up... 04:30:23 INFO - Return code: 0 04:30:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30:23 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')]} 04:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:23 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')]} 04:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:24 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 0x20a83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2282a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, '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': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', '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 04:30:24 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 04:30:24 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 04:30:24 INFO - Using env: {'DISPLAY': ':0', 04:30:24 INFO - 'HOME': '/home/cltbld', 04:30:24 INFO - 'LANG': 'en_US.UTF-8', 04:30:24 INFO - 'LANGUAGE': 'en_US:en', 04:30:24 INFO - 'LOGNAME': 'cltbld', 04:30:24 INFO - 'MAIL': '/var/mail/cltbld', 04:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:24 INFO - 'MOZ_NO_REMOTE': '1', 04:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:24 INFO - 'NO_EM_RESTART': '1', 04:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:24 INFO - 'PWD': '/builds/slave/test', 04:30:24 INFO - 'SHELL': '/bin/bash', 04:30:24 INFO - 'SHLVL': '1', 04:30:24 INFO - 'TERM': 'linux', 04:30:24 INFO - 'TMOUT': '86400', 04:30:24 INFO - 'USER': 'cltbld', 04:30:24 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:24 INFO - '_': '/tools/buildbot/bin/python'} 04:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:24 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 04:30:24 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 04:30:24 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 04:30:24 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 04:30:25 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:25 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 04:30:25 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 04:30:25 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 04:30:25 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 04:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:25 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 04:30:25 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 04:30:25 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 04:30:25 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 04:30:25 INFO - Downloading docopt-0.6.1.tar.gz 04:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:25 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:25 INFO - Running setup.py install for blobuploader 04:30:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:26 INFO - Running setup.py install for requests 04:30:26 INFO - Running setup.py install for docopt 04:30:26 INFO - Successfully installed blobuploader requests docopt 04:30:26 INFO - Cleaning up... 04:30:26 INFO - Return code: 0 04:30:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:26 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')]} 04:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:26 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')]} 04:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:26 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 0x20a83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2282a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, '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': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', '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 04:30:26 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 04:30:26 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 04:30:26 INFO - Using env: {'DISPLAY': ':0', 04:30:26 INFO - 'HOME': '/home/cltbld', 04:30:26 INFO - 'LANG': 'en_US.UTF-8', 04:30:26 INFO - 'LANGUAGE': 'en_US:en', 04:30:26 INFO - 'LOGNAME': 'cltbld', 04:30:26 INFO - 'MAIL': '/var/mail/cltbld', 04:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:26 INFO - 'MOZ_NO_REMOTE': '1', 04:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:26 INFO - 'NO_EM_RESTART': '1', 04:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:26 INFO - 'PWD': '/builds/slave/test', 04:30:26 INFO - 'SHELL': '/bin/bash', 04:30:26 INFO - 'SHLVL': '1', 04:30:26 INFO - 'TERM': 'linux', 04:30:26 INFO - 'TMOUT': '86400', 04:30:26 INFO - 'USER': 'cltbld', 04:30:26 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:26 INFO - '_': '/tools/buildbot/bin/python'} 04:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:26 INFO - Running setup.py (path:/tmp/pip-VchH8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:26 INFO - Running setup.py (path:/tmp/pip-rogwko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:26 INFO - Running setup.py (path:/tmp/pip-79QfVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:27 INFO - Running setup.py (path:/tmp/pip-fhDPd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:27 INFO - Running setup.py (path:/tmp/pip-Ihhu4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:27 INFO - Running setup.py (path:/tmp/pip-1K_cPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:27 INFO - Running setup.py (path:/tmp/pip-6TuEJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:27 INFO - Running setup.py (path:/tmp/pip-S9vKr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:27 INFO - Running setup.py (path:/tmp/pip-5XQZra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:27 INFO - Running setup.py (path:/tmp/pip-7QMsXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:27 INFO - Running setup.py (path:/tmp/pip-fN1vXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:27 INFO - Running setup.py (path:/tmp/pip-tK7ni2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:27 INFO - Running setup.py (path:/tmp/pip-eEbRtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:27 INFO - Running setup.py (path:/tmp/pip-ynze1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:27 INFO - Running setup.py (path:/tmp/pip-NnS56M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:27 INFO - Running setup.py (path:/tmp/pip-cfFV5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:27 INFO - Running setup.py (path:/tmp/pip-FgQ_Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:27 INFO - Running setup.py install for manifestparser 04:30:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:28 INFO - Running setup.py install for mozcrash 04:30:28 INFO - Running setup.py install for mozdebug 04:30:28 INFO - Running setup.py install for mozdevice 04:30:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:28 INFO - Running setup.py install for mozfile 04:30:28 INFO - Running setup.py install for mozhttpd 04:30:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:28 INFO - Running setup.py install for mozinfo 04:30:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:28 INFO - Running setup.py install for mozInstall 04:30:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:28 INFO - Running setup.py install for mozleak 04:30:28 INFO - Running setup.py install for mozlog 04:30:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:29 INFO - Running setup.py install for moznetwork 04:30:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:29 INFO - Running setup.py install for mozprocess 04:30:29 INFO - Running setup.py install for mozprofile 04:30:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:29 INFO - Running setup.py install for mozrunner 04:30:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:29 INFO - Running setup.py install for mozscreenshot 04:30:29 INFO - Running setup.py install for moztest 04:30:29 INFO - Running setup.py install for mozversion 04:30:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:29 INFO - Cleaning up... 04:30:29 INFO - Return code: 0 04:30:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:29 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')]} 04:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:29 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')]} 04:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:29 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 0x20a83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2282a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, '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': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', '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 04:30:29 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 04:30:29 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 04:30:29 INFO - Using env: {'DISPLAY': ':0', 04:30:29 INFO - 'HOME': '/home/cltbld', 04:30:29 INFO - 'LANG': 'en_US.UTF-8', 04:30:29 INFO - 'LANGUAGE': 'en_US:en', 04:30:29 INFO - 'LOGNAME': 'cltbld', 04:30:29 INFO - 'MAIL': '/var/mail/cltbld', 04:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:29 INFO - 'MOZ_NO_REMOTE': '1', 04:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:29 INFO - 'NO_EM_RESTART': '1', 04:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:29 INFO - 'PWD': '/builds/slave/test', 04:30:29 INFO - 'SHELL': '/bin/bash', 04:30:29 INFO - 'SHLVL': '1', 04:30:29 INFO - 'TERM': 'linux', 04:30:29 INFO - 'TMOUT': '86400', 04:30:29 INFO - 'USER': 'cltbld', 04:30:29 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:29 INFO - '_': '/tools/buildbot/bin/python'} 04:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:30 INFO - Running setup.py (path:/tmp/pip-ApzHGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:30 INFO - Running setup.py (path:/tmp/pip-fjTlMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:30 INFO - Running setup.py (path:/tmp/pip-K68ATd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:30 INFO - Running setup.py (path:/tmp/pip-Z3tIq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:30 INFO - Running setup.py (path:/tmp/pip-R2eEzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:30 INFO - Running setup.py (path:/tmp/pip-X4HgyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:30 INFO - Running setup.py (path:/tmp/pip-1YLmMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:30 INFO - Running setup.py (path:/tmp/pip-TwCpSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:30 INFO - Running setup.py (path:/tmp/pip-sxCbvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:30 INFO - Running setup.py (path:/tmp/pip-UGMmVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:30 INFO - Running setup.py (path:/tmp/pip-ZgX4zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:30 INFO - Running setup.py (path:/tmp/pip-AZpvWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:30 INFO - Running setup.py (path:/tmp/pip-7u9IOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:30 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)) 04:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:30 INFO - Running setup.py (path:/tmp/pip-ARaDha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:31 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)) 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:31 INFO - Running setup.py (path:/tmp/pip-EX0rCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:31 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)) 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:31 INFO - Running setup.py (path:/tmp/pip-jJwPqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:31 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)) 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:31 INFO - Running setup.py (path:/tmp/pip-Jf5QAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:31 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)) 04:30:31 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)) 04:30:31 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)) 04:30:31 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)) 04:30:31 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)) 04:30:31 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)) 04:30:31 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:30:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:31 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 04:30:31 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 04:30:31 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 04:30:31 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 04:30:32 INFO - Downloading blessings-1.6.tar.gz 04:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:30:32 INFO - Installing collected packages: blessings 04:30:32 INFO - Running setup.py install for blessings 04:30:32 INFO - Successfully installed blessings 04:30:32 INFO - Cleaning up... 04:30:32 INFO - Return code: 0 04:30:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:30:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:32 INFO - Reading from file tmpfile_stdout 04:30:32 INFO - Current package versions: 04:30:32 INFO - argparse == 1.2.1 04:30:32 INFO - blessings == 1.6 04:30:32 INFO - blobuploader == 1.2.4 04:30:32 INFO - docopt == 0.6.1 04:30:32 INFO - functools32 == 3.2.3-2 04:30:32 INFO - jsonschema == 2.5.1 04:30:32 INFO - manifestparser == 1.1 04:30:32 INFO - mozInstall == 1.13 04:30:32 INFO - mozcrash == 1.0 04:30:32 INFO - mozdebug == 0.1 04:30:32 INFO - mozdevice == 0.51 04:30:32 INFO - mozfile == 1.2 04:30:32 INFO - mozhttpd == 0.7 04:30:32 INFO - mozinfo == 0.10 04:30:32 INFO - mozleak == 0.1 04:30:32 INFO - mozlog == 3.4 04:30:32 INFO - moznetwork == 0.27 04:30:32 INFO - mozprocess == 0.25 04:30:32 INFO - mozprofile == 0.28 04:30:32 INFO - mozrunner == 6.13 04:30:32 INFO - mozscreenshot == 0.1 04:30:32 INFO - mozsystemmonitor == 0.3 04:30:32 INFO - moztest == 0.8 04:30:32 INFO - mozversion == 1.4 04:30:32 INFO - psutil == 3.1.1 04:30:32 INFO - requests == 1.2.3 04:30:32 INFO - wsgiref == 0.1.2 04:30:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:32 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')]} 04:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:32 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')]} 04:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:33 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 0x20a83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2282a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, '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': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', '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 04:30:33 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 04:30:33 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 04:30:33 INFO - Using env: {'DISPLAY': ':0', 04:30:33 INFO - 'HOME': '/home/cltbld', 04:30:33 INFO - 'LANG': 'en_US.UTF-8', 04:30:33 INFO - 'LANGUAGE': 'en_US:en', 04:30:33 INFO - 'LOGNAME': 'cltbld', 04:30:33 INFO - 'MAIL': '/var/mail/cltbld', 04:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:33 INFO - 'MOZ_NO_REMOTE': '1', 04:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:33 INFO - 'NO_EM_RESTART': '1', 04:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:33 INFO - 'PWD': '/builds/slave/test', 04:30:33 INFO - 'SHELL': '/bin/bash', 04:30:33 INFO - 'SHLVL': '1', 04:30:33 INFO - 'TERM': 'linux', 04:30:33 INFO - 'TMOUT': '86400', 04:30:33 INFO - 'USER': 'cltbld', 04:30:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:33 INFO - '_': '/tools/buildbot/bin/python'} 04:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:33 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)) 04:30:33 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)) 04:30:33 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)) 04:30:33 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)) 04:30:33 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)) 04:30:33 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)) 04:30:33 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)) 04:30:33 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)) 04:30:33 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)) 04:30:33 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:30:33 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 04:30:33 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 04:30:33 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 04:30:33 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 04:30:35 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:30:35 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)) 04:30:35 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)) 04:30:35 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)) 04:30:35 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)) 04:30:35 INFO - Installing collected packages: marionette-driver 04:30:35 INFO - Running setup.py install for marionette-driver 04:30:35 INFO - Successfully installed marionette-driver 04:30:35 INFO - Cleaning up... 04:30:35 INFO - Return code: 0 04:30:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:36 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 0x20a83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2282a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, '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': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', '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 04:30:36 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 04:30:36 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 04:30:36 INFO - Using env: {'DISPLAY': ':0', 04:30:36 INFO - 'HOME': '/home/cltbld', 04:30:36 INFO - 'LANG': 'en_US.UTF-8', 04:30:36 INFO - 'LANGUAGE': 'en_US:en', 04:30:36 INFO - 'LOGNAME': 'cltbld', 04:30:36 INFO - 'MAIL': '/var/mail/cltbld', 04:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:36 INFO - 'MOZ_NO_REMOTE': '1', 04:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:36 INFO - 'NO_EM_RESTART': '1', 04:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:36 INFO - 'PWD': '/builds/slave/test', 04:30:36 INFO - 'SHELL': '/bin/bash', 04:30:36 INFO - 'SHLVL': '1', 04:30:36 INFO - 'TERM': 'linux', 04:30:36 INFO - 'TMOUT': '86400', 04:30:36 INFO - 'USER': 'cltbld', 04:30:36 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:36 INFO - '_': '/tools/buildbot/bin/python'} 04:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:30:36 INFO - Cleaning up... 04:30:36 INFO - Return code: 0 04:30:36 INFO - Running post-action listener: _resource_record_post_action 04:30:36 INFO - Running post-action listener: _start_resource_monitoring 04:30:36 INFO - Starting resource monitoring. 04:30:36 INFO - [mozharness: 2017-06-22 11:30:36.272210Z] Finished create-virtualenv step (success) 04:30:36 INFO - [mozharness: 2017-06-22 11:30:36.272720Z] Running install step. 04:30:36 INFO - Running pre-action listener: _resource_record_pre_action 04:30:36 INFO - Running main action method: install 04:30:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:36 INFO - Reading from file tmpfile_stdout 04:30:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:30:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:30:36 INFO - Reading from file tmpfile_stdout 04:30:36 INFO - Output received: 04:30:36 INFO - Usage: mozinstall [options] installer 04:30:36 INFO - Options: 04:30:36 INFO - -h, --help show this help message and exit 04:30:36 INFO - -d DEST, --destination=DEST 04:30:36 INFO - Directory to install application into. [default: 04:30:36 INFO - "/builds/slave/test"] 04:30:36 INFO - --app=APP Application being installed. [default: firefox] 04:30:36 INFO - mkdir: /builds/slave/test/build/application 04:30:36 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'] 04:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:30:54 INFO - Reading from file tmpfile_stdout 04:30:54 INFO - Output received: 04:30:54 INFO - /builds/slave/test/build/application/firefox/firefox 04:30:54 INFO - Running post-action listener: _resource_record_post_action 04:30:54 INFO - [mozharness: 2017-06-22 11:30:54.454760Z] Finished install step (success) 04:30:54 INFO - [mozharness: 2017-06-22 11:30:54.455036Z] Running setup-mitmproxy step. 04:30:54 INFO - Running pre-action listener: _resource_record_pre_action 04:30:54 INFO - Running main action method: setup_mitmproxy 04:30:54 INFO - Skipping: mitmproxy is not required 04:30:54 INFO - Running post-action listener: _resource_record_post_action 04:30:54 INFO - [mozharness: 2017-06-22 11:30:54.456190Z] Finished setup-mitmproxy step (success) 04:30:54 INFO - [mozharness: 2017-06-22 11:30:54.456411Z] Running run-tests step. 04:30:54 INFO - Running pre-action listener: _resource_record_pre_action 04:30:54 INFO - Running main action method: run_tests 04:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:30:54 INFO - Python 2.7.3 04:30:54 INFO - Return code: 0 04:30:54 INFO - grabbing minidump binary from tooltool 04:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:54 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 0x2424140>, '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 0x2424a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:30:54 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 04:30:54 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 04:30:54 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 04:30:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:30:54 INFO - Return code: 0 04:30:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:30:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:30:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:30:54 INFO - ENV: RUST_BACKTRACE is now 1 04:30:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:30:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 04:30:54 INFO - Using env: {'DISPLAY': ':0', 04:30:54 INFO - 'HOME': '/home/cltbld', 04:30:54 INFO - 'LANG': 'en_US.UTF-8', 04:30:54 INFO - 'LANGUAGE': 'en_US:en', 04:30:54 INFO - 'LOGNAME': 'cltbld', 04:30:54 INFO - 'MAIL': '/var/mail/cltbld', 04:30:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:30:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:54 INFO - 'MOZ_NO_REMOTE': '1', 04:30:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:54 INFO - 'NO_EM_RESTART': '1', 04:30:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:54 INFO - 'PWD': '/builds/slave/test', 04:30:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:30:54 INFO - 'RUST_BACKTRACE': '1', 04:30:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:30:54 INFO - 'SHELL': '/bin/bash', 04:30:54 INFO - 'SHLVL': '1', 04:30:54 INFO - 'TERM': 'linux', 04:30:54 INFO - 'TMOUT': '86400', 04:30:54 INFO - 'USER': 'cltbld', 04:30:54 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047', 04:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:54 INFO - '_': '/tools/buildbot/bin/python'} 04:30:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:30:54 INFO - mozversion application_buildid: 20170622104543 04:30:54 INFO - mozversion application_changeset: 71733bc984a1355ad99a0df00c9d6f73c369fbe9 04:30:54 INFO - mozversion application_display_name: Nightly 04:30:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:30:54 INFO - mozversion application_name: Firefox 04:30:54 INFO - mozversion application_remotingname: firefox 04:30:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:30:54 INFO - mozversion application_vendor: Mozilla 04:30:54 INFO - mozversion application_version: 56.0a1 04:30:54 INFO - mozversion platform_buildid: 20170622104543 04:30:54 INFO - mozversion platform_changeset: 71733bc984a1355ad99a0df00c9d6f73c369fbe9 04:30:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:30:54 INFO - mozversion platform_version: 56.0a1 04:30:54 INFO - using testdate: 1498131054 04:30:54 INFO - actual date: 1498131054 04:30:54 INFO - starting webserver on 'localhost:36393' 04:30:54 INFO - SUITE-START | Running 2 tests 04:30:54 INFO - TEST-START | dromaeo_css 04:30:54 INFO - operating with platform_type : linux_ 04:30:54 INFO - Initialising browser for dromaeo_css test... 04:30:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36393/getInfo.html -profile /tmp/tmpp64cqh/profile 04:30:54 INFO - TEST-INFO | started process 26907 (/builds/slave/test/build/application/firefox/firefox http://localhost:36393/getInfo.html) 04:31:01 INFO - TEST-INFO | 26907: exit 0 04:31:01 INFO - Browser initialized. 04:31:01 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:01 INFO - TEST-INFO | started process 27136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp64cqh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:12 INFO - PID 27136 | RSS: Main: 176115712 04:31:12 INFO - PID 27136 | 04:34:16 INFO - PID 27136 | Cycle 1(1): loaded http://localhost:36393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36393/tests/dromaeo/cssquery-ext.html) 04:34:18 INFO - PID 27136 | RSS: Main: 181223424 04:34:18 INFO - PID 27136 | 04:37:19 INFO - PID 27136 | Cycle 1(1): loaded http://localhost:36393/tests/dromaeo/cssquery-ext.html (next: http://localhost:36393/tests/dromaeo/cssquery-jquery.html) 04:37:20 INFO - PID 27136 | RSS: Main: 178327552 04:37:20 INFO - PID 27136 | 04:40:21 INFO - PID 27136 | Cycle 1(1): loaded http://localhost:36393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36393/tests/dromaeo/cssquery-mootools.html) 04:40:22 INFO - PID 27136 | RSS: Main: 181702656 04:40:22 INFO - PID 27136 | 04:43:24 INFO - PID 27136 | Cycle 1(1): loaded http://localhost:36393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36393/tests/dromaeo/cssquery-prototype.html) 04:43:24 INFO - PID 27136 | RSS: Main: 180043776 04:43:24 INFO - PID 27136 | 04:46:27 INFO - PID 27136 | Cycle 1(1): loaded http://localhost:36393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36393/tests/dromaeo/cssquery-yui.html) 04:46:28 INFO - PID 27136 | RSS: Main: 182177792 04:46:28 INFO - PID 27136 | 04:49:29 INFO - PID 27136 | Cycle 1(1): loaded http://localhost:36393/tests/dromaeo/cssquery-yui.html (next: http://localhost:36393/tests/dromaeo/cssquery-dojo.html) 04:49:30 INFO - PID 27136 | RSS: Main: 179011584 04:49:30 INFO - PID 27136 | 04:49:30 INFO - PID 27136 | __start_tp_report 04:49:30 INFO - PID 27136 | _x_x_mozilla_page_load 04:49:30 INFO - PID 27136 | _x_x_mozilla_page_load_details 04:49:30 INFO - PID 27136 | |i|pagename|runs| 04:49:30 INFO - PID 27136 | |0;dojo.html;3030.83330416827;3041.4981528047865;3069.5242237453203;3091.134482344944;3094.5822313987605;5790.652560846353;5925.940740592593;6038.064100064486;6040.426159514845;6057.606255593383;5818.389069147742;5847.26909136358;5864.824055278338;5869.677167755772;5899.52803775698;5498.532624726903;5502.367227768817;5529.142982837667;5534.308211473566;5571.693556854391;5130.743462826862;5443.482869127427;5534.418886016971;5646.57650676201;5663.235463212455;5537.390887002426;5595.720213989284;5646.2377579026925;5649.4633009864;5701.77192912283;5330.520253177194;5396.028714831329;5404.243405923174;5550.86122846928;5588.776448942038;5417.187421886709;5420.186971954199;5470.7264636768;5491.0116179087745;5528.502434780889;5959.463648271676;5962.5528085393335;5982.581219314649;6018.8194354169445;6022.8494287642725;6455.644939528371;6477.77327793525;6478.902816457757;6479.74081036758;6482;6325.051242313643;6529.640869752162;6543.214814222324;6553.6395498247575;6555.868882622369;5960.85097872548;5963;5967.5524335675;5981.461668449861;6013.759449621966;6512.283648798629;6605.141331626858;6645.767398141042;6659.800205993828;6708.094407254958;6337.017762246859;6349.52378571609;6361.045843123476;6385.106085148083;6407.871842563122;6402.231732192074;6436.967815160894;6458.095866578683;6479.8056058318325;6486.091947127406;6226.657533835682;6275.278342990523;6309.779157729457;6331.746730130743;6478.870422591522;6335.588186767845;6341.746330146835;6361.681915904186;6434.871302573923;6441.806745797539;5288.074586947346;5296.655717378358;5307.6019298552765;5315.920261196085;5321.707306098202;4497.572730590588;4507.211238033331;4510.255807791743;4514.097180563835;4537.977310113428;5600.60795744294;5601.6358936668985;5603.271574695345;5603.887922241533;5604.327480702342;6295.464885484785;6379.075034120026;6389.584676995981;6503.25212600557;6568.277489476154;5465.672059676353;5570.888582228414;5571.220029195916;5609.382967873531;5613.747381367848;5670.603057785998;5746.339170995306;5765.164051212634;5791.7683292667825;5792.710364481759;6292.9579988354335;6316.557840951089;6318.368163183645;6322.36776322364;6331.398517140864;6520.250171230369;6521.934780652133;6527.5757075789925;6532.150820393318;6540.444062254762;5999.1601175836295;6046.7278972445465;6065.757369705162;6139.539534534839;6320.810375688737;6245.781397651061;6279.591826531444;6322.747090116344;6355.428011478989;6372.936270637234;6473.579217350857;6515.641639709862;6520.902186467301;6534.085228068169;6554.442872355903;6296.401841825203;6301.842453938505;6309.842253943688;6334.3665633436285;6346.460550853045;6314.336994615499;6320.62076275425;6331.145295385249;6335.778247761491;6354.110424540476;6045.455908968214;6080.574359794949;6131.774283661862;6136.969315153574;6149.354317796746;6300.2754683212015;6313.526485513697;6316.589421687576;6317.652529110759;6341.90487142684;6136.539759517965;6139.171211886338;6157.168782214523;6163.075538669235;6208.348123446973 04:49:30 INFO - PID 27136 | |1;ext.html;638.1576319258578;670.316277397055;689.5862482510493;693.2235895796708;695.5478938689854;39202.80398598006;40521.18957620846;40615.18769624606;40650.1869962601;40742.388864167064;36893.631063689354;37080.072998175056;37259.62740372596;37306.8134659327;37307.44038839419;6735.326467353275;6829.248782633907;6854.691538880737;6870.519063665521;6903.413209877166;6603.306652801459;6645.368689974469;6663.833404164886;6690.698918548677;6710.597364158141;6583.2429270633775;6618.768343107992;6651.966740166293;6687.598744075347;6705.295943925891;6667.233268174149;6676.365745254193;6684.732610695566;6700.329967003309;6710.228323742784;6037.943359912042;6039.1545183674325;6040.426159514839;6060.30306514752;6066.6663333516635;32365.19087022843;32514.512282315784;32537.837310813295;32552;32649.673503265138;3347.0460918638314;3351.2124650707065;3362.899113026613;3389.57630296213;3614.5662520497444;29997;30096;30127;30143.246418839484;30185.547216791765;3682.0794801299676;3789.8673546425744;3790.54513458384;3792.5448946126367;3836.846526138951;180680;180732;181703;183033.08483457498;183234.99999999866;41089.1782164355;41538.58461415347;46869.06261874812;47005;47669.284960725614;49170.50829491731;49457.25814112791;49847.50152498501;49885.50114498881;49891;15372.84627153714;15391.230438478031;15413.152276624669;15421.151836649093;15438.614034649;12617;12712.237265763899;12741.235525868478;12753.936230318788;12759.93620031894;14012.439502419993;14014.369353379123;14057.85942140586;14133.5053273137;14183.290835458185;5556.972215138899;5586.888262234814;5680.204771332017;5683.772649094072;5776.480116789509;997.3816233935007;1009.9949500252452;1012.372329155928;1043.6451606453843;1044.2220545693508;21796.45508862291;22368.664470032963;22656.980435880425;23122;23251.88374058119;1084.815581351172;1085.8859819718973;1120.165476719849;1128.6501184632791;1132.4111462039857;11543.36511491876;11812.468438920097;11987.52049918011;12081.335526545949;12442.253464792142;220751;220764;221227;221851;222974;51024.489755101975;51249.74375128175;51398.22902656463;51483.48516514862;51823;1408.1832537128441;1449.814854724644;1466.6040169154269;1474.1941122125525;1484.0131312677165;21231.03836061477;22063.33809985703;22176.65473838257;22496.32511024672;23050;36021;36080.63919360773;36091;36130.4580431299;36209.45685814662;182589;183137;184101;184214;185155;33657.15857103494;34651.826740866134;36653;36745.265094697425;37037.25925481529;42211.577884220766;43810.342844856714;44718.55281447274;44953.77523112363;45327;30439.847800760854;30797.692023079482;31635.84182079075;32093.518597221526;33572.66427335695;31380.686193137775;31730.52404213985;32051.519227211145;32746.1813454656;32765;34343.82828085944;35057;36472;36735.63264367429;36790.08024799402;29997.700022999492;31142;31677.20806979844;31758.841205793822;32004.839975799972;22345.664815028114;24957.376065598506;25095.24714258575;25215.74784252134;25238 04:49:30 INFO - PID 27136 | |2;jquery.html;543.9700816455098;558.8546977785775;560.249265983582;561.2283110722753;581.134110175838;21514.354569362924;22216.777832221673;22252.221172258975;22359.888200558995;22387.216447424365;23858.76141238587;25100.623490647657;25954;26012;26225.73774262257;6540.7056682449165;6622.2715501294815;6646.30213827546;6650.1354823872825;6674;6604.900926486107;6606.735730570771;6646.33536646334;6646.468282537386;6685.097511835888;6094.055421409666;6416.41357091918;6461.6446095464735;6472.51456140789;6562.409383155515;6432.871342573146;6501.642409667466;6508.609483430985;6535.771248006297;6535.803925882231;6039.758409663608;6055.909161362583;6056.788012419588;6070.119832624245;6097.20736304282;25852.353691157685;28219.294517637223;28540.286492837844;28610.713892861015;28641.71358286411;1944.543032387388;1965.4693232827058;1984.5832375201226;1991.621591897535;1992.9900350498156;17683.38108166208;18056.09719514019;18188;18205.27178912842;18264.90867545667;2310.838241323108;2320.1415476273887;2330.5804955108074;2332.3352844439423;2391.115287343694;113864.43067784607;116963;117720.41139794332;118422.40788796001;118811.40594296974;14183.78724319136;14799.926000370144;14985.250737463084;15201.6199595011;15439.768403473958;22786.65820012701;22833;23065;23077.7692223079;23096;9842.163416109712;9874.950625246827;9961.900380996241;10136.239782016379;10206.897931020743;8972.102789720975;9046.231070359094;9213.81572368549;9239.353245272901;9258.166764991183;9098.272138229058;9112.498812565373;9160.496172710566;9204.95397523008;9212.769680757901;2648.6821581410354;2666.360073582326;2692.1788854399597;2731.3171707073234;2871.956920646192;937.1144268666045;943.7876477792579;962.6486332488591;987.1757082835912;1013.1489548779061;19266.059608412535;19618.90190549038;20130.698039529125;20419.8979005104;20521.35829133666;989.2975987049132;1012.5342342522375;1013.6046941692746;1054.8681414823147;1055.7941201465794;10841.241113122163;10912.945435272773;10954.671359859218;11132.833007504894;11374.090072794157;499212;517545;521221;527631;537848;105629.47185264024;110850;113905.43047284876;114882.4255878732;115372;1241.6275117464725;1277.9297138657278;1286;1286.0483242400555;1287.1697754948193;19460.610787784448;20806.167753290305;21043.894780526;21567.686462707206;21572.352829415144;51526.22710659418;52841.471585285195;53007.4699253018;53067.20399194092;53117.20324195217;66733.33266667271;67252.32747672657;67747.66126169337;68072;68563;12344.4444999977;12549.435275412447;12832;12988.805167922299;13104.868951310365;18760.96814675206;18934.905325473286;18995.810041899404;19158.71261931044;19350.806491935462;14731.558053258419;15458.149801761012;15733.44932927342;15778.368865245262;15790;14003.299835008005;14255.928720356333;14380.784288235895;14744.926275368554;14751.262436877898;15133;15215.315310810818;15271.389144434099;15307.46423875159;15521.37914483408;12423.440945157308;12727.618171454871;12944.611661650166;12971;13018.088733788543;14912.850871491146;14995.325210365778;15127.848721513084;15197.31612077437;15197.316120774813 04:49:30 INFO - PID 27136 | |3;mootools.html;1364.2973868457743;1417.2205287092104;1433.3693175002998;1440.5462279381986;1447.0377199162554;12890.226586404822;13349.199048057124;13380.130291531044;13381.464741410344;13412.262325572101;12794.168379055378;13155.736885262313;13167.209967401963;13170.934145329284;13212.40544175512;2517.2699917024042;2541.2503311523146;2551.6045013023013;2559.795216382685;2572.4469239113587;2443.6701045358914;2509.636102765098;2512.811539134563;2521.3318470605213;2529.443522425073;2460.1635443949053;2488.9751102488926;2498.038255271724;2515.610080437535;2516.19481765835;2368.0764501844296;2406.927792166229;2412.8552286862846;2415.2029830156007;2420.346506443268;2357.3870793593787;2374.4538756086026;2374.750651181618;2375;2376.4652953085592;12382.75234495314;12581.496740130384;12604.306763128025;12671.429785659668;12686.429110690042;6435.066915297302;6663.300353462865;6686;6687.264400915896;6696.8995465068065;3988.3818008208773;4144.129732756125;4167.91664166715;4181.749095054276;4239.915201695949;1542.2057640315247;1567.9608009799733;1569.097768782943;1612.3147662243616;1626.7559866020192;18906;19529.218831246733;20366.28717994878;20503.17987280507;20540.17839286427;5274.287971123926;5864.882702345929;6052.6671033092725;6079.665618391031;6102.145699602059;14537.055091419235;14558.85441145596;14562.126272423688;14567.344469498687;14577.323607785029;6906.792796216121;6917.619530925847;6919.273476285019;6922.273161317989;6978.337057979484;6441.355864413521;6679.532432729759;6737.056812046318;6762.323767623297;6820.488463365267;4618.1918164321105;4712.670113092119;4752.52474752522;4776.14029474691;4904.509549045139;1298.740251949595;1303.4720938020116;1304.706441050756;1320.2474589483902;1328.1566205459603;900.7703035725848;901.7069452427987;907.9500627465553;940.8917974432891;951.5670369981642;7649;7750.922490775133;7824.139344672081;7870.960645196852;7997.240262175084;971.0871780526282;976.2531663277598;1015.4922538730634;1017.659084206799;1028.7325295423243;4939.073603811118;4989.775460104304;5113.795448182105;5222.321098257202;5224.634275600672;16344.591385215226;16839.494815155565;17242.913785431243;17336.913315433343;17364.739528907077;16335.428260010842;17275.654486910193;17369.913150434168;17415.91292043557;17426.215820287864;10096.596136154472;10129.898701012895;10132.138768204784;10159.136473399843;10196.694099176888;6771.492138089565;7231.674574644258;7544.509606875536;7640.770776876702;7778.377729781717;14213.57359279182;14285.500007499688;15023.09861408319;15060.096394216382;15153;14756.63108422298;14883.25583720788;14986.325615347117;15048.849511504744;15136.470223542123;10893.128549715846;10918.181136414642;11004.39475828837;11047.83428248593;11060.336379817236;11921.225120367148;12015.279083255033;12040.698982525508;12079.335636540074;12255.203411778206;9655.951720241354;10212.183025358103;10418.947905260426;10433.843492347773;10680.412577308323;9006.369554131148;9452.007539208284;9573.617055317709;9892.060254275832;9994.550245239127;8998.865017024618;9039.231665308522;9072.727818165466;9079.863802042843;9101.362904596615;6260.907076609459;6510.967445162744;6730.798076057726;6810.659467026728;6885.965570172117;6795.45636349081;7142.142942846892;7193.424526038009;7202.927970720226;7380.040594722652 04:49:30 INFO - PID 27136 | |4;prototype.html;478.56928764112274;489.66702642203296;501.62879469192796;511.3301574936831;515.5257163409663;6145.416185462385;6221.551590612711;6234.844128896774;6267.749290028405;6275.560710750249;5922.3485416604135;6049.727762250698;6083.8174854754425;6090.421409966058;6113.877722445548;4934.333864928233;4938.703677779345;4949.232868905326;4959.6528243023;4985.601151907838;4951.925721114186;4988.102141614508;4999.600271815164;5001.099802035632;5018.59479345782;4959.834438906854;4962.925556116661;4966.349732946282;4974.900501989958;4974.97512512437;4785.641076919228;4940.777665005047;4955.1597511928185;4991.5258050485145;4996.525330093636;4450.087732014961;4452.777361131931;4460.528025751494;4466.173757854807;4467.776611169428;5995.460408563206;6004.609700369462;6017.69911504423;6022.638641681469;6060.969695151496;5630.465105814982;5639.802606908738;5663.037283661787;5708.514776244025;5711.62874413166;6406.391392817722;6529.183852018497;6534.477241820643;6543.149390579194;6544.476441884638;4834.274858771178;4839.153148199086;4861.562459378673;4872.65891387603;4873.902521949542;6833.794986150423;6853.691583878687;6872.969054641794;6902.378785909242;6904.516683832084;5004.624653151028;5010.1733214020005;5016.698998060128;5029.949700503022;5043.949560504421;5053.67151135175;5078.5937125029905;5088.6946783193125;5093.821716239914;5101.617378696538;5693.694053908173;5703.600747947604;5714.914276285859;5717.256756621696;5723.855228954226;6531.542792004514;6591.538592298493;6602.537822352485;6617.2943151835125;6630.30381809903;1625.3823547052282;1745.720684690469;1760.8151144129938;1774.5563609097726;1788.195312109556;1183.526589364261;1207.2153100484754;1213.1023042948154;1214.7206142587254;1219.439058033297;5520.337559492807;5673.461021202979;5719.19931209631;5740.167675687086;5742.569307301969;6486.837829054311;6584.209894812558;6597.8350541235895;6607.834804129935;6685.933140668629;5697.259356283656;5711;5720.42795720433;5735.139729040594;5763.221965034751;3542.946855797165;3550.2366991097037;3550.467429885486;3559.359315323215;3571.4464108212496;6448.871022579616;6476.676166191672;6501.382368675063;6512.381323774234;6545.509086818508;6786.117804685359;6801.42187914023;6806.149231346082;6843.315668433216;6862.828429289308;6457.870842583122;6484.351564843478;6490.7079181436;6492.812136172142;6497.902531462032;6637.70130344126;6637.900431493435;6696.397324240842;6705.698243578953;6713.932860671331;6561.3438656134;6612.93304617647;6660.2673705893285;6676.132102826601;6680.231773346128;6462.804381189495;6467.579607325509;6486.318936511599;6497.660842096936;6537.738490460329;4764.642651801059;4907.165781817028;4929.950700492949;4941.43173535048;4966.130927087673;6673.9332606673315;6692.661467706381;6711.395974362331;6729.596224226562;6731.899021514583;6486.513511486563;6493.837654058686;6518.57629254097;6525.9021114684265;6545;6385.616862988236;6427.614343139239;6443.96778016107;6511;6515.902261466176;6366.204224471941;6389.904151437825;6393.392627700361;6438.4527315176865;6445.516586255956;6528.902066469102;6545.967270163619;6547.934520654732;6549.377809108127;6558.606483610999;6282.424206075487;6301.4328710416285;6305.653189074462;6311.779087731908;6340.968295158495 04:49:30 INFO - PID 27136 | |5;yui.html;842.2293601354761;852.1435956863352;860.126971124309;864.3862857371266;873.126873126873;17589.296428142876;17809.643807123848;17851;17965.10174491275;18031.72952405715;16138.193090345494;16251.18744062798;16309.347626094943;17267.654646907085;18862.24551017961;1043.9739006524821;1059.5179193466954;1061.1404762142652;1062.543106464224;1062.8565143705616;1069.7272195590153;1072.7264547540367;1083.49617427896;1090.0462095666292;1091.9890801092006;1126.3636045634232;1141.0358247281076;1141.3779490177874;1141.8743938166795;1144.0447226565827;1073.2004656530896;1102.1843835561626;1116.8268918317674;1133.240728711761;1134.387430787374;797.1550156833774;802.3821657323887;802.5545822068749;804.9315808156314;810.7689308547094;18464.907675461673;18779.154938027823;18976;18976.715349269773;19279.807201927943;19464.90267548667;19741.309054183177;19943.401697949084;20095.497612559655;20135.89932050345;15018.249087545688;15075.773863392058;15137.772933406008;15192.468263610832;15224;3395.711364534018;3545.0251180925193;3552.5381700378784;3567.161716996504;3590.5152804371596;100083;100658;101217;103583.99999999924;106871;14699.706005879823;15506.379744810081;15791.605209869846;15918.28367723432;16019.599510012109;27861;28259.434811303658;28684.13947581576;29105;29127.708722912925;8800.515971621622;8845.911540884508;8874.334424918157;8910.777230569287;8945.284377249804;4110;4162.084341444877;4185.476815398075;4188.81150348235;4199.91600167995;4882.780274887567;4887.682300650446;4898.681585696918;4904.950950490521;4961.652684312064;936.8969413364524;951.8619800129081;958.7171784323501;966.3477152921749;967.1054274795786;581.119603800243;585.6777875722779;587.1134586774002;598.8472939400425;612.1154931124482;10212.846807297896;11543.538258469735;11568.595099171656;11633.360165190996;11692.70768230801;550.2214366671116;574.9080147176431;574.9971250143806;589.9587028907936;590.2356448399333;4787.521247875255;4930.802767889316;4939.629527785431;5136.1268584340005;5154.969006198775;89152.55423722969;92024;93209;93841.53079234697;94108;63079.36920630827;81375;84120.57939710263;84769.57615211884;85971.57014214889;66127;73344.2665573348;75064.62467687626;76313.61843190748;76645.23354766493;10788.136949043901;10977.890221097687;10985.395803230898;11301.15241356918;11539;32704;34582.481262781585;34775.43510541981;35259.64740352564;35275.118122047155;41220.587794121675;42959.355609665254;43787.78106109449;44808.77595612001;44986.10027799491;15041.849581504044;15799;15813.288402021706;15873;15879.28543215535;17537.12314384301;17626.91186544059;17650.293988240326;17818.821811781716;18114;14640.560783176521;15180.392784288504;15261.160636165117;15504.689906202038;15557.611059723598;15710.2930368136;16123.11322877253;16201;16288.185590720654;16540.75188872192;14132.576022719335;14319.355628996513;14424.06243594163;14854.554363369116;14968.775468367765;10774.353538787698;11298.94350528275;11594.6521604352;11742.295462272292;11807.99632031287;11474;11791.528338866692;11940.46267917963;11963.222390544586;11988.280703157838 04:49:30 INFO - PID 27136 | __end_tp_report 04:49:30 INFO - PID 27136 | __start_cc_report 04:49:30 INFO - PID 27136 | _x_x_mozilla_cycle_collect,369 04:49:30 INFO - PID 27136 | __end_cc_report 04:49:30 INFO - PID 27136 | __startTimestamp1498132170143__endTimestamp 04:49:30 INFO - PID 27136 | 04:49:30 INFO - PID 27136 | ------- Summary: start ------- 04:49:30 INFO - PID 27136 | Number of tests: 6 04:49:30 INFO - PID 27136 | 04:49:30 INFO - PID 27136 | [#0] dojo.html Cycles:165 Average:5931.81 Median:6136.97 stddev:691.16 (11.3%) stddev-sans-first:654.74 04:49:30 INFO - PID 27136 | Values: 3030.8 3041.5 3069.5 3091.1 3094.6 5790.7 5925.9 6038.1 6040.4 6057.6 5818.4 5847.3 5864.8 5869.7 5899.5 5498.5 5502.4 5529.1 5534.3 5571.7 5130.7 5443.5 5534.4 5646.6 5663.2 5537.4 5595.7 5646.2 5649.5 5701.8 5330.5 5396.0 5404.2 5550.9 5588.8 5417.2 5420.2 5470.7 5491.0 5528.5 5959.5 5962.6 5982.6 6018.8 6022.8 6455.6 6477.8 6478.9 6479.7 6482.0 6325.1 6529.6 6543.2 6553.6 6555.9 5960.9 5963.0 5967.6 5981.5 6013.8 6512.3 6605.1 6645.8 6659.8 6708.1 6337.0 6349.5 6361.0 6385.1 6407.9 6402.2 6437.0 6458.1 6479.8 6486.1 6226.7 6275.3 6309.8 6331.7 6478.9 6335.6 6341.7 6361.7 6434.9 6441.8 5288.1 5296.7 5307.6 5315.9 5321.7 4497.6 4507.2 4510.3 4514.1 4538.0 5600.6 5601.6 5603.3 5603.9 5604.3 6295.5 6379.1 6389.6 6503.3 6568.3 5465.7 5570.9 5571.2 5609.4 5613.7 5670.6 5746.3 5765.2 5791.8 5792.7 6293.0 6316.6 6318.4 6322.4 6331.4 6520.3 6521.9 6527.6 6532.2 6540.4 5999.2 6046.7 6065.8 6139.5 6320.8 6245.8 6279.6 6322.7 6355.4 6372.9 6473.6 6515.6 6520.9 6534.1 6554.4 6296.4 6301.8 6309.8 6334.4 6346.5 6314.3 6320.6 6331.1 6335.8 6354.1 6045.5 6080.6 6131.8 6137.0 6149.4 6300.3 6313.5 6316.6 6317.7 6341.9 6136.5 6139.2 6157.2 6163.1 6208.3 04:49:30 INFO - PID 27136 | 04:49:30 INFO - PID 27136 | [#1] ext.html Cycles:180 Average:35943.05 Median:18467.78 stddev:50972.95 (276.0%) stddev-sans-first:51047.01 04:49:30 INFO - PID 27136 | Values: 638.2 670.3 689.6 693.2 695.5 39202.8 40521.2 40615.2 40650.2 40742.4 36893.6 37080.1 37259.6 37306.8 37307.4 6735.3 6829.2 6854.7 6870.5 6903.4 6603.3 6645.4 6663.8 6690.7 6710.6 6583.2 6618.8 6652.0 6687.6 6705.3 6667.2 6676.4 6684.7 6700.3 6710.2 6037.9 6039.2 6040.4 6060.3 6066.7 32365.2 32514.5 32537.8 32552.0 32649.7 3347.0 3351.2 3362.9 3389.6 3614.6 29997.0 30096.0 30127.0 30143.2 30185.5 3682.1 3789.9 3790.5 3792.5 3836.8 180680.0 180732.0 181703.0 183033.1 183235.0 41089.2 41538.6 46869.1 47005.0 47669.3 49170.5 49457.3 49847.5 49885.5 49891.0 15372.8 15391.2 15413.2 15421.2 15438.6 12617.0 12712.2 12741.2 12753.9 12759.9 14012.4 14014.4 14057.9 14133.5 14183.3 5557.0 5586.9 5680.2 5683.8 5776.5 997.4 1010.0 1012.4 1043.6 1044.2 21796.5 22368.7 22657.0 23122.0 23251.9 1084.8 1085.9 1120.2 1128.7 1132.4 11543.4 11812.5 11987.5 12081.3 12442.3 220751.0 220764.0 221227.0 221851.0 222974.0 51024.5 51249.7 51398.2 51483.5 51823.0 1408.2 1449.8 1466.6 1474.2 1484.0 21231.0 22063.3 22176.7 22496.3 23050.0 36021.0 36080.6 36091.0 36130.5 36209.5 182589.0 183137.0 184101.0 184214.0 185155.0 33657.2 34651.8 36653.0 36745.3 37037.3 42211.6 43810.3 44718.6 44953.8 45327.0 30439.8 30797.7 31635.8 32093.5 33572.7 31380.7 31730.5 32051.5 32746.2 32765.0 34343.8 35057.0 36472.0 36735.6 36790.1 29997.7 31142.0 31677.2 31758.8 32004.8 22345.7 24957.4 25095.2 25215.7 25238.0 04:49:30 INFO - PID 27136 | 04:49:30 INFO - PID 27136 | [#2] jquery.html Cycles:180 Average:34170.49 Median:22373.55 stddev:86679.21 (387.4%) stddev-sans-first:86885.60 04:49:30 INFO - PID 27136 | Values: 544.0 558.9 560.2 561.2 581.1 21514.4 22216.8 22252.2 22359.9 22387.2 23858.8 25100.6 25954.0 26012.0 26225.7 6540.7 6622.3 6646.3 6650.1 6674.0 6604.9 6606.7 6646.3 6646.5 6685.1 6094.1 6416.4 6461.6 6472.5 6562.4 6432.9 6501.6 6508.6 6535.8 6535.8 6039.8 6055.9 6056.8 6070.1 6097.2 25852.4 28219.3 28540.3 28610.7 28641.7 1944.5 1965.5 1984.6 1991.6 1993.0 17683.4 18056.1 18188.0 18205.3 18264.9 2310.8 2320.1 2330.6 2332.3 2391.1 113864.4 116963.0 117720.4 118422.4 118811.4 14183.8 14799.9 14985.3 15201.6 15439.8 22786.7 22833.0 23065.0 23077.8 23096.0 9842.2 9875.0 9961.9 10136.2 10206.9 8972.1 9046.2 9213.8 9239.4 9258.2 9098.3 9112.5 9160.5 9205.0 9212.8 2648.7 2666.4 2692.2 2731.3 2872.0 937.1 943.8 962.6 987.2 1013.1 19266.1 19618.9 20130.7 20419.9 20521.4 989.3 1012.5 1013.6 1054.9 1055.8 10841.2 10912.9 10954.7 11132.8 11374.1 499212.0 517545.0 521221.0 527631.0 537848.0 105629.5 110850.0 113905.4 114882.4 115372.0 1241.6 1277.9 1286.0 1286.0 1287.2 19460.6 20806.2 21043.9 21567.7 21572.4 51526.2 52841.5 53007.5 53067.2 53117.2 66733.3 67252.3 67747.7 68072.0 68563.0 12344.4 12549.4 12832.0 12988.8 13104.9 18761.0 18934.9 18995.8 19158.7 19350.8 14731.6 15458.1 15733.4 15778.4 15790.0 14003.3 14255.9 14380.8 14744.9 14751.3 15133.0 15215.3 15271.4 15307.5 15521.4 12423.4 12727.6 12944.6 12971.0 13018.1 14912.9 14995.3 15127.8 15197.3 15197.3 04:49:30 INFO - PID 27136 | 04:49:30 INFO - PID 27136 | [#3] mootools.html Cycles:180 Average:7977.40 Median:2417.77 stddev:5255.32 (217.4%) stddev-sans-first:5246.56 04:49:30 INFO - PID 27136 | Values: 1364.3 1417.2 1433.4 1440.5 1447.0 12890.2 13349.2 13380.1 13381.5 13412.3 12794.2 13155.7 13167.2 13170.9 13212.4 2517.3 2541.3 2551.6 2559.8 2572.4 2443.7 2509.6 2512.8 2521.3 2529.4 2460.2 2489.0 2498.0 2515.6 2516.2 2368.1 2406.9 2412.9 2415.2 2420.3 2357.4 2374.5 2374.8 2375.0 2376.5 12382.8 12581.5 12604.3 12671.4 12686.4 6435.1 6663.3 6686.0 6687.3 6696.9 3988.4 4144.1 4167.9 4181.7 4239.9 1542.2 1568.0 1569.1 1612.3 1626.8 18906.0 19529.2 20366.3 20503.2 20540.2 5274.3 5864.9 6052.7 6079.7 6102.1 14537.1 14558.9 14562.1 14567.3 14577.3 6906.8 6917.6 6919.3 6922.3 6978.3 6441.4 6679.5 6737.1 6762.3 6820.5 4618.2 4712.7 4752.5 4776.1 4904.5 1298.7 1303.5 1304.7 1320.2 1328.2 900.8 901.7 908.0 940.9 951.6 7649.0 7750.9 7824.1 7871.0 7997.2 971.1 976.3 1015.5 1017.7 1028.7 4939.1 4989.8 5113.8 5222.3 5224.6 16344.6 16839.5 17242.9 17336.9 17364.7 16335.4 17275.7 17369.9 17415.9 17426.2 10096.6 10129.9 10132.1 10159.1 10196.7 6771.5 7231.7 7544.5 7640.8 7778.4 14213.6 14285.5 15023.1 15060.1 15153.0 14756.6 14883.3 14986.3 15048.8 15136.5 10893.1 10918.2 11004.4 11047.8 11060.3 11921.2 12015.3 12040.7 12079.3 12255.2 9656.0 10212.2 10418.9 10433.8 10680.4 9006.4 9452.0 9573.6 9892.1 9994.6 8998.9 9039.2 9072.7 9079.9 9101.4 6260.9 6511.0 6730.8 6810.7 6886.0 6795.5 7142.1 7193.4 7202.9 7380.0 04:49:30 INFO - PID 27136 | 04:49:30 INFO - PID 27136 | [#4] prototype.html Cycles:180 Average:5482.72 Median:6055.35 stddev:1538.41 (25.4%) stddev-sans-first:1496.18 04:49:30 INFO - PID 27136 | Values: 478.6 489.7 501.6 511.3 515.5 6145.4 6221.6 6234.8 6267.7 6275.6 5922.3 6049.7 6083.8 6090.4 6113.9 4934.3 4938.7 4949.2 4959.7 4985.6 4951.9 4988.1 4999.6 5001.1 5018.6 4959.8 4962.9 4966.3 4974.9 4975.0 4785.6 4940.8 4955.2 4991.5 4996.5 4450.1 4452.8 4460.5 4466.2 4467.8 5995.5 6004.6 6017.7 6022.6 6061.0 5630.5 5639.8 5663.0 5708.5 5711.6 6406.4 6529.2 6534.5 6543.1 6544.5 4834.3 4839.2 4861.6 4872.7 4873.9 6833.8 6853.7 6873.0 6902.4 6904.5 5004.6 5010.2 5016.7 5029.9 5043.9 5053.7 5078.6 5088.7 5093.8 5101.6 5693.7 5703.6 5714.9 5717.3 5723.9 6531.5 6591.5 6602.5 6617.3 6630.3 1625.4 1745.7 1760.8 1774.6 1788.2 1183.5 1207.2 1213.1 1214.7 1219.4 5520.3 5673.5 5719.2 5740.2 5742.6 6486.8 6584.2 6597.8 6607.8 6685.9 5697.3 5711.0 5720.4 5735.1 5763.2 3542.9 3550.2 3550.5 3559.4 3571.4 6448.9 6476.7 6501.4 6512.4 6545.5 6786.1 6801.4 6806.1 6843.3 6862.8 6457.9 6484.4 6490.7 6492.8 6497.9 6637.7 6637.9 6696.4 6705.7 6713.9 6561.3 6612.9 6660.3 6676.1 6680.2 6462.8 6467.6 6486.3 6497.7 6537.7 4764.6 4907.2 4930.0 4941.4 4966.1 6673.9 6692.7 6711.4 6729.6 6731.9 6486.5 6493.8 6518.6 6525.9 6545.0 6385.6 6427.6 6444.0 6511.0 6515.9 6366.2 6389.9 6393.4 6438.5 6445.5 6528.9 6546.0 6547.9 6549.4 6558.6 6282.4 6301.4 6305.7 6311.8 6341.0 04:49:30 INFO - PID 27136 | 04:49:30 INFO - PID 27136 | [#5] yui.html Cycles:180 Average:19973.33 Median:18820.70 stddev:26034.69 (138.3%) stddev-sans-first:26068.09 04:49:30 INFO - PID 27136 | Values: 842.2 852.1 860.1 864.4 873.1 17589.3 17809.6 17851.0 17965.1 18031.7 16138.2 16251.2 16309.3 17267.7 18862.2 1044.0 1059.5 1061.1 1062.5 1062.9 1069.7 1072.7 1083.5 1090.0 1092.0 1126.4 1141.0 1141.4 1141.9 1144.0 1073.2 1102.2 1116.8 1133.2 1134.4 797.2 802.4 802.6 804.9 810.8 18464.9 18779.2 18976.0 18976.7 19279.8 19464.9 19741.3 19943.4 20095.5 20135.9 15018.2 15075.8 15137.8 15192.5 15224.0 3395.7 3545.0 3552.5 3567.2 3590.5 100083.0 100658.0 101217.0 103584.0 106871.0 14699.7 15506.4 15791.6 15918.3 16019.6 27861.0 28259.4 28684.1 29105.0 29127.7 8800.5 8845.9 8874.3 8910.8 8945.3 4110.0 4162.1 4185.5 4188.8 4199.9 4882.8 4887.7 4898.7 4905.0 4961.7 936.9 951.9 958.7 966.3 967.1 581.1 585.7 587.1 598.8 612.1 10212.8 11543.5 11568.6 11633.4 11692.7 550.2 574.9 575.0 590.0 590.2 4787.5 4930.8 4939.6 5136.1 5155.0 89152.6 92024.0 93209.0 93841.5 94108.0 63079.4 81375.0 84120.6 84769.6 85971.6 66127.0 73344.3 75064.6 76313.6 76645.2 10788.1 10977.9 10985.4 11301.2 11539.0 32704.0 34582.5 34775.4 35259.6 35275.1 41220.6 42959.4 43787.8 44808.8 44986.1 15041.8 15799.0 15813.3 15873.0 15879.3 17537.1 17626.9 17650.3 17818.8 18114.0 14640.6 15180.4 15261.2 15504.7 15557.6 15710.3 16123.1 16201.0 16288.2 16540.8 14132.6 14319.4 14424.1 14854.6 14968.8 10774.4 11298.9 11594.7 11742.3 11808.0 11474.0 11791.5 11940.5 11963.2 11988.3 04:49:30 INFO - PID 27136 | -------- Summary: end -------- 04:49:30 INFO - PID 27136 | 04:49:30 INFO - TEST-INFO | 27136: exit 0 04:49:30 INFO - TEST-OK | dromaeo_css | took 1115924ms 04:49:30 INFO - TEST-START | kraken 04:49:30 INFO - operating with platform_type : linux_ 04:49:30 INFO - Initialising browser for kraken test... 04:49:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36393/getInfo.html -profile /tmp/tmprE4WiG/profile 04:49:30 INFO - TEST-INFO | started process 27557 (/builds/slave/test/build/application/firefox/firefox http://localhost:36393/getInfo.html) 04:49:36 INFO - TEST-INFO | 27557: exit 0 04:49:36 INFO - Browser initialized. 04:49:36 INFO - Running cycle 1/1 for kraken test... 04:49:36 INFO - TEST-INFO | started process 27788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprE4WiG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:48 INFO - PID 27788 | RSS: Main: 169586688 04:49:48 INFO - PID 27788 | 04:49:50 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36393/tests/kraken/driver.html?testName=audio-beat-detection) 04:49:51 INFO - PID 27788 | RSS: Main: 173510656 04:49:51 INFO - PID 27788 | 04:49:54 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36393/tests/kraken/driver.html?testName=audio-dft) 04:49:55 INFO - PID 27788 | RSS: Main: 173842432 04:49:55 INFO - PID 27788 | 04:49:58 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36393/tests/kraken/driver.html?testName=audio-fft) 04:49:58 INFO - PID 27788 | RSS: Main: 168484864 04:49:58 INFO - PID 27788 | 04:50:00 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36393/tests/kraken/driver.html?testName=audio-oscillator) 04:50:01 INFO - PID 27788 | RSS: Main: 170196992 04:50:01 INFO - PID 27788 | 04:50:03 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:04 INFO - PID 27788 | RSS: Main: 169959424 04:50:04 INFO - PID 27788 | 04:50:07 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36393/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:07 INFO - PID 27788 | RSS: Main: 174088192 04:50:07 INFO - PID 27788 | 04:50:11 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36393/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:11 INFO - PID 27788 | RSS: Main: 174342144 04:50:11 INFO - PID 27788 | 04:50:14 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36393/tests/kraken/driver.html?testName=json-parse-financial) 04:50:15 INFO - PID 27788 | RSS: Main: 174870528 04:50:15 INFO - PID 27788 | 04:50:16 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:17 INFO - PID 27788 | RSS: Main: 173887488 04:50:17 INFO - PID 27788 | 04:50:19 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36393/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:19 INFO - PID 27788 | RSS: Main: 174383104 04:50:19 INFO - PID 27788 | 04:50:21 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:22 INFO - PID 27788 | RSS: Main: 173658112 04:50:22 INFO - PID 27788 | 04:50:24 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:50:25 INFO - PID 27788 | RSS: Main: 173879296 04:50:25 INFO - PID 27788 | 04:50:28 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:50:29 INFO - PID 27788 | RSS: Main: 174231552 04:50:29 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | Cycle 1(1): loaded http://localhost:36393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36393/tests/kraken/driver.html?testName=ai-astar) 04:50:31 INFO - PID 27788 | RSS: Main: 174796800 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | __start_tp_report 04:50:31 INFO - PID 27788 | _x_x_mozilla_page_load 04:50:31 INFO - PID 27788 | _x_x_mozilla_page_load_details 04:50:31 INFO - PID 27788 | |i|pagename|runs| 04:50:31 INFO - PID 27788 | |0;ai-astar;99;106;108;107;107;107;111;113;108;110 04:50:31 INFO - PID 27788 | |1;audio-beat-detection;154;118;148;185;121;147;143;121;168;121 04:50:31 INFO - PID 27788 | |2;audio-dft;162;161;163;162;167;171;162;164;164;166 04:50:31 INFO - PID 27788 | |3;audio-fft;75;77;76;179;74;74;75;74;93;75 04:50:31 INFO - PID 27788 | |4;audio-oscillator;82;82;140;82;82;82;135;82;82;130 04:50:31 INFO - PID 27788 | |5;imaging-gaussian-blur;113;114;113;114;114;113;114;114;114;114 04:50:31 INFO - PID 27788 | |6;imaging-darkroom;149;151;149;150;150;151;149;150;151;151 04:50:31 INFO - PID 27788 | |7;imaging-desaturate;96;94;94;94;94;94;94;94;94;94 04:50:31 INFO - PID 27788 | |8;json-parse-financial;54;54;54;56;54;58;59;55;54;54 04:50:31 INFO - PID 27788 | |9;json-stringify-tinderbox;54;53;53;53;53;55;54;54;54;53 04:50:31 INFO - PID 27788 | |10;stanford-crypto-aes;76;75;84;85;76;87;76;77;76;76 04:50:31 INFO - PID 27788 | |11;stanford-crypto-ccm;130;139;131;129;123;128;126;132;124;159 04:50:31 INFO - PID 27788 | |12;stanford-crypto-pbkdf2;182;188;181;177;183;181;184;181;179;186 04:50:31 INFO - PID 27788 | |13;stanford-crypto-sha256-iterative;69;71;70;69;67;67;69;67;70;67 04:50:31 INFO - PID 27788 | __end_tp_report 04:50:31 INFO - PID 27788 | __start_cc_report 04:50:31 INFO - PID 27788 | _x_x_mozilla_cycle_collect,926 04:50:31 INFO - PID 27788 | __end_cc_report 04:50:31 INFO - PID 27788 | __startTimestamp1498132231441__endTimestamp 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | ------- Summary: start ------- 04:50:31 INFO - PID 27788 | Number of tests: 14 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.72 (3.4%) stddev-sans-first:2.30 04:50:31 INFO - PID 27788 | Values: 99.0 106.0 108.0 107.0 107.0 107.0 111.0 113.0 108.0 110.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:147.50 stddev:22.67 (15.4%) stddev-sans-first:23.67 04:50:31 INFO - PID 27788 | Values: 154.0 118.0 148.0 185.0 121.0 147.0 143.0 121.0 168.0 121.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.05 (1.9%) stddev-sans-first:3.13 04:50:31 INFO - PID 27788 | Values: 162.0 161.0 163.0 162.0 167.0 171.0 162.0 164.0 164.0 166.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#3] audio-fft Cycles:10 Average:87.20 Median:75.00 stddev:32.76 (43.7%) stddev-sans-first:34.45 04:50:31 INFO - PID 27788 | Values: 75.0 77.0 76.0 179.0 74.0 74.0 75.0 74.0 93.0 75.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:82.00 stddev:25.71 (31.4%) stddev-sans-first:26.62 04:50:31 INFO - PID 27788 | Values: 82.0 82.0 140.0 82.0 82.0 82.0 135.0 82.0 82.0 130.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:50:31 INFO - PID 27788 | Values: 113.0 114.0 113.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 04:50:31 INFO - PID 27788 | Values: 149.0 151.0 149.0 150.0 150.0 151.0 149.0 150.0 151.0 151.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.00 04:50:31 INFO - PID 27788 | Values: 96.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:1.87 (3.4%) stddev-sans-first:1.94 04:50:31 INFO - PID 27788 | Values: 54.0 54.0 54.0 56.0 54.0 58.0 59.0 55.0 54.0 54.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#9] json-stringify-tinderbox Cycles:10 Average:53.60 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 04:50:31 INFO - PID 27788 | Values: 54.0 53.0 53.0 53.0 53.0 55.0 54.0 54.0 54.0 53.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:76.50 stddev:4.59 (6.0%) stddev-sans-first:4.76 04:50:31 INFO - PID 27788 | Values: 76.0 75.0 84.0 85.0 76.0 87.0 76.0 77.0 76.0 76.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:130.50 stddev:10.48 (8.0%) stddev-sans-first:11.09 04:50:31 INFO - PID 27788 | Values: 130.0 139.0 131.0 129.0 123.0 128.0 126.0 132.0 124.0 159.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:182.50 stddev:3.22 (1.8%) stddev-sans-first:3.42 04:50:31 INFO - PID 27788 | Values: 182.0 188.0 181.0 177.0 183.0 181.0 184.0 181.0 179.0 186.0 04:50:31 INFO - PID 27788 | 04:50:31 INFO - PID 27788 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.51 (2.2%) stddev-sans-first:1.59 04:50:31 INFO - PID 27788 | Values: 69.0 71.0 70.0 69.0 67.0 67.0 69.0 67.0 70.0 67.0 04:50:31 INFO - PID 27788 | -------- Summary: end -------- 04:50:31 INFO - PID 27788 | 04:50:32 INFO - TEST-INFO | 27788: exit 0 04:50:32 INFO - TEST-OK | kraken | took 61518ms 04:50:32 INFO - SUITE-END | took 1177s 04:50:32 INFO - Completed test suite (00:19:37) 04:50:32 INFO - javascript benchmark 04:50:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8035.332456719186, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.83330416827, 3041.4981528047865, 3069.5242237453203, 3091.134482344944, 3094.5822313987605, 5790.652560846353, 5925.940740592593, 6038.064100064486, 6040.426159514845, 6057.606255593383, 5818.389069147742, 5847.26909136358, 5864.824055278338, 5869.677167755772, 5899.52803775698, 5498.532624726903, 5502.367227768817, 5529.142982837667, 5534.308211473566, 5571.693556854391, 5130.743462826862, 5443.482869127427, 5534.418886016971, 5646.57650676201, 5663.235463212455, 5537.390887002426, 5595.720213989284, 5646.2377579026925, 5649.4633009864, 5701.77192912283, 5330.520253177194, 5396.028714831329, 5404.243405923174, 5550.86122846928, 5588.776448942038, 5417.187421886709, 5420.186971954199, 5470.7264636768, 5491.0116179087745, 5528.502434780889, 5959.463648271676, 5962.5528085393335, 5982.581219314649, 6018.8194354169445, 6022.8494287642725, 6455.644939528371, 6477.77327793525, 6478.902816457757, 6479.74081036758, 6482.0, 6325.051242313643, 6529.640869752162, 6543.214814222324, 6553.6395498247575, 6555.868882622369, 5960.85097872548, 5963.0, 5967.5524335675, 5981.461668449861, 6013.759449621966, 6512.283648798629, 6605.141331626858, 6645.767398141042, 6659.800205993828, 6708.094407254958, 6337.017762246859, 6349.52378571609, 6361.045843123476, 6385.106085148083, 6407.871842563122, 6402.231732192074, 6436.967815160894, 6458.095866578683, 6479.8056058318325, 6486.091947127406, 6226.657533835682, 6275.278342990523, 6309.779157729457, 6331.746730130743, 6478.870422591522, 6335.588186767845, 6341.746330146835, 6361.681915904186, 6434.871302573923, 6441.806745797539, 5288.074586947346, 5296.655717378358, 5307.6019298552765, 5315.920261196085, 5321.707306098202, 4497.572730590588, 4507.211238033331, 4510.255807791743, 4514.097180563835, 4537.977310113428, 5600.60795744294, 5601.6358936668985, 5603.271574695345, 5603.887922241533, 5604.327480702342, 6295.464885484785, 6379.075034120026, 6389.584676995981, 6503.25212600557, 6568.277489476154, 5465.672059676353, 5570.888582228414, 5571.220029195916, 5609.382967873531, 5613.747381367848, 5670.603057785998, 5746.339170995306, 5765.164051212634, 5791.7683292667825, 5792.710364481759, 6292.9579988354335, 6316.557840951089, 6318.368163183645, 6322.36776322364, 6331.398517140864, 6520.250171230369, 6521.934780652133, 6527.5757075789925, 6532.150820393318, 6540.444062254762, 5999.1601175836295, 6046.7278972445465, 6065.757369705162, 6139.539534534839, 6320.810375688737, 6245.781397651061, 6279.591826531444, 6322.747090116344, 6355.428011478989, 6372.936270637234, 6473.579217350857, 6515.641639709862, 6520.902186467301, 6534.085228068169, 6554.442872355903, 6296.401841825203, 6301.842453938505, 6309.842253943688, 6334.3665633436285, 6346.460550853045, 6314.336994615499, 6320.62076275425, 6331.145295385249, 6335.778247761491, 6354.110424540476, 6045.455908968214, 6080.574359794949, 6131.774283661862, 6136.969315153574, 6149.354317796746, 6300.2754683212015, 6313.526485513697, 6316.589421687576, 6317.652529110759, 6341.90487142684, 6136.539759517965, 6139.171211886338, 6157.168782214523, 6163.075538669235, 6208.348123446973], "value": 5880.807252139896, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.1576319258578, 670.316277397055, 689.5862482510493, 693.2235895796708, 695.5478938689854, 39202.80398598006, 40521.18957620846, 40615.18769624606, 40650.1869962601, 40742.388864167064, 36893.631063689354, 37080.072998175056, 37259.62740372596, 37306.8134659327, 37307.44038839419, 6735.326467353275, 6829.248782633907, 6854.691538880737, 6870.519063665521, 6903.413209877166, 6603.306652801459, 6645.368689974469, 6663.833404164886, 6690.698918548677, 6710.597364158141, 6583.2429270633775, 6618.768343107992, 6651.966740166293, 6687.598744075347, 6705.295943925891, 6667.233268174149, 6676.365745254193, 6684.732610695566, 6700.329967003309, 6710.228323742784, 6037.943359912042, 6039.1545183674325, 6040.426159514839, 6060.30306514752, 6066.6663333516635, 32365.19087022843, 32514.512282315784, 32537.837310813295, 32552.0, 32649.673503265138, 3347.0460918638314, 3351.2124650707065, 3362.899113026613, 3389.57630296213, 3614.5662520497444, 29997.0, 30096.0, 30127.0, 30143.246418839484, 30185.547216791765, 3682.0794801299676, 3789.8673546425744, 3790.54513458384, 3792.5448946126367, 3836.846526138951, 180680.0, 180732.0, 181703.0, 183033.08483457498, 183234.99999999866, 41089.1782164355, 41538.58461415347, 46869.06261874812, 47005.0, 47669.284960725614, 49170.50829491731, 49457.25814112791, 49847.50152498501, 49885.50114498881, 49891.0, 15372.84627153714, 15391.230438478031, 15413.152276624669, 15421.151836649093, 15438.614034649, 12617.0, 12712.237265763899, 12741.235525868478, 12753.936230318788, 12759.93620031894, 14012.439502419993, 14014.369353379123, 14057.85942140586, 14133.5053273137, 14183.290835458185, 5556.972215138899, 5586.888262234814, 5680.204771332017, 5683.772649094072, 5776.480116789509, 997.3816233935007, 1009.9949500252452, 1012.372329155928, 1043.6451606453843, 1044.2220545693508, 21796.45508862291, 22368.664470032963, 22656.980435880425, 23122.0, 23251.88374058119, 1084.815581351172, 1085.8859819718973, 1120.165476719849, 1128.6501184632791, 1132.4111462039857, 11543.36511491876, 11812.468438920097, 11987.52049918011, 12081.335526545949, 12442.253464792142, 220751.0, 220764.0, 221227.0, 221851.0, 222974.0, 51024.489755101975, 51249.74375128175, 51398.22902656463, 51483.48516514862, 51823.0, 1408.1832537128441, 1449.814854724644, 1466.6040169154269, 1474.1941122125525, 1484.0131312677165, 21231.03836061477, 22063.33809985703, 22176.65473838257, 22496.32511024672, 23050.0, 36021.0, 36080.63919360773, 36091.0, 36130.4580431299, 36209.45685814662, 182589.0, 183137.0, 184101.0, 184214.0, 185155.0, 33657.15857103494, 34651.826740866134, 36653.0, 36745.265094697425, 37037.25925481529, 42211.577884220766, 43810.342844856714, 44718.55281447274, 44953.77523112363, 45327.0, 30439.847800760854, 30797.692023079482, 31635.84182079075, 32093.518597221526, 33572.66427335695, 31380.686193137775, 31730.52404213985, 32051.519227211145, 32746.1813454656, 32765.0, 34343.82828085944, 35057.0, 36472.0, 36735.63264367429, 36790.08024799402, 29997.700022999492, 31142.0, 31677.20806979844, 31758.841205793822, 32004.839975799972, 22345.664815028114, 24957.376065598506, 25095.24714258575, 25215.74784252134, 25238.0], "value": 16179.493029720297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.9700816455098, 558.8546977785775, 560.249265983582, 561.2283110722753, 581.134110175838, 21514.354569362924, 22216.777832221673, 22252.221172258975, 22359.888200558995, 22387.216447424365, 23858.76141238587, 25100.623490647657, 25954.0, 26012.0, 26225.73774262257, 6540.7056682449165, 6622.2715501294815, 6646.30213827546, 6650.1354823872825, 6674.0, 6604.900926486107, 6606.735730570771, 6646.33536646334, 6646.468282537386, 6685.097511835888, 6094.055421409666, 6416.41357091918, 6461.6446095464735, 6472.51456140789, 6562.409383155515, 6432.871342573146, 6501.642409667466, 6508.609483430985, 6535.771248006297, 6535.803925882231, 6039.758409663608, 6055.909161362583, 6056.788012419588, 6070.119832624245, 6097.20736304282, 25852.353691157685, 28219.294517637223, 28540.286492837844, 28610.713892861015, 28641.71358286411, 1944.543032387388, 1965.4693232827058, 1984.5832375201226, 1991.621591897535, 1992.9900350498156, 17683.38108166208, 18056.09719514019, 18188.0, 18205.27178912842, 18264.90867545667, 2310.838241323108, 2320.1415476273887, 2330.5804955108074, 2332.3352844439423, 2391.115287343694, 113864.43067784607, 116963.0, 117720.41139794332, 118422.40788796001, 118811.40594296974, 14183.78724319136, 14799.926000370144, 14985.250737463084, 15201.6199595011, 15439.768403473958, 22786.65820012701, 22833.0, 23065.0, 23077.7692223079, 23096.0, 9842.163416109712, 9874.950625246827, 9961.900380996241, 10136.239782016379, 10206.897931020743, 8972.102789720975, 9046.231070359094, 9213.81572368549, 9239.353245272901, 9258.166764991183, 9098.272138229058, 9112.498812565373, 9160.496172710566, 9204.95397523008, 9212.769680757901, 2648.6821581410354, 2666.360073582326, 2692.1788854399597, 2731.3171707073234, 2871.956920646192, 937.1144268666045, 943.7876477792579, 962.6486332488591, 987.1757082835912, 1013.1489548779061, 19266.059608412535, 19618.90190549038, 20130.698039529125, 20419.8979005104, 20521.35829133666, 989.2975987049132, 1012.5342342522375, 1013.6046941692746, 1054.8681414823147, 1055.7941201465794, 10841.241113122163, 10912.945435272773, 10954.671359859218, 11132.833007504894, 11374.090072794157, 499212.0, 517545.0, 521221.0, 527631.0, 537848.0, 105629.47185264024, 110850.0, 113905.43047284876, 114882.4255878732, 115372.0, 1241.6275117464725, 1277.9297138657278, 1286.0, 1286.0483242400555, 1287.1697754948193, 19460.610787784448, 20806.167753290305, 21043.894780526, 21567.686462707206, 21572.352829415144, 51526.22710659418, 52841.471585285195, 53007.4699253018, 53067.20399194092, 53117.20324195217, 66733.33266667271, 67252.32747672657, 67747.66126169337, 68072.0, 68563.0, 12344.4444999977, 12549.435275412447, 12832.0, 12988.805167922299, 13104.868951310365, 18760.96814675206, 18934.905325473286, 18995.810041899404, 19158.71261931044, 19350.806491935462, 14731.558053258419, 15458.149801761012, 15733.44932927342, 15778.368865245262, 15790.0, 14003.299835008005, 14255.928720356333, 14380.784288235895, 14744.926275368554, 14751.262436877898, 15133.0, 15215.315310810818, 15271.389144434099, 15307.46423875159, 15521.37914483408, 12423.440945157308, 12727.618171454871, 12944.611661650166, 12971.0, 13018.088733788543, 14912.850871491146, 14995.325210365778, 15127.848721513084, 15197.31612077437, 15197.316120774813], "value": 11487.910502720782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.2973868457743, 1417.2205287092104, 1433.3693175002998, 1440.5462279381986, 1447.0377199162554, 12890.226586404822, 13349.199048057124, 13380.130291531044, 13381.464741410344, 13412.262325572101, 12794.168379055378, 13155.736885262313, 13167.209967401963, 13170.934145329284, 13212.40544175512, 2517.2699917024042, 2541.2503311523146, 2551.6045013023013, 2559.795216382685, 2572.4469239113587, 2443.6701045358914, 2509.636102765098, 2512.811539134563, 2521.3318470605213, 2529.443522425073, 2460.1635443949053, 2488.9751102488926, 2498.038255271724, 2515.610080437535, 2516.19481765835, 2368.0764501844296, 2406.927792166229, 2412.8552286862846, 2415.2029830156007, 2420.346506443268, 2357.3870793593787, 2374.4538756086026, 2374.750651181618, 2375.0, 2376.4652953085592, 12382.75234495314, 12581.496740130384, 12604.306763128025, 12671.429785659668, 12686.429110690042, 6435.066915297302, 6663.300353462865, 6686.0, 6687.264400915896, 6696.8995465068065, 3988.3818008208773, 4144.129732756125, 4167.91664166715, 4181.749095054276, 4239.915201695949, 1542.2057640315247, 1567.9608009799733, 1569.097768782943, 1612.3147662243616, 1626.7559866020192, 18906.0, 19529.218831246733, 20366.28717994878, 20503.17987280507, 20540.17839286427, 5274.287971123926, 5864.882702345929, 6052.6671033092725, 6079.665618391031, 6102.145699602059, 14537.055091419235, 14558.85441145596, 14562.126272423688, 14567.344469498687, 14577.323607785029, 6906.792796216121, 6917.619530925847, 6919.273476285019, 6922.273161317989, 6978.337057979484, 6441.355864413521, 6679.532432729759, 6737.056812046318, 6762.323767623297, 6820.488463365267, 4618.1918164321105, 4712.670113092119, 4752.52474752522, 4776.14029474691, 4904.509549045139, 1298.740251949595, 1303.4720938020116, 1304.706441050756, 1320.2474589483902, 1328.1566205459603, 900.7703035725848, 901.7069452427987, 907.9500627465553, 940.8917974432891, 951.5670369981642, 7649.0, 7750.922490775133, 7824.139344672081, 7870.960645196852, 7997.240262175084, 971.0871780526282, 976.2531663277598, 1015.4922538730634, 1017.659084206799, 1028.7325295423243, 4939.073603811118, 4989.775460104304, 5113.795448182105, 5222.321098257202, 5224.634275600672, 16344.591385215226, 16839.494815155565, 17242.913785431243, 17336.913315433343, 17364.739528907077, 16335.428260010842, 17275.654486910193, 17369.913150434168, 17415.91292043557, 17426.215820287864, 10096.596136154472, 10129.898701012895, 10132.138768204784, 10159.136473399843, 10196.694099176888, 6771.492138089565, 7231.674574644258, 7544.509606875536, 7640.770776876702, 7778.377729781717, 14213.57359279182, 14285.500007499688, 15023.09861408319, 15060.096394216382, 15153.0, 14756.63108422298, 14883.25583720788, 14986.325615347117, 15048.849511504744, 15136.470223542123, 10893.128549715846, 10918.181136414642, 11004.39475828837, 11047.83428248593, 11060.336379817236, 11921.225120367148, 12015.279083255033, 12040.698982525508, 12079.335636540074, 12255.203411778206, 9655.951720241354, 10212.183025358103, 10418.947905260426, 10433.843492347773, 10680.412577308323, 9006.369554131148, 9452.007539208284, 9573.617055317709, 9892.060254275832, 9994.550245239127, 8998.865017024618, 9039.231665308522, 9072.727818165466, 9079.863802042843, 9101.362904596615, 6260.907076609459, 6510.967445162744, 6730.798076057726, 6810.659467026728, 6885.965570172117, 6795.45636349081, 7142.142942846892, 7193.424526038009, 7202.927970720226, 7380.040594722652], "value": 5912.1914615632795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.56928764112274, 489.66702642203296, 501.62879469192796, 511.3301574936831, 515.5257163409663, 6145.416185462385, 6221.551590612711, 6234.844128896774, 6267.749290028405, 6275.560710750249, 5922.3485416604135, 6049.727762250698, 6083.8174854754425, 6090.421409966058, 6113.877722445548, 4934.333864928233, 4938.703677779345, 4949.232868905326, 4959.6528243023, 4985.601151907838, 4951.925721114186, 4988.102141614508, 4999.600271815164, 5001.099802035632, 5018.59479345782, 4959.834438906854, 4962.925556116661, 4966.349732946282, 4974.900501989958, 4974.97512512437, 4785.641076919228, 4940.777665005047, 4955.1597511928185, 4991.5258050485145, 4996.525330093636, 4450.087732014961, 4452.777361131931, 4460.528025751494, 4466.173757854807, 4467.776611169428, 5995.460408563206, 6004.609700369462, 6017.69911504423, 6022.638641681469, 6060.969695151496, 5630.465105814982, 5639.802606908738, 5663.037283661787, 5708.514776244025, 5711.62874413166, 6406.391392817722, 6529.183852018497, 6534.477241820643, 6543.149390579194, 6544.476441884638, 4834.274858771178, 4839.153148199086, 4861.562459378673, 4872.65891387603, 4873.902521949542, 6833.794986150423, 6853.691583878687, 6872.969054641794, 6902.378785909242, 6904.516683832084, 5004.624653151028, 5010.1733214020005, 5016.698998060128, 5029.949700503022, 5043.949560504421, 5053.67151135175, 5078.5937125029905, 5088.6946783193125, 5093.821716239914, 5101.617378696538, 5693.694053908173, 5703.600747947604, 5714.914276285859, 5717.256756621696, 5723.855228954226, 6531.542792004514, 6591.538592298493, 6602.537822352485, 6617.2943151835125, 6630.30381809903, 1625.3823547052282, 1745.720684690469, 1760.8151144129938, 1774.5563609097726, 1788.195312109556, 1183.526589364261, 1207.2153100484754, 1213.1023042948154, 1214.7206142587254, 1219.439058033297, 5520.337559492807, 5673.461021202979, 5719.19931209631, 5740.167675687086, 5742.569307301969, 6486.837829054311, 6584.209894812558, 6597.8350541235895, 6607.834804129935, 6685.933140668629, 5697.259356283656, 5711.0, 5720.42795720433, 5735.139729040594, 5763.221965034751, 3542.946855797165, 3550.2366991097037, 3550.467429885486, 3559.359315323215, 3571.4464108212496, 6448.871022579616, 6476.676166191672, 6501.382368675063, 6512.381323774234, 6545.509086818508, 6786.117804685359, 6801.42187914023, 6806.149231346082, 6843.315668433216, 6862.828429289308, 6457.870842583122, 6484.351564843478, 6490.7079181436, 6492.812136172142, 6497.902531462032, 6637.70130344126, 6637.900431493435, 6696.397324240842, 6705.698243578953, 6713.932860671331, 6561.3438656134, 6612.93304617647, 6660.2673705893285, 6676.132102826601, 6680.231773346128, 6462.804381189495, 6467.579607325509, 6486.318936511599, 6497.660842096936, 6537.738490460329, 4764.642651801059, 4907.165781817028, 4929.950700492949, 4941.43173535048, 4966.130927087673, 6673.9332606673315, 6692.661467706381, 6711.395974362331, 6729.596224226562, 6731.899021514583, 6486.513511486563, 6493.837654058686, 6518.57629254097, 6525.9021114684265, 6545.0, 6385.616862988236, 6427.614343139239, 6443.96778016107, 6511.0, 6515.902261466176, 6366.204224471941, 6389.904151437825, 6393.392627700361, 6438.4527315176865, 6445.516586255956, 6528.902066469102, 6545.967270163619, 6547.934520654732, 6549.377809108127, 6558.606483610999, 6282.424206075487, 6301.4328710416285, 6305.653189074462, 6311.779087731908, 6340.968295158495], "value": 5026.492605288381, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.2293601354761, 852.1435956863352, 860.126971124309, 864.3862857371266, 873.126873126873, 17589.296428142876, 17809.643807123848, 17851.0, 17965.10174491275, 18031.72952405715, 16138.193090345494, 16251.18744062798, 16309.347626094943, 17267.654646907085, 18862.24551017961, 1043.9739006524821, 1059.5179193466954, 1061.1404762142652, 1062.543106464224, 1062.8565143705616, 1069.7272195590153, 1072.7264547540367, 1083.49617427896, 1090.0462095666292, 1091.9890801092006, 1126.3636045634232, 1141.0358247281076, 1141.3779490177874, 1141.8743938166795, 1144.0447226565827, 1073.2004656530896, 1102.1843835561626, 1116.8268918317674, 1133.240728711761, 1134.387430787374, 797.1550156833774, 802.3821657323887, 802.5545822068749, 804.9315808156314, 810.7689308547094, 18464.907675461673, 18779.154938027823, 18976.0, 18976.715349269773, 19279.807201927943, 19464.90267548667, 19741.309054183177, 19943.401697949084, 20095.497612559655, 20135.89932050345, 15018.249087545688, 15075.773863392058, 15137.772933406008, 15192.468263610832, 15224.0, 3395.711364534018, 3545.0251180925193, 3552.5381700378784, 3567.161716996504, 3590.5152804371596, 100083.0, 100658.0, 101217.0, 103583.99999999924, 106871.0, 14699.706005879823, 15506.379744810081, 15791.605209869846, 15918.28367723432, 16019.599510012109, 27861.0, 28259.434811303658, 28684.13947581576, 29105.0, 29127.708722912925, 8800.515971621622, 8845.911540884508, 8874.334424918157, 8910.777230569287, 8945.284377249804, 4110.0, 4162.084341444877, 4185.476815398075, 4188.81150348235, 4199.91600167995, 4882.780274887567, 4887.682300650446, 4898.681585696918, 4904.950950490521, 4961.652684312064, 936.8969413364524, 951.8619800129081, 958.7171784323501, 966.3477152921749, 967.1054274795786, 581.119603800243, 585.6777875722779, 587.1134586774002, 598.8472939400425, 612.1154931124482, 10212.846807297896, 11543.538258469735, 11568.595099171656, 11633.360165190996, 11692.70768230801, 550.2214366671116, 574.9080147176431, 574.9971250143806, 589.9587028907936, 590.2356448399333, 4787.521247875255, 4930.802767889316, 4939.629527785431, 5136.1268584340005, 5154.969006198775, 89152.55423722969, 92024.0, 93209.0, 93841.53079234697, 94108.0, 63079.36920630827, 81375.0, 84120.57939710263, 84769.57615211884, 85971.57014214889, 66127.0, 73344.2665573348, 75064.62467687626, 76313.61843190748, 76645.23354766493, 10788.136949043901, 10977.890221097687, 10985.395803230898, 11301.15241356918, 11539.0, 32704.0, 34582.481262781585, 34775.43510541981, 35259.64740352564, 35275.118122047155, 41220.587794121675, 42959.355609665254, 43787.78106109449, 44808.77595612001, 44986.10027799491, 15041.849581504044, 15799.0, 15813.288402021706, 15873.0, 15879.28543215535, 17537.12314384301, 17626.91186544059, 17650.293988240326, 17818.821811781716, 18114.0, 14640.560783176521, 15180.392784288504, 15261.160636165117, 15504.689906202038, 15557.611059723598, 15710.2930368136, 16123.11322877253, 16201.0, 16288.185590720654, 16540.75188872192, 14132.576022719335, 14319.355628996513, 14424.06243594163, 14854.554363369116, 14968.775468367765, 10774.353538787698, 11298.94350528275, 11594.6521604352, 11742.295462272292, 11807.99632031287, 11474.0, 11791.528338866692, 11940.46267917963, 11963.222390544586, 11988.280703157838], "value": 8285.90961516017, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 106.0, 108.0, 107.0, 107.0, 107.0, 111.0, 113.0, 108.0, 110.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 118.0, 148.0, 185.0, 121.0, 147.0, 143.0, 121.0, 168.0, 121.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 167.0, 171.0, 162.0, 164.0, 164.0, 166.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 179.0, 74.0, 74.0, 75.0, 74.0, 93.0, 75.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 140.0, 82.0, 82.0, 82.0, 135.0, 82.0, 82.0, 130.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 149.0, 150.0, 150.0, 151.0, 149.0, 150.0, 151.0, 151.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 56.0, 54.0, 58.0, 59.0, 55.0, 54.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 55.0, 54.0, 54.0, 54.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 84.0, 85.0, 76.0, 87.0, 76.0, 77.0, 76.0, 76.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 139.0, 131.0, 129.0, 123.0, 128.0, 126.0, 132.0, 124.0, 159.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 188.0, 181.0, 177.0, 183.0, 181.0, 184.0, 181.0, 179.0, 186.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 70.0, 69.0, 67.0, 67.0, 69.0, 67.0, 70.0, 67.0], "value": 68.6, "unit": "score"}]}]} 04:50:32 INFO - Return code: 0 04:50:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:50:32 INFO - # TBPL SUCCESS # 04:50:32 INFO - Running post-action listener: _resource_record_post_action 04:50:32 INFO - [mozharness: 2017-06-22 11:50:32.783648Z] Finished run-tests step (success) 04:50:32 INFO - Running post-run listener: _resource_record_post_run 04:50:32 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432918528; Read time: 164; Write time: 291100 04:50:32 INFO - TinderboxPrint: CPU usage
13.1% 04:50:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 164 04:50:32 INFO - TinderboxPrint: I/O write bytes / time
432,918,528 / 291,100 04:50:32 INFO - TinderboxPrint: CPU idle
8,281.7 (86.8%) 04:50:32 INFO - TinderboxPrint: CPU user
1,205.3 (12.6%) 04:50:32 INFO - TinderboxPrint: Swap in / out
0 / 0 04:50:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105631744; Read time: 0; Write time: 78292 04:50:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:50:32 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326430720; Read time: 164; Write time: 212724 04:50:33 INFO - Running post-run listener: _upload_blobber_files 04:50:33 INFO - Blob upload gear active. 04:50:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:50:33 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 04:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:50:33 INFO - (blobuploader) - INFO - Open directory for files ... 04:50:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:50:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:50:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:34 INFO - (blobuploader) - INFO - Done attempting. 04:50:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:50:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:50:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:51 INFO - (blobuploader) - INFO - Done attempting. 04:50:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:50:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:50:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:54 INFO - (blobuploader) - INFO - Done attempting. 04:50:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:50:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:50:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:56 INFO - (blobuploader) - INFO - Done attempting. 04:50:56 INFO - (blobuploader) - INFO - Iteration through files over. 04:50:56 INFO - Return code: 0 04:50:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:50:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:50:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a72b463025b3f62a7331f6066043f3f76c535bfa3049fbc35a8b82c67633dab5843c1b0e843e5d638394a4a47c340992383c9d335f0e378f1d79bac8a4958c0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab588dffe5aa217b7ef810c9daadcc538283bcb7371320485da224c54ffae2cd33d981731736df6d8d3a24f5aa0a585ab36ef384dd2373f14a529b4078707ca6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d885d62fce22c96e8f6a47f6d0dce39d6aa096318c57dda249807f1881b3cd157839efa9ed9f22b0f55d3f04ea83211169f88f35027facbd1183cd1d905b6ef2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2180579a6fb2074f26a60e4da6fdc0b70159caadeeb2777b5afa325107042a47fc1bdb958bbdd28402a892faed2ac044f3c392fcf7355a10230b9ea9ab43332"} 04:50:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:50:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:50:56 INFO - Contents: 04:50:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a72b463025b3f62a7331f6066043f3f76c535bfa3049fbc35a8b82c67633dab5843c1b0e843e5d638394a4a47c340992383c9d335f0e378f1d79bac8a4958c0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab588dffe5aa217b7ef810c9daadcc538283bcb7371320485da224c54ffae2cd33d981731736df6d8d3a24f5aa0a585ab36ef384dd2373f14a529b4078707ca6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d885d62fce22c96e8f6a47f6d0dce39d6aa096318c57dda249807f1881b3cd157839efa9ed9f22b0f55d3f04ea83211169f88f35027facbd1183cd1d905b6ef2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2180579a6fb2074f26a60e4da6fdc0b70159caadeeb2777b5afa325107042a47fc1bdb958bbdd28402a892faed2ac044f3c392fcf7355a10230b9ea9ab43332"} 04:50:56 INFO - Running post-run listener: copy_logs_to_upload_dir 04:50:56 INFO - Copying logs to upload dir... 04:50:56 INFO - mkdir: /builds/slave/test/build/upload/logs 04:50:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.829680 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-06-22 04:50:56.292931) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-22 04:50:56.297743) ========= 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=41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a72b463025b3f62a7331f6066043f3f76c535bfa3049fbc35a8b82c67633dab5843c1b0e843e5d638394a4a47c340992383c9d335f0e378f1d79bac8a4958c0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab588dffe5aa217b7ef810c9daadcc538283bcb7371320485da224c54ffae2cd33d981731736df6d8d3a24f5aa0a585ab36ef384dd2373f14a529b4078707ca6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d885d62fce22c96e8f6a47f6d0dce39d6aa096318c57dda249807f1881b3cd157839efa9ed9f22b0f55d3f04ea83211169f88f35027facbd1183cd1d905b6ef2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2180579a6fb2074f26a60e4da6fdc0b70159caadeeb2777b5afa325107042a47fc1bdb958bbdd28402a892faed2ac044f3c392fcf7355a10230b9ea9ab43332"} build_url:https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/IEtcVmmuTh6uo_TFnq8Mdw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a72b463025b3f62a7331f6066043f3f76c535bfa3049fbc35a8b82c67633dab5843c1b0e843e5d638394a4a47c340992383c9d335f0e378f1d79bac8a4958c0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab588dffe5aa217b7ef810c9daadcc538283bcb7371320485da224c54ffae2cd33d981731736df6d8d3a24f5aa0a585ab36ef384dd2373f14a529b4078707ca6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d885d62fce22c96e8f6a47f6d0dce39d6aa096318c57dda249807f1881b3cd157839efa9ed9f22b0f55d3f04ea83211169f88f35027facbd1183cd1d905b6ef2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2180579a6fb2074f26a60e4da6fdc0b70159caadeeb2777b5afa325107042a47fc1bdb958bbdd28402a892faed2ac044f3c392fcf7355a10230b9ea9ab43332"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-22 04:50:56.328650) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 04:50:56.328976) ========= 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=41a7e32711b8e08598a63237000001d6-1498130968.252443-612840047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 04:50:56.413173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-22 04:50:56.413496) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-22 04:50:56.413780) ========= ========= Total master_lag: 0.23 =========