builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-074 starttime: 1496418753.72 results: success (0) revision: 95d2d23ff510bea680e9707c1ec166b0cc08dc6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:33.720041) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:33.720496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:33.720765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:33.736768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:33.737041) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-02 08:52:36-- 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% 225M=0s 2017-06-02 08:52:36 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076599 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:33.826605) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:33.826922) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016708 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:33.881977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 08:52:33.882301) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 95d2d23ff510bea680e9707c1ec166b0cc08dc6b --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 95d2d23ff510bea680e9707c1ec166b0cc08dc6b --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=23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-02 08:52:36,645 truncating revision to first 12 chars 2017-06-02 08:52:36,646 Setting DEBUG logging. 2017-06-02 08:52:36,646 attempt 1/10 2017-06-02 08:52:36,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/95d2d23ff510?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-02 08:52:37,655 unpacking tar archive at: mozilla-central-95d2d23ff510/testing/mozharness/ program finished with exit code 0 elapsedTime=1.285321 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 08:52:35.186130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:35.186491) ========= script_repo_revision: 95d2d23ff510bea680e9707c1ec166b0cc08dc6b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:35.186886) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:35.187160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 08:52:35.203953) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-06-02 08:52:35.204309) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:52:38 INFO - MultiFileLogger online at 20170602 08:52:38 in /builds/slave/test 08:52:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:52:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:38 INFO - {'append_to_log': False, 08:52:38 INFO - 'base_work_dir': '/builds/slave/test', 08:52:38 INFO - 'blob_upload_branch': 'Firefox', 08:52:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:38 INFO - 'branch': 'Firefox', 08:52:38 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:38 INFO - 'config_files': ('talos/linux_config.py',), 08:52:38 INFO - 'default_actions': ('clobber', 08:52:38 INFO - 'read-buildbot-config', 08:52:38 INFO - 'download-and-extract', 08:52:38 INFO - 'populate-webroot', 08:52:38 INFO - 'create-virtualenv', 08:52:38 INFO - 'install', 08:52:38 INFO - 'setup-mitmproxy', 08:52:38 INFO - 'run-tests'), 08:52:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:38 INFO - 'download_minidump_stackwalk': True, 08:52:38 INFO - 'download_symbols': 'ondemand', 08:52:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:38 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:38 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:38 INFO - 'gecko_profile': False, 08:52:38 INFO - 'gecko_profile_interval': 0, 08:52:38 INFO - 'installer_path': 'installer.exe', 08:52:38 INFO - 'log_level': 'info', 08:52:38 INFO - 'log_name': 'talos', 08:52:38 INFO - 'log_to_console': True, 08:52:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:52:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:52:38 INFO - 'opt_config_files': (), 08:52:38 INFO - 'pip_index': False, 08:52:38 INFO - 'suite': 'dromaeojs-e10s', 08:52:38 INFO - 'system_bits': '32', 08:52:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:38 INFO - 'title': 'talos-linux64-ix-074', 08:52:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:38 INFO - 'use_talos_json': True, 08:52:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:38 INFO - 'work_dir': 'build'} 08:52:38 INFO - [mozharness: 2017-06-02 15:52:38.074489Z] Running clobber step. 08:52:38 INFO - Running pre-action listener: _resource_record_pre_action 08:52:38 INFO - Running main action method: clobber 08:52:38 INFO - rmtree: /builds/slave/test/build 08:52:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:39 INFO - Running post-action listener: _resource_record_post_action 08:52:39 INFO - [mozharness: 2017-06-02 15:52:39.092010Z] Finished clobber step (success) 08:52:39 INFO - [mozharness: 2017-06-02 15:52:39.092112Z] Running read-buildbot-config step. 08:52:39 INFO - Running pre-action listener: _resource_record_pre_action 08:52:39 INFO - Running main action method: read_buildbot_config 08:52:39 INFO - Using buildbot properties: 08:52:39 INFO - { 08:52:39 INFO - "project": "", 08:52:39 INFO - "product": "firefox", 08:52:39 INFO - "who": "ryanvm@gmail.com", 08:52:39 INFO - "installer_path": "public/build/target.tar.bz2", 08:52:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 08:52:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:52:39 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 08:52:39 INFO - "stage_platform": "linux64-stylosequential", 08:52:39 INFO - "basedir": "/builds/slave/test", 08:52:39 INFO - "buildnumber": 47, 08:52:39 INFO - "platform": "ubuntu64_hw_styloseq", 08:52:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:52:39 INFO - "slavebuilddir": "test", 08:52:39 INFO - "taskId": "Uuz6AsVsTJG5a0aTIkfnDQ", 08:52:39 INFO - "branch": "mozilla-central", 08:52:39 INFO - "script_repo_revision": "production", 08:52:39 INFO - "revision": "95d2d23ff510bea680e9707c1ec166b0cc08dc6b", 08:52:39 INFO - "slavename": "talos-linux64-ix-074", 08:52:39 INFO - "repo_path": "mozilla-central" 08:52:39 INFO - } 08:52:39 INFO - Finding installer, test and symbols from parent task. 08:52:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uuz6AsVsTJG5a0aTIkfnDQ'}, attempt #1 08:52:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uuz6AsVsTJG5a0aTIkfnDQ'}, attempt #1 08:52:40 INFO - Task dependencies: UrYeOsKRR3e_UsOLfZfxCA 08:52:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA'}, attempt #1 08:52:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.tar.bz2 08:52:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/test_packages.json 08:52:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.crashreporter-symbols.zip 08:52:40 INFO - Running post-action listener: _resource_record_post_action 08:52:40 INFO - [mozharness: 2017-06-02 15:52:40.491463Z] Finished read-buildbot-config step (success) 08:52:40 INFO - [mozharness: 2017-06-02 15:52:40.491686Z] Running download-and-extract step. 08:52:40 INFO - Running pre-action listener: _resource_record_pre_action 08:52:40 INFO - Running main action method: download_and_extract 08:52:40 INFO - mkdir: /builds/slave/test/build/tests 08:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:40 INFO - trying https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.test_packages.json 08:52:40 INFO - Downloading https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:52:41 INFO - Downloaded 989 bytes. 08:52:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:52:41 INFO - Using the following test package requirements: 08:52:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:52:41 INFO - u'common': [u'target.common.tests.zip'], 08:52:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:52:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:52:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:52:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:52:41 INFO - u'mozbase': [u'target.common.tests.zip'], 08:52:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:52:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:52:41 INFO - u'web-platform': [u'target.common.tests.zip', 08:52:41 INFO - u'target.web-platform.tests.tar.gz'], 08:52:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:52:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:52:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.common.tests.zip 08:52:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:52:41 INFO - Fetch https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.common.tests.zip into memory 08:52:42 INFO - Content-Length response header: 65102492 08:52:42 INFO - Bytes received: 65102492 08:52:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:52:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.common.tests.zip 08:52:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:52:53 INFO - Fetch https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.common.tests.zip into memory 08:52:54 INFO - Content-Length response header: 65102492 08:52:54 INFO - Bytes received: 65102492 08:53:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.talos.tests.zip 08:53:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:53:06 INFO - Fetch https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.talos.tests.zip into memory 08:53:06 INFO - Content-Length response header: 14447425 08:53:06 INFO - Bytes received: 14447425 08:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:07 INFO - trying https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.tar.bz2 08:53:07 INFO - Downloading https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:53:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:53:10 INFO - Downloaded 60333734 bytes. 08:53:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.tar.bz2 08:53:10 INFO - mkdir: /builds/slave/test/properties 08:53:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:10 INFO - Contents: 08:53:10 INFO - build_url:https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.tar.bz2 08:53:10 INFO - Running post-action listener: _resource_record_post_action 08:53:10 INFO - Running post-action listener: set_extra_try_arguments 08:53:10 INFO - [mozharness: 2017-06-02 15:53:10.047826Z] Finished download-and-extract step (success) 08:53:10 INFO - [mozharness: 2017-06-02 15:53:10.047925Z] Running populate-webroot step. 08:53:10 INFO - Running pre-action listener: _resource_record_pre_action 08:53:10 INFO - Running main action method: populate_webroot 08:53:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:10 INFO - '--tppagecycles', 08:53:10 INFO - '7'], 08:53:10 INFO - 'tests': ['tsvgm']}}, 08:53:10 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:53:10 INFO - 'talos_options': ['--disable-e10s'], 08:53:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:53:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:53:10 INFO - 'talos_options': ['--disable-e10s'], 08:53:10 INFO - 'tests': ['damp', 'tps']}, 08:53:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:53:10 INFO - 'tests': ['damp', 'tps']}, 08:53:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:10 INFO - 'tests': ['dromaeo_dom']}, 08:53:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:53:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:53:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:53:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:53:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:53:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:10 INFO - 'tests': ['a11yr', 08:53:10 INFO - 'ts_paint', 08:53:10 INFO - 'tpaint', 08:53:10 INFO - 'sessionrestore', 08:53:10 INFO - 'sessionrestore_no_auto_restore', 08:53:10 INFO - 'tabpaint']}, 08:53:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:10 INFO - 'ts_paint', 08:53:10 INFO - 'tpaint', 08:53:10 INFO - 'sessionrestore', 08:53:10 INFO - 'sessionrestore_no_auto_restore', 08:53:10 INFO - 'tabpaint']}, 08:53:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:10 INFO - 'ts_paint', 08:53:10 INFO - 'tpaint', 08:53:10 INFO - 'sessionrestore', 08:53:10 INFO - 'sessionrestore_no_auto_restore', 08:53:10 INFO - 'tabpaint']}, 08:53:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:10 INFO - 'ts_paint', 08:53:10 INFO - 'tpaint', 08:53:10 INFO - 'sessionrestore', 08:53:10 INFO - 'sessionrestore_no_auto_restore', 08:53:10 INFO - 'tabpaint']}, 08:53:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:10 INFO - 'tests': ['a11yr', 08:53:10 INFO - 'ts_paint', 08:53:10 INFO - 'tpaint', 08:53:10 INFO - 'sessionrestore', 08:53:10 INFO - 'sessionrestore_no_auto_restore', 08:53:10 INFO - 'tabpaint']}, 08:53:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:10 INFO - 'tests': ['a11yr', 08:53:10 INFO - 'ts_paint', 08:53:10 INFO - 'tpaint', 08:53:10 INFO - 'sessionrestore', 08:53:10 INFO - 'sessionrestore_no_auto_restore', 08:53:10 INFO - 'tabpaint']}, 08:53:10 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:53:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:53:10 INFO - 'bloom_basic_ref']}, 08:53:10 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 08:53:10 INFO - 'talos_options': ['--mitmproxy', 08:53:10 INFO - 'mitmproxy-recording-1.mp', 08:53:10 INFO - '--firstNonBlankPaint'], 08:53:10 INFO - 'tests': ['Quantum_1']}, 08:53:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:10 INFO - 'tests': ['tsvgx', 08:53:10 INFO - 'tsvgr_opacity', 08:53:10 INFO - 'tart', 08:53:10 INFO - 'tscrollx', 08:53:10 INFO - 'cart', 08:53:10 INFO - 'tsvg_static']}, 08:53:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:10 INFO - 'tsvgr_opacity', 08:53:10 INFO - 'tart', 08:53:10 INFO - 'tscrollx', 08:53:10 INFO - 'cart', 08:53:10 INFO - 'tsvg_static']}, 08:53:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:53:10 INFO - 'talos_options': ['--disable-e10s'], 08:53:10 INFO - 'tests': ['tp5o']}, 08:53:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:53:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:53:10 INFO - 'talos_options': ['--disable-e10s', 08:53:10 INFO - '--xperf_path', 08:53:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:10 INFO - 'tests': ['tp5n']}, 08:53:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:53:10 INFO - 'talos_options': ['--xperf_path', 08:53:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:10 INFO - 'tests': ['tp5n']}}, 08:53:10 INFO - 'talos.zip': {'path': '', 08:53:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:10 INFO - Running post-action listener: _resource_record_post_action 08:53:10 INFO - [mozharness: 2017-06-02 15:53:10.062427Z] Finished populate-webroot step (success) 08:53:10 INFO - [mozharness: 2017-06-02 15:53:10.062518Z] Running create-virtualenv step. 08:53:10 INFO - Running pre-action listener: _resource_record_pre_action 08:53:10 INFO - Running main action method: create_virtualenv 08:53:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:53:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:53:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:10 INFO - Using real prefix '/usr' 08:53:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:10 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:12 INFO - Installing pip.................done. 08:53:12 INFO - Return code: 0 08:53:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:53:12 INFO - Reading from file tmpfile_stdout 08:53:12 INFO - Output received: 08:53:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:53:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:12 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 0x1a3b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:53:12 INFO - Using env: {'DISPLAY': ':0', 08:53:12 INFO - 'HOME': '/home/cltbld', 08:53:12 INFO - 'LANG': 'en_US.UTF-8', 08:53:12 INFO - 'LANGUAGE': 'en_US:en', 08:53:12 INFO - 'LOGNAME': 'cltbld', 08:53:12 INFO - 'MAIL': '/var/mail/cltbld', 08:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:12 INFO - 'MOZ_NO_REMOTE': '1', 08:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:12 INFO - 'NO_EM_RESTART': '1', 08:53:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:12 INFO - 'PWD': '/builds/slave/test', 08:53:12 INFO - 'SHELL': '/bin/bash', 08:53:12 INFO - 'SHLVL': '1', 08:53:12 INFO - 'TERM': 'linux', 08:53:12 INFO - 'TMOUT': '86400', 08:53:12 INFO - 'USER': 'cltbld', 08:53:12 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:12 INFO - '_': '/tools/buildbot/bin/python'} 08:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:53:13 INFO - Cleaning up... 08:53:13 INFO - Return code: 0 08:53:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:13 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 0x1a3b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:53:13 INFO - Using env: {'DISPLAY': ':0', 08:53:13 INFO - 'HOME': '/home/cltbld', 08:53:13 INFO - 'LANG': 'en_US.UTF-8', 08:53:13 INFO - 'LANGUAGE': 'en_US:en', 08:53:13 INFO - 'LOGNAME': 'cltbld', 08:53:13 INFO - 'MAIL': '/var/mail/cltbld', 08:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:13 INFO - 'MOZ_NO_REMOTE': '1', 08:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:13 INFO - 'NO_EM_RESTART': '1', 08:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:13 INFO - 'PWD': '/builds/slave/test', 08:53:13 INFO - 'SHELL': '/bin/bash', 08:53:13 INFO - 'SHLVL': '1', 08:53:13 INFO - 'TERM': 'linux', 08:53:13 INFO - 'TMOUT': '86400', 08:53:13 INFO - 'USER': 'cltbld', 08:53:13 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:13 INFO - '_': '/tools/buildbot/bin/python'} 08:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:13 INFO - Downloading/unpacking psutil>=3.1.1 08:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:14 INFO - Installing collected packages: psutil 08:53:14 INFO - Running setup.py install for psutil 08:53:14 INFO - building 'psutil._psutil_linux' extension 08:53:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:53:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:53:14 INFO - building 'psutil._psutil_posix' extension 08:53:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:53:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:53:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:15 INFO - Successfully installed psutil 08:53:15 INFO - Cleaning up... 08:53:15 INFO - Return code: 0 08:53:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:15 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 0x1a3b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:53:15 INFO - Using env: {'DISPLAY': ':0', 08:53:15 INFO - 'HOME': '/home/cltbld', 08:53:15 INFO - 'LANG': 'en_US.UTF-8', 08:53:15 INFO - 'LANGUAGE': 'en_US:en', 08:53:15 INFO - 'LOGNAME': 'cltbld', 08:53:15 INFO - 'MAIL': '/var/mail/cltbld', 08:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:15 INFO - 'MOZ_NO_REMOTE': '1', 08:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:15 INFO - 'NO_EM_RESTART': '1', 08:53:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:15 INFO - 'PWD': '/builds/slave/test', 08:53:15 INFO - 'SHELL': '/bin/bash', 08:53:15 INFO - 'SHLVL': '1', 08:53:15 INFO - 'TERM': 'linux', 08:53:15 INFO - 'TMOUT': '86400', 08:53:15 INFO - 'USER': 'cltbld', 08:53:15 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:15 INFO - '_': '/tools/buildbot/bin/python'} 08:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:16 INFO - Installing collected packages: mozsystemmonitor 08:53:16 INFO - Running setup.py install for mozsystemmonitor 08:53:16 INFO - Successfully installed mozsystemmonitor 08:53:16 INFO - Cleaning up... 08:53:16 INFO - Return code: 0 08:53:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53: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', '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 0x1a3b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:53: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 jsonschema==2.5.1 08:53:16 INFO - Using env: {'DISPLAY': ':0', 08:53:16 INFO - 'HOME': '/home/cltbld', 08:53:16 INFO - 'LANG': 'en_US.UTF-8', 08:53:16 INFO - 'LANGUAGE': 'en_US:en', 08:53:16 INFO - 'LOGNAME': 'cltbld', 08:53:16 INFO - 'MAIL': '/var/mail/cltbld', 08:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:16 INFO - 'MOZ_NO_REMOTE': '1', 08:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:16 INFO - 'NO_EM_RESTART': '1', 08:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:16 INFO - 'PWD': '/builds/slave/test', 08:53:16 INFO - 'SHELL': '/bin/bash', 08:53:16 INFO - 'SHLVL': '1', 08:53:16 INFO - 'TERM': 'linux', 08:53:16 INFO - 'TMOUT': '86400', 08:53:16 INFO - 'USER': 'cltbld', 08:53:16 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:16 INFO - '_': '/tools/buildbot/bin/python'} 08:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:16 INFO - Downloading/unpacking jsonschema==2.5.1 08:53: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 08:53: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 08:53: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 08:53: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 08:53:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:18 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:18 INFO - warning: no files found matching '*.txt' 08:53:18 INFO - no previously-included directories found matching 'build' 08:53:18 INFO - no previously-included directories found matching 'dist' 08:53:18 INFO - no previously-included directories found matching '.git*' 08:53:18 INFO - Installing collected packages: jsonschema, functools32 08:53:18 INFO - Running setup.py install for functools32 08:53:18 INFO - warning: no files found matching '*.txt' 08:53:18 INFO - no previously-included directories found matching 'build' 08:53:18 INFO - no previously-included directories found matching 'dist' 08:53:18 INFO - no previously-included directories found matching '.git*' 08:53:18 INFO - Successfully installed jsonschema functools32 08:53:18 INFO - Cleaning up... 08:53:18 INFO - Return code: 0 08:53:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:18 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 0x1a3b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:53:18 INFO - Using env: {'DISPLAY': ':0', 08:53:18 INFO - 'HOME': '/home/cltbld', 08:53:18 INFO - 'LANG': 'en_US.UTF-8', 08:53:18 INFO - 'LANGUAGE': 'en_US:en', 08:53:18 INFO - 'LOGNAME': 'cltbld', 08:53:18 INFO - 'MAIL': '/var/mail/cltbld', 08:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:18 INFO - 'MOZ_NO_REMOTE': '1', 08:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:18 INFO - 'NO_EM_RESTART': '1', 08:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:18 INFO - 'PWD': '/builds/slave/test', 08:53:18 INFO - 'SHELL': '/bin/bash', 08:53:18 INFO - 'SHLVL': '1', 08:53:18 INFO - 'TERM': 'linux', 08:53:18 INFO - 'TMOUT': '86400', 08:53:18 INFO - 'USER': 'cltbld', 08:53:18 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:18 INFO - '_': '/tools/buildbot/bin/python'} 08:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:53:18 INFO - Cleaning up... 08:53:18 INFO - Return code: 0 08:53:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:18 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 0x1a3b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:53:18 INFO - Using env: {'DISPLAY': ':0', 08:53:18 INFO - 'HOME': '/home/cltbld', 08:53:18 INFO - 'LANG': 'en_US.UTF-8', 08:53:18 INFO - 'LANGUAGE': 'en_US:en', 08:53:18 INFO - 'LOGNAME': 'cltbld', 08:53:18 INFO - 'MAIL': '/var/mail/cltbld', 08:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:18 INFO - 'MOZ_NO_REMOTE': '1', 08:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:18 INFO - 'NO_EM_RESTART': '1', 08:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:18 INFO - 'PWD': '/builds/slave/test', 08:53:18 INFO - 'SHELL': '/bin/bash', 08:53:18 INFO - 'SHLVL': '1', 08:53:18 INFO - 'TERM': 'linux', 08:53:18 INFO - 'TMOUT': '86400', 08:53:18 INFO - 'USER': 'cltbld', 08:53:18 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:18 INFO - '_': '/tools/buildbot/bin/python'} 08:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:18 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53: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 08:53: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 08:53: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 08:53: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 08:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:20 INFO - Downloading docopt-0.6.1.tar.gz 08:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:20 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:20 INFO - Running setup.py install for blobuploader 08:53:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:20 INFO - Running setup.py install for requests 08:53:20 INFO - Running setup.py install for docopt 08:53:21 INFO - Successfully installed blobuploader requests docopt 08:53:21 INFO - Cleaning up... 08:53:21 INFO - Return code: 0 08:53:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53: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')]} 08:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:21 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 0x1a3b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:53:21 INFO - Using env: {'DISPLAY': ':0', 08:53:21 INFO - 'HOME': '/home/cltbld', 08:53:21 INFO - 'LANG': 'en_US.UTF-8', 08:53:21 INFO - 'LANGUAGE': 'en_US:en', 08:53:21 INFO - 'LOGNAME': 'cltbld', 08:53:21 INFO - 'MAIL': '/var/mail/cltbld', 08:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:21 INFO - 'MOZ_NO_REMOTE': '1', 08:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:21 INFO - 'NO_EM_RESTART': '1', 08:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:21 INFO - 'PWD': '/builds/slave/test', 08:53:21 INFO - 'SHELL': '/bin/bash', 08:53:21 INFO - 'SHLVL': '1', 08:53:21 INFO - 'TERM': 'linux', 08:53:21 INFO - 'TMOUT': '86400', 08:53:21 INFO - 'USER': 'cltbld', 08:53:21 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:21 INFO - '_': '/tools/buildbot/bin/python'} 08:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:21 INFO - Running setup.py (path:/tmp/pip-J_KTXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:21 INFO - Running setup.py (path:/tmp/pip-DBtbNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:21 INFO - Running setup.py (path:/tmp/pip-99BbA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:21 INFO - Running setup.py (path:/tmp/pip-_BWaU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:21 INFO - Running setup.py (path:/tmp/pip-ott16x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:21 INFO - Running setup.py (path:/tmp/pip-ZaTCQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:21 INFO - Running setup.py (path:/tmp/pip-fdJkrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:21 INFO - Running setup.py (path:/tmp/pip-EG7CEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:21 INFO - Running setup.py (path:/tmp/pip-5gaKGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:21 INFO - Running setup.py (path:/tmp/pip-l2CmcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:22 INFO - Running setup.py (path:/tmp/pip-2AR97m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:22 INFO - Running setup.py (path:/tmp/pip-LSNkWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:22 INFO - Running setup.py (path:/tmp/pip-MiTpdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:22 INFO - Running setup.py (path:/tmp/pip-GTlME5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:22 INFO - Running setup.py (path:/tmp/pip-uH0CwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:22 INFO - Running setup.py (path:/tmp/pip-LcY13d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:22 INFO - Running setup.py (path:/tmp/pip-zQ_4hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:22 INFO - Running setup.py install for manifestparser 08:53:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Running setup.py install for mozcrash 08:53:22 INFO - Running setup.py install for mozdebug 08:53:22 INFO - Running setup.py install for mozdevice 08:53:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Running setup.py install for mozfile 08:53:23 INFO - Running setup.py install for mozhttpd 08:53:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozinfo 08:53:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozInstall 08:53:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozleak 08:53:23 INFO - Running setup.py install for mozlog 08:53:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for moznetwork 08:53:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozprocess 08:53:23 INFO - Running setup.py install for mozprofile 08:53:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozrunner 08:53:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozscreenshot 08:53:24 INFO - Running setup.py install for moztest 08:53:24 INFO - Running setup.py install for mozversion 08:53:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:24 INFO - Cleaning up... 08:53:24 INFO - Return code: 0 08:53:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:24 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 0x1a3b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:53:24 INFO - Using env: {'DISPLAY': ':0', 08:53:24 INFO - 'HOME': '/home/cltbld', 08:53:24 INFO - 'LANG': 'en_US.UTF-8', 08:53:24 INFO - 'LANGUAGE': 'en_US:en', 08:53:24 INFO - 'LOGNAME': 'cltbld', 08:53:24 INFO - 'MAIL': '/var/mail/cltbld', 08:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:24 INFO - 'MOZ_NO_REMOTE': '1', 08:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:24 INFO - 'NO_EM_RESTART': '1', 08:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:24 INFO - 'PWD': '/builds/slave/test', 08:53:24 INFO - 'SHELL': '/bin/bash', 08:53:24 INFO - 'SHLVL': '1', 08:53:24 INFO - 'TERM': 'linux', 08:53:24 INFO - 'TMOUT': '86400', 08:53:24 INFO - 'USER': 'cltbld', 08:53:24 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:24 INFO - '_': '/tools/buildbot/bin/python'} 08:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:24 INFO - Running setup.py (path:/tmp/pip-hHifYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:24 INFO - Running setup.py (path:/tmp/pip-TQ1yfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:24 INFO - Running setup.py (path:/tmp/pip-bHscu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:24 INFO - Running setup.py (path:/tmp/pip-bisUQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:24 INFO - Running setup.py (path:/tmp/pip-xAm6wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:24 INFO - Running setup.py (path:/tmp/pip-L9q0KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:24 INFO - Running setup.py (path:/tmp/pip-fFIk_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:25 INFO - Running setup.py (path:/tmp/pip-ggBNYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:25 INFO - Running setup.py (path:/tmp/pip-QRfJJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:25 INFO - Running setup.py (path:/tmp/pip-L8B1Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:25 INFO - Running setup.py (path:/tmp/pip-qFHLJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:25 INFO - Running setup.py (path:/tmp/pip-6cbtnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:25 INFO - Running setup.py (path:/tmp/pip-JLBGwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:25 INFO - Running setup.py (path:/tmp/pip-aXZ24G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:25 INFO - Running setup.py (path:/tmp/pip-r3hHEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:25 INFO - Running setup.py (path:/tmp/pip-jano9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:25 INFO - Running setup.py (path:/tmp/pip-MBUPEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53: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 08:53: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 08:53: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 08:53: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 08:53:26 INFO - Downloading blessings-1.6.tar.gz 08:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:26 INFO - Installing collected packages: blessings 08:53:26 INFO - Running setup.py install for blessings 08:53:27 INFO - Successfully installed blessings 08:53:27 INFO - Cleaning up... 08:53:27 INFO - Return code: 0 08:53:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:27 INFO - Reading from file tmpfile_stdout 08:53:27 INFO - Current package versions: 08:53:27 INFO - argparse == 1.2.1 08:53:27 INFO - blessings == 1.6 08:53:27 INFO - blobuploader == 1.2.4 08:53:27 INFO - docopt == 0.6.1 08:53:27 INFO - functools32 == 3.2.3-2 08:53:27 INFO - jsonschema == 2.5.1 08:53:27 INFO - manifestparser == 1.1 08:53:27 INFO - mozInstall == 1.12 08:53:27 INFO - mozcrash == 1.0 08:53:27 INFO - mozdebug == 0.1 08:53:27 INFO - mozdevice == 0.51 08:53:27 INFO - mozfile == 1.2 08:53:27 INFO - mozhttpd == 0.7 08:53:27 INFO - mozinfo == 0.9 08:53:27 INFO - mozleak == 0.1 08:53:27 INFO - mozlog == 3.4 08:53:27 INFO - moznetwork == 0.27 08:53:27 INFO - mozprocess == 0.25 08:53:27 INFO - mozprofile == 0.28 08:53:27 INFO - mozrunner == 6.13 08:53:27 INFO - mozscreenshot == 0.1 08:53:27 INFO - mozsystemmonitor == 0.3 08:53:27 INFO - moztest == 0.8 08:53:27 INFO - mozversion == 1.4 08:53:27 INFO - psutil == 3.1.1 08:53:27 INFO - requests == 1.2.3 08:53:27 INFO - wsgiref == 0.1.2 08:53:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:27 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 0x1a3b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:53:27 INFO - Using env: {'DISPLAY': ':0', 08:53:27 INFO - 'HOME': '/home/cltbld', 08:53:27 INFO - 'LANG': 'en_US.UTF-8', 08:53:27 INFO - 'LANGUAGE': 'en_US:en', 08:53:27 INFO - 'LOGNAME': 'cltbld', 08:53:27 INFO - 'MAIL': '/var/mail/cltbld', 08:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:27 INFO - 'MOZ_NO_REMOTE': '1', 08:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:27 INFO - 'NO_EM_RESTART': '1', 08:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:27 INFO - 'PWD': '/builds/slave/test', 08:53:27 INFO - 'SHELL': '/bin/bash', 08:53:27 INFO - 'SHLVL': '1', 08:53:27 INFO - 'TERM': 'linux', 08:53:27 INFO - 'TMOUT': '86400', 08:53:27 INFO - 'USER': 'cltbld', 08:53:27 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:27 INFO - '_': '/tools/buildbot/bin/python'} 08:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:53:27 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:53:28 INFO - Installing collected packages: marionette-driver 08:53:28 INFO - Running setup.py install for marionette-driver 08:53:28 INFO - Successfully installed marionette-driver 08:53:28 INFO - Cleaning up... 08:53:28 INFO - Return code: 0 08:53:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:28 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 0x1a3b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:53:28 INFO - Using env: {'DISPLAY': ':0', 08:53:28 INFO - 'HOME': '/home/cltbld', 08:53:28 INFO - 'LANG': 'en_US.UTF-8', 08:53:28 INFO - 'LANGUAGE': 'en_US:en', 08:53:28 INFO - 'LOGNAME': 'cltbld', 08:53:28 INFO - 'MAIL': '/var/mail/cltbld', 08:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:28 INFO - 'MOZ_NO_REMOTE': '1', 08:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:28 INFO - 'NO_EM_RESTART': '1', 08:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:28 INFO - 'PWD': '/builds/slave/test', 08:53:28 INFO - 'SHELL': '/bin/bash', 08:53:28 INFO - 'SHLVL': '1', 08:53:28 INFO - 'TERM': 'linux', 08:53:28 INFO - 'TMOUT': '86400', 08:53:28 INFO - 'USER': 'cltbld', 08:53:28 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:28 INFO - '_': '/tools/buildbot/bin/python'} 08:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:29 INFO - Cleaning up... 08:53:29 INFO - Return code: 0 08:53:29 INFO - Running post-action listener: _resource_record_post_action 08:53:29 INFO - Running post-action listener: _start_resource_monitoring 08:53:29 INFO - Starting resource monitoring. 08:53:29 INFO - [mozharness: 2017-06-02 15:53:29.102181Z] Finished create-virtualenv step (success) 08:53:29 INFO - [mozharness: 2017-06-02 15:53:29.102654Z] Running install step. 08:53:29 INFO - Running pre-action listener: _resource_record_pre_action 08:53:29 INFO - Running main action method: install 08:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:29 INFO - Reading from file tmpfile_stdout 08:53:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:29 INFO - Reading from file tmpfile_stdout 08:53:29 INFO - Output received: 08:53:29 INFO - Usage: mozinstall [options] installer 08:53:29 INFO - Options: 08:53:29 INFO - -h, --help show this help message and exit 08:53:29 INFO - -d DEST, --destination=DEST 08:53:29 INFO - Directory to install application into. [default: 08:53:29 INFO - "/builds/slave/test"] 08:53:29 INFO - --app=APP Application being installed. [default: firefox] 08:53:29 INFO - mkdir: /builds/slave/test/build/application 08:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:53:46 INFO - Reading from file tmpfile_stdout 08:53:46 INFO - Output received: 08:53:46 INFO - /builds/slave/test/build/application/firefox/firefox 08:53:46 INFO - Running post-action listener: _resource_record_post_action 08:53:46 INFO - [mozharness: 2017-06-02 15:53:46.857962Z] Finished install step (success) 08:53:46 INFO - [mozharness: 2017-06-02 15:53:46.858214Z] Running setup-mitmproxy step. 08:53:46 INFO - Running pre-action listener: _resource_record_pre_action 08:53:46 INFO - Running main action method: setup_mitmproxy 08:53:46 INFO - Skipping: mitmproxy is not required 08:53:46 INFO - Running post-action listener: _resource_record_post_action 08:53:46 INFO - [mozharness: 2017-06-02 15:53:46.859393Z] Finished setup-mitmproxy step (success) 08:53:46 INFO - [mozharness: 2017-06-02 15:53:46.859615Z] Running run-tests step. 08:53:46 INFO - Running pre-action listener: _resource_record_pre_action 08:53:46 INFO - Running main action method: run_tests 08:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:53:46 INFO - Python 2.7.3 08:53:46 INFO - Return code: 0 08:53:46 INFO - grabbing minidump binary from tooltool 08:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:46 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 0x1db6840>, '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 0x1db7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db7bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:53:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:53:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:53:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:53:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:53:46 INFO - Return code: 0 08:53:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:53:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:53:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:53:46 INFO - ENV: RUST_BACKTRACE is now 1 08:53:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:53:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-074 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:53:46 INFO - Using env: {'DISPLAY': ':0', 08:53:46 INFO - 'HOME': '/home/cltbld', 08:53:46 INFO - 'LANG': 'en_US.UTF-8', 08:53:46 INFO - 'LANGUAGE': 'en_US:en', 08:53:46 INFO - 'LOGNAME': 'cltbld', 08:53:46 INFO - 'MAIL': '/var/mail/cltbld', 08:53:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:53:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:46 INFO - 'MOZ_NO_REMOTE': '1', 08:53:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:46 INFO - 'NO_EM_RESTART': '1', 08:53:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:46 INFO - 'PWD': '/builds/slave/test', 08:53:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:53:46 INFO - 'RUST_BACKTRACE': '1', 08:53:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:53:46 INFO - 'SHELL': '/bin/bash', 08:53:46 INFO - 'SHLVL': '1', 08:53:46 INFO - 'TERM': 'linux', 08:53:46 INFO - 'TMOUT': '86400', 08:53:46 INFO - 'USER': 'cltbld', 08:53:46 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589', 08:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:46 INFO - '_': '/tools/buildbot/bin/python'} 08:53:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:53:47 INFO - mozversion application_buildid: 20170602151012 08:53:47 INFO - mozversion application_changeset: 95d2d23ff510bea680e9707c1ec166b0cc08dc6b 08:53:47 INFO - mozversion application_display_name: Nightly 08:53:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:53:47 INFO - mozversion application_name: Firefox 08:53:47 INFO - mozversion application_remotingname: firefox 08:53:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:53:47 INFO - mozversion application_vendor: Mozilla 08:53:47 INFO - mozversion application_version: 55.0a1 08:53:47 INFO - mozversion platform_buildid: 20170602151012 08:53:47 INFO - mozversion platform_changeset: 95d2d23ff510bea680e9707c1ec166b0cc08dc6b 08:53:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:53:47 INFO - mozversion platform_version: 55.0a1 08:53:47 INFO - using testdate: 1496418827 08:53:47 INFO - actual date: 1496418827 08:53:47 INFO - starting webserver on 'localhost:41474' 08:53:47 INFO - SUITE-START | Running 2 tests 08:53:47 INFO - TEST-START | dromaeo_css 08:53:47 INFO - operating with platform_type : linux_ 08:53:47 INFO - Initialising browser for dromaeo_css test... 08:53:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41474/getInfo.html -profile /tmp/tmpuDoBZ2/profile 08:53:47 INFO - TEST-INFO | started process 15934 (/builds/slave/test/build/application/firefox/firefox http://localhost:41474/getInfo.html) 08:54:22 INFO - TEST-INFO | 15934: killed by SIGTERM 08:54:22 INFO - Browser initialized. 08:54:22 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:22 INFO - TEST-INFO | started process 16164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuDoBZ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:34 INFO - PID 16164 | RSS: Main: 192696320 08:54:34 INFO - PID 16164 | 08:57:35 INFO - PID 16164 | Cycle 1(1): loaded http://localhost:41474/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41474/tests/dromaeo/cssquery-ext.html) 08:57:36 INFO - PID 16164 | RSS: Main: 187801600 08:57:36 INFO - PID 16164 | 09:00:38 INFO - PID 16164 | Cycle 1(1): loaded http://localhost:41474/tests/dromaeo/cssquery-ext.html (next: http://localhost:41474/tests/dromaeo/cssquery-jquery.html) 09:00:39 INFO - PID 16164 | RSS: Main: 194318336 09:00:39 INFO - PID 16164 | 09:03:41 INFO - PID 16164 | Cycle 1(1): loaded http://localhost:41474/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41474/tests/dromaeo/cssquery-mootools.html) 09:03:41 INFO - PID 16164 | RSS: Main: 190013440 09:03:41 INFO - PID 16164 | 09:06:43 INFO - PID 16164 | Cycle 1(1): loaded http://localhost:41474/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41474/tests/dromaeo/cssquery-prototype.html) 09:06:44 INFO - PID 16164 | RSS: Main: 193761280 09:06:44 INFO - PID 16164 | 09:09:46 INFO - PID 16164 | Cycle 1(1): loaded http://localhost:41474/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41474/tests/dromaeo/cssquery-yui.html) 09:09:47 INFO - PID 16164 | RSS: Main: 194637824 09:09:47 INFO - PID 16164 | 09:12:49 INFO - PID 16164 | Cycle 1(1): loaded http://localhost:41474/tests/dromaeo/cssquery-yui.html (next: http://localhost:41474/tests/dromaeo/cssquery-dojo.html) 09:12:49 INFO - PID 16164 | RSS: Main: 194088960 09:12:49 INFO - PID 16164 | 09:12:49 INFO - PID 16164 | __start_tp_report 09:12:49 INFO - PID 16164 | _x_x_mozilla_page_load 09:12:49 INFO - PID 16164 | _x_x_mozilla_page_load_details 09:12:49 INFO - PID 16164 | |i|pagename|runs| 09:12:49 INFO - PID 16164 | |0;dojo.html;3092.6752690967446;3097.16376578324;3110.191350248936;3130.295683471219;3131.5928929239194;5713.285839270091;5731.14032895066;5754.769809207632;5769.884602307962;5788.50797682197;5724.22722932404;5741.741621627027;5783.045797443428;5791.478766910977;5807.41925807419;5287.656302340355;5397.136458166694;5405.918911216335;5414.4314846941;5430.212619170218;5235.502627250424;5394.406615272336;5402.405735369106;5423.05096608092;5426.593005524582;5353.9196912046355;5434.375046869621;5445.401005889349;5486.149646804752;5490.149026900816;5311.468853114697;5330.733463326818;5363.570914326844;5367.382750983647;5372.758225879806;5353.785848566053;5358.785648574052;5404.972975135139;5416.620836541444;5420.972895135538;5780.624259423124;5796.3913789052385;5798.3911689272445;5804.680742559158;5827.883442331172;6105.2474731169705;6303.590266632654;6312.684365781693;6330.873382532323;6339.429451349401;6251.218597675291;6280.995040793451;6347.619142851444;6354.968225158891;6361.395667411589;5789.363170051291;5793.681347525884;5797.391273916262;5805.767769289266;5854.941450585482;6340.904886426707;6385.96807015962;6394.744210231632;6399.7440102395385;6401.551891367652;6035.818925432244;6109.236345456818;6140.785072522441;6156.168917196122;6165.10605962133;6264.780732674334;6277.905831412532;6287.402696743802;6293.590916590407;6293.685315734287;6263.906041409383;6268.153799237136;6273.247210334698;6281.7173227204885;6282.717277722513;6115.755369785248;6152.723127459275;6182.474489668429;6294.024426213944;6294.307626161119;5175.560077393388;5188.766505507186;5217.452167522431;5232.73836308183;5253.290805741252;4375.124975005012;4443.644508439382;4456.286994080931;4517.164324599959;4563.680542362069;5455.699936503451;5495.450454954553;5498.560115190775;5511.448855114457;5557.722113894289;6191.318954914956;6206.72069756862;6235.844103897439;6243.625382477066;6254.249490061222;5554.416786237468;5566.137248726453;5569.415211402745;5584.162375643686;5624.3813180550105;5654.886902261932;5665.433456654384;5671;5671.716414179275;5671.773129074791;5995.2206213192;6018.638881667026;6076.605020673642;6077.118817771487;6090.695465226632;6270.216222972129;6271.498280137669;6339.270983836917;6342.778002769881;6346.333634968447;6091.634501929721;6104.969475152596;6139.829471381233;6214.40963108504;6227.346128656607;6108.342071131425;6109.708332504907;6125.05232106189;6126.761967422209;6175.351588083367;6318.842028949313;6321.020241862519;6332.0818481320875;6332.651704156131;6367.07677386767;6066.241719785027;6069.848253793691;6074.878502430015;6075.453209211192;6083.847903802441;5932.79235226765;6016.729247183975;6056.9697151513965;6101.60339577926;6107.267127944675;5841.591088623755;6071.362506936708;6079.969600151971;6080.969595152173;6129.325774164928;6168.414000669929;6170.660613666291;6174.753009879554;6176.3514830943905;6197.845053873689;5622.9156562652415;5696.832149409444;5879.647221166743;5998.1002849572915;6004.849878753066 09:12:49 INFO - PID 16164 | |1;ext.html;711.9466040046998;751.3238085722849;773.7021246819975;1134.1437214902746;1147.237087336921;35435;36158.63841361589;36267;36286.637133628654;36323.81838090806;37453.250934981355;37547;37861.81069094658;37902.86291411255;37929.24141517168;7147.106611673541;7285.56286622803;7294.343509084181;7376.631168441583;7399;7198.8200294992785;7311.086114235721;7312.451566132535;7319.158296795883;7336.303051210127;7312.890306645405;7337.926620733778;7368.8894666580045;7397.297256760599;7408.296211859864;7305.452091093162;7348.559086454829;7349.522281051714;7388.815279617998;7393.852122957537;7177.7487787927175;7260.165081015698;7271.200167981518;7274.709011639528;7291.234420385889;34650.306993860235;34810.82594587011;34901.12747181315;34931.4760278596;34977.47533786995;3397.524346591479;3412.385770561298;3420.162060295219;3432.63957284484;3451.706604938583;27688;27817.304567385978;27911.58132628012;27914.581281280796;28023.159305220877;3614.9096272593133;3685.3919103347916;3690.612485688991;3702.648248416396;3717.5353080864893;133622;139042;140767.99999999898;162898;164301;41049;41088;41341.1731765363;41411.7929410357;41460;43524.56475435205;43614.34578481325;43703.56296436995;43732;43745.87557741919;14422.06256593318;14437.278136093153;14499.492517761828;14504.34730437133;14566.927165364317;11966.64100076999;11988.160828741904;11998.760024799456;12002.699932501757;12035.699107522207;13291.069625126149;13312.334383280797;13343.26612036328;13343.73312533744;13556.16991706107;5430.83707488776;5533.861653458695;5552.333719953551;5597.74810133545;5634.32388113429;965.7778710896392;1000.6197644894893;1006.0392325329293;1012.6708819633649;1028.3521381529588;22242.332730018126;23155.536889262457;23194.53610927806;23319.41701457477;23386.53226935486;1093.3767752381066;1094.3324572011068;1099.4118146791589;1116.3246236027087;1119.205364191417;11952.342621155745;12190.329531875655;12262.938685306517;12370.75258494825;12433;187611.0619446894;189591;189843;189952;190360;46706.299405508944;46784;46921.29618055732;46942.765286174035;47010.294845577344;1378.3797291218991;1438.7338342406688;1446.197360464952;1461.0795199024546;1463.0928824129107;21596.892015539823;21844.45388865291;22826.201082962016;22895.42761430911;23058.769412306334;34328.14179645529;34507.13732156716;34558.13604659803;34598.65401345954;34636;170727;172004;172308;172615;172972;24708.752912470645;25171.748282517674;26853.462930740887;30502.389952201276;30773.46132693401;33560.1609959753;33759.66240337565;34010.65989340075;34432;34465.48301775425;25917.22248332553;26253.34366640849;26392.07627733097;26717.8664106686;27234.455310894067;25192.24423267305;25272.368190795376;25978.74021259839;27162.72837271602;27238.182854514398;28538.57192142078;28645.14064578066;28779.712202877705;28957.85521072381;29167.416651667274;25519.87240063788;25755.356116097246;25850;26365.472690546467;26623.86688066547;20536.794632053487;21383;21461.24885629058;21490.24784132548;21512.677309840677 09:12:49 INFO - PID 16164 | |2;jquery.html;420.1890351621373;420.6311392173566;428.6035417239053;443.571953065292;447.2553198923792;19375.32186373477;20174.798252017474;20245.088970996305;22165.667514987246;23043.654345184837;22816.543669126608;23190.188343407983;23250.88374558129;23255;23257.185998490055;5950.404959504048;6049.788257410992;6092.390760923917;6093.299270583895;6094.512439004869;6017.488513476338;6031.6984150792505;6037.30570984338;6070.514358851281;6075.605085669439;5812.796552120677;5902.940970590282;5929.733162007698;5947.22686050815;5956.970215148918;5880.911786323209;5881.588288819784;5919.911201331984;5934.821955341346;5940.108983652465;5301.1783173608155;5308.70802105884;5316.707581083039;5336.092864213093;5342.679439233659;25562.744372556223;25698.22905312825;25824.87087564569;25861.35346616331;25881.22356329313;1854.1841589700623;1931.9903400482908;1943.1935746665117;1943.6782987568447;1945.1830231302886;17246.22391992351;17440.389586364417;17454.912725436418;17513.912430437893;17585.56036099095;2206.282958038628;2224.4327696437467;2261.208576998054;2274.294968559735;2277.7266727992583;100286.49856750743;106341;112022;112755.43622281917;119690.4015479917;11583.305001699924;11878.46546905374;12010.759784804255;12027.579034733742;12071.215371000857;16786.496405107868;16974.405895793836;17024.319027238773;17052.829471705372;17083.658326833644;8725.825483490422;9022.188003079755;9035.45787252767;9039.864402033974;9077.364584479155;8560.529170895661;8650.697225597074;8684.478931264144;8769.991450983218;8866.556672166365;7528.924710752932;7754.728584499516;7897.131315555284;7909.1299957004685;7915.12933577306;2102.327255278327;2106.6945292932746;2108.8734675919495;2136.1135128921633;2265.750767415583;943.3255222515934;987.8172538080478;992.0773680477081;997.3616885193481;1018.6231094495084;19240.23039078421;20184.798152018586;20228.494287642927;20616.175352985712;20665.79334206669;981.097390400833;993.7664648807524;1004.3070281505737;1009.4044513736784;1030.0935177044303;10078.59685612582;11143.609973650884;12380.504779808887;13723.862761372458;13769.862301377058;440897;443571;444667;446609;453889;100916;102387;102521;103998.48000759947;104854;1153.4521102476256;1209.6008317255285;1240.7394447166196;1243.6144795113362;1248.806435002576;20050.799492004895;20064.69902951486;20810.167593296705;20852;20852.37442876716;48044.759776200895;48554.27168592403;49136.75431622819;49552.256716150005;50129.498705012484;60589;60702.39297606968;60800.391996079474;60801.69599152153;60915.69542152261;10158.13655839262;10197.59209631636;10557.99699028591;10600.204984626029;10648.680539583826;17137.314507420062;17585.912070439565;17827.73258401099;17863.196156173264;17953.820461795214;14527.564173074825;14626.780598290821;14877.628059298171;14910.32903519366;15097.622559436102;12768.6807829805;13361.732765344444;13524.59426217215;14436.278186090864;14447.78328325055;13444.39500222512;15319.846801531841;15475.226238688245;15510.22448877529;15523.922380388025;10189.898101018895;10193.541290641791;10331.638392656221;10430.16558675289;10483.108935740547;13850.515231966832;13852.861471385157;13964;13975.650608734863;14067.296635168404 09:12:49 INFO - PID 16164 | |3;mootools.html;1278.1564167649353;1352.7700290950538;1363.659085228693;1369.6781256404743;1383.806267122603;10513.526891289892;10600;10731.034206921375;11135.665930022093;11179.273347232423;10855.565777368916;11245.212835101545;11258.718532036683;11295.717607059827;11296.039836613878;2335.1126571902696;2385.2128797496785;2385.5348207099623;2385.546746118232;2392.1507864708037;2248.516568937678;2260.864348139117;2348.248560460653;2353.0587764894008;2357.1043003658588;2342.590046741822;2344.742078371378;2375.2280508834697;2378.988105059472;2382.0828980842416;2305.0318866076373;2310.0297874892503;2310.145246258878;2316.073570571776;2317.316391664463;2258.3450799268194;2266.3994041578994;2287.885605719724;2291.988540057289;2304.4238940264936;10580.15358771304;10656.09423199029;10683.626073087482;10692.091172250368;10702.357858528514;6034.788782392639;6225.470834979033;6253.062040693887;6255.06174073888;6258.3428739982555;3775.452559378875;3825.5409350877794;3867.505458978971;3928.685705143582;3941.881743547698;1233.4018001269378;1261.482792055253;1277.5337001994299;1283.146707439561;1290.8450985881661;14419.279036048261;14964.925175374163;15132.394704211929;15555.377784888591;15569.922150389175;5428.267183930119;5441.564674826004;5648.49163575272;5676.233708449389;5683.886322273532;13816.309184540733;13831.239281839395;13835.584932452042;13885.166889986633;13887.861121388858;6148.723307451175;6281.089242059876;6297.748090076346;6300.180976473121;6304.558680892385;5671.432856714378;5723.198752174699;5749.223854779635;5759.625624334489;5799.739011744482;4423.469183697976;4427.535108813592;4526.7510286933875;4540.205464043779;4567.451905771262;1349.4737052549513;1409.584172669065;1414.5473448496589;1427.586000059971;1432.7564314066633;804.927556519916;825.4222044568826;838.362844238371;849.5454931611558;869.8434281829205;5963.5527335450015;5969.940300597025;5991.670458124758;6082.452579267887;6146.262448506119;592.0970519957013;603.1856993059334;606.7027156693189;612.7579606055583;617.305531277313;3678.264347130531;4279.850205242801;4467.508574056851;4507.616852567503;4578.908421831545;13462.057655963989;13941.581752547238;14222;14275.14349139055;14283.42866285337;13945.790813137812;14190.077644953046;14214.644633884029;14247.287635618384;14378.784318235235;8360.790980225544;8917.509536975398;8921.330900182513;8944.642214311354;9002.819943601222;6864.897026544706;6952.85277929136;7165.498415110892;7168.068151140318;7193.496455248082;12229.266244025386;12553;12634;12677.429515672002;12707.428165732748;12759.87240127624;12765.93617031909;12781.233126012468;12904.8064279034;13005.739885202433;9278.675246366345;9317.487538185194;9389.154976052188;9437.669681561387;9488.146066854017;10393.116585090049;10415.427151506437;10487.737806554896;10564.894351056699;10573.52419141156;8147.14454982242;8395.286400656012;8439.831203376021;8475.067742548437;8614.353923455641;8412.663493460193;8592.742217733228;8653.69712060075;8683.86974195375;8843.51360675169;7530.531546348629;7653.272939070779;7667.079950405987;7705.845883082195;7708.113566939874;5506.972465137648;5546.417626149197;5625.156226566048;5671.064274394678;5774.56690748204;5616.803411880564;5622.269105016322;5667.858303542444;5719.399463056319;5761.423857614205 09:12:49 INFO - PID 16164 | |4;prototype.html;393.77554793767547;401.5963956223994;402.9858954936576;405.90055436418083;415.5429028069124;6018.578699491038;6181.227346581677;6190.709437508128;6233.06504024396;6238.5321100917445;5903.970480147594;5992.3108842483125;6029.216201893748;6031.969840150793;6037.882991646548;4729.337892695025;4732.597729193023;4750.809967601292;4769.642276829243;4778.784954677048;4621.930671039937;4766.952330476703;4775.737334446621;4776.641751868607;4802.087603355369;4723.952760472403;4728.574428301452;4730.739809310487;4733.857984260478;4745.359376484183;4676.924307409298;4691.926787953896;4705.905881882378;4717.221658426355;4753.809847606091;4152.314868046798;4154.750714957112;4158.189153115144;4162.876023473646;4170.91658166838;5952.7023648817385;5960.850978725523;5961;5967.283925928917;5982.102684597346;5402.8109016184635;5413.133898576249;5414.296141501619;5428.240046393508;5432.239486471857;6340.714667839959;6373.203349581302;6405.5516113872045;6450.838729031811;6454.741810327581;4515.729056256635;4547.954520454786;4554.521775213588;4555.2711566149255;4557.065801510682;6460.773872914426;6532;6682.632455214961;6752;6874.793756187272;4564.452265728068;4581.518940511265;4594.563516465931;4601.930971035437;4607.585317321457;4647.16351056813;4648.302754586839;4649.744264065509;4650.325702773079;4674.415698037746;5352.411234764173;5355.875975498922;5359.732013399393;5373;5375.811846585429;6382.585131966407;6384.32964538726;6425.871482570323;6439.388258115471;6440.935590644033;1623.4480276705976;1637.983620163807;1638.5248277999247;1640.4176517336412;1641.2860405723548;1037.1547189040907;1089.362722807151;1094.124700239805;1110.0897264243242;1112.4215407987963;5720.1991721159075;5730.484256416859;5741.732015853714;5790.36306006339;5800.564957628195;6576.5067619928695;6601.6234155703905;6612.86774264512;6614.570052946639;6621.172353455818;5711.200431939532;5731.455511726379;5733.254676891977;5738.885222295531;5784.479396854304;3510.5962814276686;3523.295340931824;3542.8051457170104;3545.7340699447645;3549.290141971616;6550.2794692583775;6563.671816409161;6569.540132190797;6591.571547849375;6615.239247486505;6769.120014398097;6786.796396108125;6789.083473730983;6826.180858296937;6836;6498.108341787954;6516.446102081376;6530.2816690164045;6537.182852143482;6538.574992625464;6621.205455345389;6627.834304142435;6642.83392915181;6647.235567909559;6671.599704017581;6481.351864813481;6496;6574.638394888327;6589.24223714279;6606.669666516751;6019.247594050744;6451.483881289391;6510.73957041713;6534.803955881332;6612.660606393741;4580.519045500175;4592.196365636067;4596.793144308581;4605.746683932416;4627.652926030494;6362.395572420613;6592.373724496165;6629.585763331985;6668.699298741926;6698.866022679422;6378.947473666979;6395.456386207225;6408.327125651739;6408.878446271977;6420.903686444613;6380.553361264667;6385.616862988236;6429.688710314098;6451.806445806634;6464.5798023128345;6347.238331400262;6368.172137622265;6374.139491168633;6380.234371875405;6397.936020639734;6442.516811239082;6477.578957367756;6506.739730410731;6518.185226846645;6533.705983230671;6200.193974783429;6280;6283.37166283368;6313.842153946188;6325.462335701332 09:12:49 INFO - PID 16164 | |5;yui.html;747.3908764357049;755.803491092316;779.2830595851816;799.0970203669852;831.7878940870081;16242.35030598776;16634.417795377165;16656.25046872889;16710.498685039438;17482.912585437087;18759.155837987288;18866.622667546642;19134.234630614792;19150.712739308885;19185.520361990923;915.9908400915989;940.8071345374182;941.90110038446;942.5334459442586;945.399671208784;907.9818403631923;996.7657600463886;1002.3885429887799;1011.4234886114881;1013.1692012549712;1045.7490202351419;1046.7697106636529;1048.7430579507993;1050.144132531988;1051.0225490294024;1035.6271742172812;1037.8806437259698;1042.0413219837767;1043.1237760281324;1046.0794500839213;766.5094339622646;767.7351313796731;769.8806684963839;770.9074911010658;771.4175797273023;16107.597310067225;16807.32770689171;17051.74422383653;17072.48782536526;17177.31290748381;18270;18387.908060459748;18566.35017774385;18721.251149953987;18802.717959230624;15237.542873713695;15509.612259693598;15569.455069072641;15587.454439094578;15590.922045389814;3357.647447018077;3428.3828910796046;3461.152017755666;3464.272502774395;3485.3900567400606;86970.56514717385;88592.55703721504;89478;89511.55244223803;89538.55230723805;14424.350904209336;14676.266186690622;14775.187364695044;14818.777718334233;14857.10857348541;26361.73638263631;26768.464630707665;27179.184624461297;27258.5911211332;27551.44897102047;7697.153313135551;7988.6804527819395;8423.368247381472;8443.324534037261;8452.915470845335;3961.4057891316534;4084.9387259191135;4087.693422993287;4090;4095.7337773044655;3866.516685414323;3950.051987523031;3963.742356746802;3975.7018223633345;4265.253580623378;858.9012263589642;859.9312055035582;869.443556124081;872.0843114729508;872.5637181409295;653.2552889705739;688.1157712339619;689.1557841644046;690.413148823506;694.035290945586;10384.948075259575;11735.471903764352;11835.585754498552;12042;12780.552680656132;678.0744284052332;684.428502200658;688.9276625954203;698.3435570563654;716.373173473211;5163.845084647466;5427.864303392368;5434.456554344534;5472.2338872557875;5696.544276457874;87660.56169719239;88049;88837;89816;92529.53735231281;74483;75314;75457.24542754501;77798;78596.60701696455;70869.64565177141;71906.76419561132;72006.63996679983;72520.99999999894;73080.26919730841;9998.400095994264;10264.589699634555;10514.107460656849;10604.522796474022;10955.17836162307;29037.7096229035;30246.697533024388;30287.697123028487;30454.847725762116;31582.36835263328;37169.25661486701;37629.81185094057;37692.246155076195;37829.81085094557;38593.614063859;15197.544073677807;15471.071735695445;15489;15569.455069072528;15688.215589220721;18229;19622.313219037263;19977.500562486053;20407.18371265192;20407.387778366672;17010.744838827675;17022.57443563921;17097;17238.741418878977;17612;14453.710925781636;14522.128672279698;14585.92707036458;17147.399841005506;17466.650666986843;15108.093514389171;15318.387264509294;15336.769948451005;15568.688626227638;15757.606059848595;12467.314297713712;12518;12551.3096779678;12700;12708.682282943;13456.86543134556;13830.861691382957;14041;14377.928110359382;14421 09:12:49 INFO - PID 16164 | __end_tp_report 09:12:49 INFO - PID 16164 | __start_cc_report 09:12:49 INFO - PID 16164 | _x_x_mozilla_cycle_collect,374 09:12:49 INFO - PID 16164 | __end_cc_report 09:12:49 INFO - PID 16164 | __startTimestamp1496419969710__endTimestamp 09:12:49 INFO - PID 16164 | 09:12:49 INFO - PID 16164 | ------- Summary: start ------- 09:12:49 INFO - PID 16164 | Number of tests: 6 09:12:49 INFO - PID 16164 | 09:12:49 INFO - PID 16164 | [#0] dojo.html Cycles:165 Average:5784.24 Median:6004.85 stddev:637.97 (10.6%) stddev-sans-first:603.98 09:12:49 INFO - PID 16164 | Values: 3092.7 3097.2 3110.2 3130.3 3131.6 5713.3 5731.1 5754.8 5769.9 5788.5 5724.2 5741.7 5783.0 5791.5 5807.4 5287.7 5397.1 5405.9 5414.4 5430.2 5235.5 5394.4 5402.4 5423.1 5426.6 5353.9 5434.4 5445.4 5486.1 5490.1 5311.5 5330.7 5363.6 5367.4 5372.8 5353.8 5358.8 5405.0 5416.6 5421.0 5780.6 5796.4 5798.4 5804.7 5827.9 6105.2 6303.6 6312.7 6330.9 6339.4 6251.2 6281.0 6347.6 6355.0 6361.4 5789.4 5793.7 5797.4 5805.8 5854.9 6340.9 6386.0 6394.7 6399.7 6401.6 6035.8 6109.2 6140.8 6156.2 6165.1 6264.8 6277.9 6287.4 6293.6 6293.7 6263.9 6268.2 6273.2 6281.7 6282.7 6115.8 6152.7 6182.5 6294.0 6294.3 5175.6 5188.8 5217.5 5232.7 5253.3 4375.1 4443.6 4456.3 4517.2 4563.7 5455.7 5495.5 5498.6 5511.4 5557.7 6191.3 6206.7 6235.8 6243.6 6254.2 5554.4 5566.1 5569.4 5584.2 5624.4 5654.9 5665.4 5671.0 5671.7 5671.8 5995.2 6018.6 6076.6 6077.1 6090.7 6270.2 6271.5 6339.3 6342.8 6346.3 6091.6 6105.0 6139.8 6214.4 6227.3 6108.3 6109.7 6125.1 6126.8 6175.4 6318.8 6321.0 6332.1 6332.7 6367.1 6066.2 6069.8 6074.9 6075.5 6083.8 5932.8 6016.7 6057.0 6101.6 6107.3 5841.6 6071.4 6080.0 6081.0 6129.3 6168.4 6170.7 6174.8 6176.4 6197.8 5622.9 5696.8 5879.6 5998.1 6004.8 09:12:49 INFO - PID 16164 | 09:12:49 INFO - PID 16164 | [#1] ext.html Cycles:180 Average:32064.63 Median:28712.43 stddev:44112.39 (153.6%) stddev-sans-first:44173.32 09:12:49 INFO - PID 16164 | Values: 711.9 751.3 773.7 1134.1 1147.2 35435.0 36158.6 36267.0 36286.6 36323.8 37453.3 37547.0 37861.8 37902.9 37929.2 7147.1 7285.6 7294.3 7376.6 7399.0 7198.8 7311.1 7312.5 7319.2 7336.3 7312.9 7337.9 7368.9 7397.3 7408.3 7305.5 7348.6 7349.5 7388.8 7393.9 7177.7 7260.2 7271.2 7274.7 7291.2 34650.3 34810.8 34901.1 34931.5 34977.5 3397.5 3412.4 3420.2 3432.6 3451.7 27688.0 27817.3 27911.6 27914.6 28023.2 3614.9 3685.4 3690.6 3702.6 3717.5 133622.0 139042.0 140768.0 162898.0 164301.0 41049.0 41088.0 41341.2 41411.8 41460.0 43524.6 43614.3 43703.6 43732.0 43745.9 14422.1 14437.3 14499.5 14504.3 14566.9 11966.6 11988.2 11998.8 12002.7 12035.7 13291.1 13312.3 13343.3 13343.7 13556.2 5430.8 5533.9 5552.3 5597.7 5634.3 965.8 1000.6 1006.0 1012.7 1028.4 22242.3 23155.5 23194.5 23319.4 23386.5 1093.4 1094.3 1099.4 1116.3 1119.2 11952.3 12190.3 12262.9 12370.8 12433.0 187611.1 189591.0 189843.0 189952.0 190360.0 46706.3 46784.0 46921.3 46942.8 47010.3 1378.4 1438.7 1446.2 1461.1 1463.1 21596.9 21844.5 22826.2 22895.4 23058.8 34328.1 34507.1 34558.1 34598.7 34636.0 170727.0 172004.0 172308.0 172615.0 172972.0 24708.8 25171.7 26853.5 30502.4 30773.5 33560.2 33759.7 34010.7 34432.0 34465.5 25917.2 26253.3 26392.1 26717.9 27234.5 25192.2 25272.4 25978.7 27162.7 27238.2 28538.6 28645.1 28779.7 28957.9 29167.4 25519.9 25755.4 25850.0 26365.5 26623.9 20536.8 21383.0 21461.2 21490.2 21512.7 09:12:49 INFO - PID 16164 | 09:12:49 INFO - PID 16164 | [#2] jquery.html Cycles:180 Average:30521.18 Median:20852.19 stddev:74621.20 (357.9%) stddev-sans-first:74796.31 09:12:49 INFO - PID 16164 | Values: 420.2 420.6 428.6 443.6 447.3 19375.3 20174.8 20245.1 22165.7 23043.7 22816.5 23190.2 23250.9 23255.0 23257.2 5950.4 6049.8 6092.4 6093.3 6094.5 6017.5 6031.7 6037.3 6070.5 6075.6 5812.8 5902.9 5929.7 5947.2 5957.0 5880.9 5881.6 5919.9 5934.8 5940.1 5301.2 5308.7 5316.7 5336.1 5342.7 25562.7 25698.2 25824.9 25861.4 25881.2 1854.2 1932.0 1943.2 1943.7 1945.2 17246.2 17440.4 17454.9 17513.9 17585.6 2206.3 2224.4 2261.2 2274.3 2277.7 100286.5 106341.0 112022.0 112755.4 119690.4 11583.3 11878.5 12010.8 12027.6 12071.2 16786.5 16974.4 17024.3 17052.8 17083.7 8725.8 9022.2 9035.5 9039.9 9077.4 8560.5 8650.7 8684.5 8770.0 8866.6 7528.9 7754.7 7897.1 7909.1 7915.1 2102.3 2106.7 2108.9 2136.1 2265.8 943.3 987.8 992.1 997.4 1018.6 19240.2 20184.8 20228.5 20616.2 20665.8 981.1 993.8 1004.3 1009.4 1030.1 10078.6 11143.6 12380.5 13723.9 13769.9 440897.0 443571.0 444667.0 446609.0 453889.0 100916.0 102387.0 102521.0 103998.5 104854.0 1153.5 1209.6 1240.7 1243.6 1248.8 20050.8 20064.7 20810.2 20852.0 20852.4 48044.8 48554.3 49136.8 49552.3 50129.5 60589.0 60702.4 60800.4 60801.7 60915.7 10158.1 10197.6 10558.0 10600.2 10648.7 17137.3 17585.9 17827.7 17863.2 17953.8 14527.6 14626.8 14877.6 14910.3 15097.6 12768.7 13361.7 13524.6 14436.3 14447.8 13444.4 15319.8 15475.2 15510.2 15523.9 10189.9 10193.5 10331.6 10430.2 10483.1 13850.5 13852.9 13964.0 13975.7 14067.3 09:12:49 INFO - PID 16164 | 09:12:49 INFO - PID 16164 | [#3] mootools.html Cycles:180 Average:6852.21 Median:3726.86 stddev:4319.49 (115.9%) stddev-sans-first:4311.29 09:12:49 INFO - PID 16164 | Values: 1278.2 1352.8 1363.7 1369.7 1383.8 10513.5 10600.0 10731.0 11135.7 11179.3 10855.6 11245.2 11258.7 11295.7 11296.0 2335.1 2385.2 2385.5 2385.5 2392.2 2248.5 2260.9 2348.2 2353.1 2357.1 2342.6 2344.7 2375.2 2379.0 2382.1 2305.0 2310.0 2310.1 2316.1 2317.3 2258.3 2266.4 2287.9 2292.0 2304.4 10580.2 10656.1 10683.6 10692.1 10702.4 6034.8 6225.5 6253.1 6255.1 6258.3 3775.5 3825.5 3867.5 3928.7 3941.9 1233.4 1261.5 1277.5 1283.1 1290.8 14419.3 14964.9 15132.4 15555.4 15569.9 5428.3 5441.6 5648.5 5676.2 5683.9 13816.3 13831.2 13835.6 13885.2 13887.9 6148.7 6281.1 6297.7 6300.2 6304.6 5671.4 5723.2 5749.2 5759.6 5799.7 4423.5 4427.5 4526.8 4540.2 4567.5 1349.5 1409.6 1414.5 1427.6 1432.8 804.9 825.4 838.4 849.5 869.8 5963.6 5969.9 5991.7 6082.5 6146.3 592.1 603.2 606.7 612.8 617.3 3678.3 4279.9 4467.5 4507.6 4578.9 13462.1 13941.6 14222.0 14275.1 14283.4 13945.8 14190.1 14214.6 14247.3 14378.8 8360.8 8917.5 8921.3 8944.6 9002.8 6864.9 6952.9 7165.5 7168.1 7193.5 12229.3 12553.0 12634.0 12677.4 12707.4 12759.9 12765.9 12781.2 12904.8 13005.7 9278.7 9317.5 9389.2 9437.7 9488.1 10393.1 10415.4 10487.7 10564.9 10573.5 8147.1 8395.3 8439.8 8475.1 8614.4 8412.7 8592.7 8653.7 8683.9 8843.5 7530.5 7653.3 7667.1 7705.8 7708.1 5507.0 5546.4 5625.2 5671.1 5774.6 5616.8 5622.3 5667.9 5719.4 5761.4 09:12:49 INFO - PID 16164 | 09:12:49 INFO - PID 16164 | [#4] prototype.html Cycles:180 Average:5353.96 Median:5987.21 stddev:1573.50 (26.3%) stddev-sans-first:1533.24 09:12:49 INFO - PID 16164 | Values: 393.8 401.6 403.0 405.9 415.5 6018.6 6181.2 6190.7 6233.1 6238.5 5904.0 5992.3 6029.2 6032.0 6037.9 4729.3 4732.6 4750.8 4769.6 4778.8 4621.9 4767.0 4775.7 4776.6 4802.1 4724.0 4728.6 4730.7 4733.9 4745.4 4676.9 4691.9 4705.9 4717.2 4753.8 4152.3 4154.8 4158.2 4162.9 4170.9 5952.7 5960.9 5961.0 5967.3 5982.1 5402.8 5413.1 5414.3 5428.2 5432.2 6340.7 6373.2 6405.6 6450.8 6454.7 4515.7 4548.0 4554.5 4555.3 4557.1 6460.8 6532.0 6682.6 6752.0 6874.8 4564.5 4581.5 4594.6 4601.9 4607.6 4647.2 4648.3 4649.7 4650.3 4674.4 5352.4 5355.9 5359.7 5373.0 5375.8 6382.6 6384.3 6425.9 6439.4 6440.9 1623.4 1638.0 1638.5 1640.4 1641.3 1037.2 1089.4 1094.1 1110.1 1112.4 5720.2 5730.5 5741.7 5790.4 5800.6 6576.5 6601.6 6612.9 6614.6 6621.2 5711.2 5731.5 5733.3 5738.9 5784.5 3510.6 3523.3 3542.8 3545.7 3549.3 6550.3 6563.7 6569.5 6591.6 6615.2 6769.1 6786.8 6789.1 6826.2 6836.0 6498.1 6516.4 6530.3 6537.2 6538.6 6621.2 6627.8 6642.8 6647.2 6671.6 6481.4 6496.0 6574.6 6589.2 6606.7 6019.2 6451.5 6510.7 6534.8 6612.7 4580.5 4592.2 4596.8 4605.7 4627.7 6362.4 6592.4 6629.6 6668.7 6698.9 6378.9 6395.5 6408.3 6408.9 6420.9 6380.6 6385.6 6429.7 6451.8 6464.6 6347.2 6368.2 6374.1 6380.2 6397.9 6442.5 6477.6 6506.7 6518.2 6533.7 6200.2 6280.0 6283.4 6313.8 6325.5 09:12:49 INFO - PID 16164 | 09:12:49 INFO - PID 16164 | [#5] yui.html Cycles:180 Average:19120.92 Median:27405.02 stddev:24052.11 (87.8%) stddev-sans-first:24080.01 09:12:49 INFO - PID 16164 | Values: 747.4 755.8 779.3 799.1 831.8 16242.4 16634.4 16656.3 16710.5 17482.9 18759.2 18866.6 19134.2 19150.7 19185.5 916.0 940.8 941.9 942.5 945.4 908.0 996.8 1002.4 1011.4 1013.2 1045.7 1046.8 1048.7 1050.1 1051.0 1035.6 1037.9 1042.0 1043.1 1046.1 766.5 767.7 769.9 770.9 771.4 16107.6 16807.3 17051.7 17072.5 17177.3 18270.0 18387.9 18566.4 18721.3 18802.7 15237.5 15509.6 15569.5 15587.5 15590.9 3357.6 3428.4 3461.2 3464.3 3485.4 86970.6 88592.6 89478.0 89511.6 89538.6 14424.4 14676.3 14775.2 14818.8 14857.1 26361.7 26768.5 27179.2 27258.6 27551.4 7697.2 7988.7 8423.4 8443.3 8452.9 3961.4 4084.9 4087.7 4090.0 4095.7 3866.5 3950.1 3963.7 3975.7 4265.3 858.9 859.9 869.4 872.1 872.6 653.3 688.1 689.2 690.4 694.0 10384.9 11735.5 11835.6 12042.0 12780.6 678.1 684.4 688.9 698.3 716.4 5163.8 5427.9 5434.5 5472.2 5696.5 87660.6 88049.0 88837.0 89816.0 92529.5 74483.0 75314.0 75457.2 77798.0 78596.6 70869.6 71906.8 72006.6 72521.0 73080.3 9998.4 10264.6 10514.1 10604.5 10955.2 29037.7 30246.7 30287.7 30454.8 31582.4 37169.3 37629.8 37692.2 37829.8 38593.6 15197.5 15471.1 15489.0 15569.5 15688.2 18229.0 19622.3 19977.5 20407.2 20407.4 17010.7 17022.6 17097.0 17238.7 17612.0 14453.7 14522.1 14585.9 17147.4 17466.7 15108.1 15318.4 15336.8 15568.7 15757.6 12467.3 12518.0 12551.3 12700.0 12708.7 13456.9 13830.9 14041.0 14377.9 14421.0 09:12:49 INFO - PID 16164 | -------- Summary: end -------- 09:12:49 INFO - PID 16164 | 09:12:50 INFO - TEST-INFO | 16164: exit 0 09:12:50 INFO - TEST-OK | dromaeo_css | took 1143452ms 09:12:50 INFO - TEST-START | kraken 09:12:50 INFO - operating with platform_type : linux_ 09:12:50 INFO - Initialising browser for kraken test... 09:12:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41474/getInfo.html -profile /tmp/tmpQXMiBt/profile 09:12:50 INFO - TEST-INFO | started process 16587 (/builds/slave/test/build/application/firefox/firefox http://localhost:41474/getInfo.html) 09:13:25 INFO - TEST-INFO | 16587: killed by SIGTERM 09:13:25 INFO - Browser initialized. 09:13:25 INFO - Running cycle 1/1 for kraken test... 09:13:25 INFO - TEST-INFO | started process 16817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQXMiBt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:37 INFO - PID 16817 | RSS: Main: 192446464 09:13:37 INFO - PID 16817 | 09:13:40 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41474/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:41 INFO - PID 16817 | RSS: Main: 195895296 09:13:41 INFO - PID 16817 | 09:13:43 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41474/tests/kraken/driver.html?testName=audio-dft) 09:13:44 INFO - PID 16817 | RSS: Main: 195203072 09:13:44 INFO - PID 16817 | 09:13:47 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41474/tests/kraken/driver.html?testName=audio-fft) 09:13:48 INFO - PID 16817 | RSS: Main: 190087168 09:13:48 INFO - PID 16817 | 09:13:50 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41474/tests/kraken/driver.html?testName=audio-oscillator) 09:13:50 INFO - PID 16817 | RSS: Main: 191254528 09:13:50 INFO - PID 16817 | 09:13:52 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41474/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:53 INFO - PID 16817 | RSS: Main: 191463424 09:13:53 INFO - PID 16817 | 09:13:56 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41474/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:57 INFO - PID 16817 | RSS: Main: 192348160 09:13:57 INFO - PID 16817 | 09:14:00 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41474/tests/kraken/driver.html?testName=imaging-desaturate) 09:14:01 INFO - PID 16817 | RSS: Main: 191733760 09:14:01 INFO - PID 16817 | 09:14:04 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41474/tests/kraken/driver.html?testName=json-parse-financial) 09:14:04 INFO - PID 16817 | RSS: Main: 192204800 09:14:04 INFO - PID 16817 | 09:14:06 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41474/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:14:07 INFO - PID 16817 | RSS: Main: 192212992 09:14:07 INFO - PID 16817 | 09:14:08 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41474/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:14:09 INFO - PID 16817 | RSS: Main: 192262144 09:14:09 INFO - PID 16817 | 09:14:11 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41474/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:14:12 INFO - PID 16817 | RSS: Main: 192344064 09:14:12 INFO - PID 16817 | 09:14:15 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:14:15 INFO - PID 16817 | RSS: Main: 192196608 09:14:15 INFO - PID 16817 | 09:14:18 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:19 INFO - PID 16817 | RSS: Main: 192102400 09:14:19 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | Cycle 1(1): loaded http://localhost:41474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41474/tests/kraken/driver.html?testName=ai-astar) 09:14:21 INFO - PID 16817 | RSS: Main: 193458176 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | __start_tp_report 09:14:21 INFO - PID 16817 | _x_x_mozilla_page_load 09:14:21 INFO - PID 16817 | _x_x_mozilla_page_load_details 09:14:21 INFO - PID 16817 | |i|pagename|runs| 09:14:21 INFO - PID 16817 | |0;ai-astar;103;110;111;111;110;113;110;112;113;114 09:14:21 INFO - PID 16817 | |1;audio-beat-detection;147;126;131;170;125;127;124;125;146;121 09:14:21 INFO - PID 16817 | |2;audio-dft;164;163;164;166;164;174;170;165;172;165 09:14:21 INFO - PID 16817 | |3;audio-fft;75;73;74;109;74;76;75;75;96;79 09:14:21 INFO - PID 16817 | |4;audio-oscillator;83;83;103;82;81;82;97;81;83;104 09:14:21 INFO - PID 16817 | |5;imaging-gaussian-blur;114;115;113;114;114;114;114;114;113;115 09:14:21 INFO - PID 16817 | |6;imaging-darkroom;150;150;151;151;154;155;150;151;151;152 09:14:21 INFO - PID 16817 | |7;imaging-desaturate;96;95;95;94;95;94;95;95;94;94 09:14:21 INFO - PID 16817 | |8;json-parse-financial;63;54;56;55;58;62;58;55;56;60 09:14:21 INFO - PID 16817 | |9;json-stringify-tinderbox;55;56;56;56;56;56;57;56;58;56 09:14:21 INFO - PID 16817 | |10;stanford-crypto-aes;86;95;87;101;86;87;88;90;123;86 09:14:21 INFO - PID 16817 | |11;stanford-crypto-ccm;151;139;130;129;128;131;131;134;130;141 09:14:21 INFO - PID 16817 | |12;stanford-crypto-pbkdf2;183;200;193;195;194;193;192;195;204;191 09:14:21 INFO - PID 16817 | |13;stanford-crypto-sha256-iterative;76;71;75;71;70;72;71;76;70;73 09:14:21 INFO - PID 16817 | __end_tp_report 09:14:21 INFO - PID 16817 | __start_cc_report 09:14:21 INFO - PID 16817 | _x_x_mozilla_cycle_collect,994 09:14:21 INFO - PID 16817 | __end_cc_report 09:14:21 INFO - PID 16817 | __startTimestamp1496420061604__endTimestamp 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | ------- Summary: start ------- 09:14:21 INFO - PID 16817 | Number of tests: 14 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:3.06 (2.7%) stddev-sans-first:1.51 09:14:21 INFO - PID 16817 | Values: 103.0 110.0 111.0 111.0 110.0 113.0 110.0 112.0 113.0 114.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:129.00 stddev:15.50 (12.0%) stddev-sans-first:15.73 09:14:21 INFO - PID 16817 | Values: 147.0 126.0 131.0 170.0 125.0 127.0 124.0 125.0 146.0 121.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#2] audio-dft Cycles:10 Average:166.70 Median:165.50 stddev:3.86 (2.3%) stddev-sans-first:3.97 09:14:21 INFO - PID 16817 | Values: 164.0 163.0 164.0 166.0 164.0 174.0 170.0 165.0 172.0 165.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.05 (16.1%) stddev-sans-first:12.61 09:14:21 INFO - PID 16817 | Values: 75.0 73.0 74.0 109.0 74.0 76.0 75.0 75.0 96.0 79.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#4] audio-oscillator Cycles:10 Average:87.90 Median:82.50 stddev:9.47 (11.5%) stddev-sans-first:9.88 09:14:21 INFO - PID 16817 | Values: 83.0 83.0 103.0 82.0 81.0 82.0 97.0 81.0 83.0 104.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:14:21 INFO - PID 16817 | Values: 114.0 115.0 113.0 114.0 114.0 114.0 114.0 114.0 113.0 115.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:1.72 (1.1%) stddev-sans-first:1.73 09:14:21 INFO - PID 16817 | Values: 150.0 150.0 151.0 151.0 154.0 155.0 150.0 151.0 151.0 152.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 09:14:21 INFO - PID 16817 | Values: 96.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 94.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:3.09 (5.3%) stddev-sans-first:2.62 09:14:21 INFO - PID 16817 | Values: 63.0 54.0 56.0 55.0 58.0 62.0 58.0 55.0 56.0 60.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:0.79 (1.4%) stddev-sans-first:0.71 09:14:21 INFO - PID 16817 | Values: 55.0 56.0 56.0 56.0 56.0 56.0 57.0 56.0 58.0 56.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:87.00 stddev:11.65 (13.4%) stddev-sans-first:12.08 09:14:21 INFO - PID 16817 | Values: 86.0 95.0 87.0 101.0 86.0 87.0 88.0 90.0 123.0 86.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:132.50 stddev:7.24 (5.5%) stddev-sans-first:4.56 09:14:21 INFO - PID 16817 | Values: 151.0 139.0 130.0 129.0 128.0 131.0 131.0 134.0 130.0 141.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.00 Median:194.50 stddev:5.52 (2.8%) stddev-sans-first:4.18 09:14:21 INFO - PID 16817 | Values: 183.0 200.0 193.0 195.0 194.0 193.0 192.0 195.0 204.0 191.0 09:14:21 INFO - PID 16817 | 09:14:21 INFO - PID 16817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:2.37 (3.3%) stddev-sans-first:2.15 09:14:21 INFO - PID 16817 | Values: 76.0 71.0 75.0 71.0 70.0 72.0 71.0 76.0 70.0 73.0 09:14:21 INFO - PID 16817 | -------- Summary: end -------- 09:14:21 INFO - PID 16817 | 09:14:22 INFO - TEST-INFO | 16817: exit 0 09:14:22 INFO - TEST-OK | kraken | took 92280ms 09:14:22 INFO - SUITE-END | took 1235s 09:14:23 INFO - Completed test suite (00:20:36) 09:14:23 INFO - javascript benchmark 09:14:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7574.773612792269, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.6752690967446, 3097.16376578324, 3110.191350248936, 3130.295683471219, 3131.5928929239194, 5713.285839270091, 5731.14032895066, 5754.769809207632, 5769.884602307962, 5788.50797682197, 5724.22722932404, 5741.741621627027, 5783.045797443428, 5791.478766910977, 5807.41925807419, 5287.656302340355, 5397.136458166694, 5405.918911216335, 5414.4314846941, 5430.212619170218, 5235.502627250424, 5394.406615272336, 5402.405735369106, 5423.05096608092, 5426.593005524582, 5353.9196912046355, 5434.375046869621, 5445.401005889349, 5486.149646804752, 5490.149026900816, 5311.468853114697, 5330.733463326818, 5363.570914326844, 5367.382750983647, 5372.758225879806, 5353.785848566053, 5358.785648574052, 5404.972975135139, 5416.620836541444, 5420.972895135538, 5780.624259423124, 5796.3913789052385, 5798.3911689272445, 5804.680742559158, 5827.883442331172, 6105.2474731169705, 6303.590266632654, 6312.684365781693, 6330.873382532323, 6339.429451349401, 6251.218597675291, 6280.995040793451, 6347.619142851444, 6354.968225158891, 6361.395667411589, 5789.363170051291, 5793.681347525884, 5797.391273916262, 5805.767769289266, 5854.941450585482, 6340.904886426707, 6385.96807015962, 6394.744210231632, 6399.7440102395385, 6401.551891367652, 6035.818925432244, 6109.236345456818, 6140.785072522441, 6156.168917196122, 6165.10605962133, 6264.780732674334, 6277.905831412532, 6287.402696743802, 6293.590916590407, 6293.685315734287, 6263.906041409383, 6268.153799237136, 6273.247210334698, 6281.7173227204885, 6282.717277722513, 6115.755369785248, 6152.723127459275, 6182.474489668429, 6294.024426213944, 6294.307626161119, 5175.560077393388, 5188.766505507186, 5217.452167522431, 5232.73836308183, 5253.290805741252, 4375.124975005012, 4443.644508439382, 4456.286994080931, 4517.164324599959, 4563.680542362069, 5455.699936503451, 5495.450454954553, 5498.560115190775, 5511.448855114457, 5557.722113894289, 6191.318954914956, 6206.72069756862, 6235.844103897439, 6243.625382477066, 6254.249490061222, 5554.416786237468, 5566.137248726453, 5569.415211402745, 5584.162375643686, 5624.3813180550105, 5654.886902261932, 5665.433456654384, 5671.0, 5671.716414179275, 5671.773129074791, 5995.2206213192, 6018.638881667026, 6076.605020673642, 6077.118817771487, 6090.695465226632, 6270.216222972129, 6271.498280137669, 6339.270983836917, 6342.778002769881, 6346.333634968447, 6091.634501929721, 6104.969475152596, 6139.829471381233, 6214.40963108504, 6227.346128656607, 6108.342071131425, 6109.708332504907, 6125.05232106189, 6126.761967422209, 6175.351588083367, 6318.842028949313, 6321.020241862519, 6332.0818481320875, 6332.651704156131, 6367.07677386767, 6066.241719785027, 6069.848253793691, 6074.878502430015, 6075.453209211192, 6083.847903802441, 5932.79235226765, 6016.729247183975, 6056.9697151513965, 6101.60339577926, 6107.267127944675, 5841.591088623755, 6071.362506936708, 6079.969600151971, 6080.969595152173, 6129.325774164928, 6168.414000669929, 6170.660613666291, 6174.753009879554, 6176.3514830943905, 6197.845053873689, 5622.9156562652415, 5696.832149409444, 5879.647221166743, 5998.1002849572915, 6004.849878753066], "value": 5740.132375859283, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.9466040046998, 751.3238085722849, 773.7021246819975, 1134.1437214902746, 1147.237087336921, 35435.0, 36158.63841361589, 36267.0, 36286.637133628654, 36323.81838090806, 37453.250934981355, 37547.0, 37861.81069094658, 37902.86291411255, 37929.24141517168, 7147.106611673541, 7285.56286622803, 7294.343509084181, 7376.631168441583, 7399.0, 7198.8200294992785, 7311.086114235721, 7312.451566132535, 7319.158296795883, 7336.303051210127, 7312.890306645405, 7337.926620733778, 7368.8894666580045, 7397.297256760599, 7408.296211859864, 7305.452091093162, 7348.559086454829, 7349.522281051714, 7388.815279617998, 7393.852122957537, 7177.7487787927175, 7260.165081015698, 7271.200167981518, 7274.709011639528, 7291.234420385889, 34650.306993860235, 34810.82594587011, 34901.12747181315, 34931.4760278596, 34977.47533786995, 3397.524346591479, 3412.385770561298, 3420.162060295219, 3432.63957284484, 3451.706604938583, 27688.0, 27817.304567385978, 27911.58132628012, 27914.581281280796, 28023.159305220877, 3614.9096272593133, 3685.3919103347916, 3690.612485688991, 3702.648248416396, 3717.5353080864893, 133622.0, 139042.0, 140767.99999999898, 162898.0, 164301.0, 41049.0, 41088.0, 41341.1731765363, 41411.7929410357, 41460.0, 43524.56475435205, 43614.34578481325, 43703.56296436995, 43732.0, 43745.87557741919, 14422.06256593318, 14437.278136093153, 14499.492517761828, 14504.34730437133, 14566.927165364317, 11966.64100076999, 11988.160828741904, 11998.760024799456, 12002.699932501757, 12035.699107522207, 13291.069625126149, 13312.334383280797, 13343.26612036328, 13343.73312533744, 13556.16991706107, 5430.83707488776, 5533.861653458695, 5552.333719953551, 5597.74810133545, 5634.32388113429, 965.7778710896392, 1000.6197644894893, 1006.0392325329293, 1012.6708819633649, 1028.3521381529588, 22242.332730018126, 23155.536889262457, 23194.53610927806, 23319.41701457477, 23386.53226935486, 1093.3767752381066, 1094.3324572011068, 1099.4118146791589, 1116.3246236027087, 1119.205364191417, 11952.342621155745, 12190.329531875655, 12262.938685306517, 12370.75258494825, 12433.0, 187611.0619446894, 189591.0, 189843.0, 189952.0, 190360.0, 46706.299405508944, 46784.0, 46921.29618055732, 46942.765286174035, 47010.294845577344, 1378.3797291218991, 1438.7338342406688, 1446.197360464952, 1461.0795199024546, 1463.0928824129107, 21596.892015539823, 21844.45388865291, 22826.201082962016, 22895.42761430911, 23058.769412306334, 34328.14179645529, 34507.13732156716, 34558.13604659803, 34598.65401345954, 34636.0, 170727.0, 172004.0, 172308.0, 172615.0, 172972.0, 24708.752912470645, 25171.748282517674, 26853.462930740887, 30502.389952201276, 30773.46132693401, 33560.1609959753, 33759.66240337565, 34010.65989340075, 34432.0, 34465.48301775425, 25917.22248332553, 26253.34366640849, 26392.07627733097, 26717.8664106686, 27234.455310894067, 25192.24423267305, 25272.368190795376, 25978.74021259839, 27162.72837271602, 27238.182854514398, 28538.57192142078, 28645.14064578066, 28779.712202877705, 28957.85521072381, 29167.416651667274, 25519.87240063788, 25755.356116097246, 25850.0, 26365.472690546467, 26623.86688066547, 20536.794632053487, 21383.0, 21461.24885629058, 21490.24784132548, 21512.677309840677], "value": 15429.587202357487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.1890351621373, 420.6311392173566, 428.6035417239053, 443.571953065292, 447.2553198923792, 19375.32186373477, 20174.798252017474, 20245.088970996305, 22165.667514987246, 23043.654345184837, 22816.543669126608, 23190.188343407983, 23250.88374558129, 23255.0, 23257.185998490055, 5950.404959504048, 6049.788257410992, 6092.390760923917, 6093.299270583895, 6094.512439004869, 6017.488513476338, 6031.6984150792505, 6037.30570984338, 6070.514358851281, 6075.605085669439, 5812.796552120677, 5902.940970590282, 5929.733162007698, 5947.22686050815, 5956.970215148918, 5880.911786323209, 5881.588288819784, 5919.911201331984, 5934.821955341346, 5940.108983652465, 5301.1783173608155, 5308.70802105884, 5316.707581083039, 5336.092864213093, 5342.679439233659, 25562.744372556223, 25698.22905312825, 25824.87087564569, 25861.35346616331, 25881.22356329313, 1854.1841589700623, 1931.9903400482908, 1943.1935746665117, 1943.6782987568447, 1945.1830231302886, 17246.22391992351, 17440.389586364417, 17454.912725436418, 17513.912430437893, 17585.56036099095, 2206.282958038628, 2224.4327696437467, 2261.208576998054, 2274.294968559735, 2277.7266727992583, 100286.49856750743, 106341.0, 112022.0, 112755.43622281917, 119690.4015479917, 11583.305001699924, 11878.46546905374, 12010.759784804255, 12027.579034733742, 12071.215371000857, 16786.496405107868, 16974.405895793836, 17024.319027238773, 17052.829471705372, 17083.658326833644, 8725.825483490422, 9022.188003079755, 9035.45787252767, 9039.864402033974, 9077.364584479155, 8560.529170895661, 8650.697225597074, 8684.478931264144, 8769.991450983218, 8866.556672166365, 7528.924710752932, 7754.728584499516, 7897.131315555284, 7909.1299957004685, 7915.12933577306, 2102.327255278327, 2106.6945292932746, 2108.8734675919495, 2136.1135128921633, 2265.750767415583, 943.3255222515934, 987.8172538080478, 992.0773680477081, 997.3616885193481, 1018.6231094495084, 19240.23039078421, 20184.798152018586, 20228.494287642927, 20616.175352985712, 20665.79334206669, 981.097390400833, 993.7664648807524, 1004.3070281505737, 1009.4044513736784, 1030.0935177044303, 10078.59685612582, 11143.609973650884, 12380.504779808887, 13723.862761372458, 13769.862301377058, 440897.0, 443571.0, 444667.0, 446609.0, 453889.0, 100916.0, 102387.0, 102521.0, 103998.48000759947, 104854.0, 1153.4521102476256, 1209.6008317255285, 1240.7394447166196, 1243.6144795113362, 1248.806435002576, 20050.799492004895, 20064.69902951486, 20810.167593296705, 20852.0, 20852.37442876716, 48044.759776200895, 48554.27168592403, 49136.75431622819, 49552.256716150005, 50129.498705012484, 60589.0, 60702.39297606968, 60800.391996079474, 60801.69599152153, 60915.69542152261, 10158.13655839262, 10197.59209631636, 10557.99699028591, 10600.204984626029, 10648.680539583826, 17137.314507420062, 17585.912070439565, 17827.73258401099, 17863.196156173264, 17953.820461795214, 14527.564173074825, 14626.780598290821, 14877.628059298171, 14910.32903519366, 15097.622559436102, 12768.6807829805, 13361.732765344444, 13524.59426217215, 14436.278186090864, 14447.78328325055, 13444.39500222512, 15319.846801531841, 15475.226238688245, 15510.22448877529, 15523.922380388025, 10189.898101018895, 10193.541290641791, 10331.638392656221, 10430.16558675289, 10483.108935740547, 13850.515231966832, 13852.861471385157, 13964.0, 13975.650608734863, 14067.296635168404], "value": 10487.221510155112, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.1564167649353, 1352.7700290950538, 1363.659085228693, 1369.6781256404743, 1383.806267122603, 10513.526891289892, 10600.0, 10731.034206921375, 11135.665930022093, 11179.273347232423, 10855.565777368916, 11245.212835101545, 11258.718532036683, 11295.717607059827, 11296.039836613878, 2335.1126571902696, 2385.2128797496785, 2385.5348207099623, 2385.546746118232, 2392.1507864708037, 2248.516568937678, 2260.864348139117, 2348.248560460653, 2353.0587764894008, 2357.1043003658588, 2342.590046741822, 2344.742078371378, 2375.2280508834697, 2378.988105059472, 2382.0828980842416, 2305.0318866076373, 2310.0297874892503, 2310.145246258878, 2316.073570571776, 2317.316391664463, 2258.3450799268194, 2266.3994041578994, 2287.885605719724, 2291.988540057289, 2304.4238940264936, 10580.15358771304, 10656.09423199029, 10683.626073087482, 10692.091172250368, 10702.357858528514, 6034.788782392639, 6225.470834979033, 6253.062040693887, 6255.06174073888, 6258.3428739982555, 3775.452559378875, 3825.5409350877794, 3867.505458978971, 3928.685705143582, 3941.881743547698, 1233.4018001269378, 1261.482792055253, 1277.5337001994299, 1283.146707439561, 1290.8450985881661, 14419.279036048261, 14964.925175374163, 15132.394704211929, 15555.377784888591, 15569.922150389175, 5428.267183930119, 5441.564674826004, 5648.49163575272, 5676.233708449389, 5683.886322273532, 13816.309184540733, 13831.239281839395, 13835.584932452042, 13885.166889986633, 13887.861121388858, 6148.723307451175, 6281.089242059876, 6297.748090076346, 6300.180976473121, 6304.558680892385, 5671.432856714378, 5723.198752174699, 5749.223854779635, 5759.625624334489, 5799.739011744482, 4423.469183697976, 4427.535108813592, 4526.7510286933875, 4540.205464043779, 4567.451905771262, 1349.4737052549513, 1409.584172669065, 1414.5473448496589, 1427.586000059971, 1432.7564314066633, 804.927556519916, 825.4222044568826, 838.362844238371, 849.5454931611558, 869.8434281829205, 5963.5527335450015, 5969.940300597025, 5991.670458124758, 6082.452579267887, 6146.262448506119, 592.0970519957013, 603.1856993059334, 606.7027156693189, 612.7579606055583, 617.305531277313, 3678.264347130531, 4279.850205242801, 4467.508574056851, 4507.616852567503, 4578.908421831545, 13462.057655963989, 13941.581752547238, 14222.0, 14275.14349139055, 14283.42866285337, 13945.790813137812, 14190.077644953046, 14214.644633884029, 14247.287635618384, 14378.784318235235, 8360.790980225544, 8917.509536975398, 8921.330900182513, 8944.642214311354, 9002.819943601222, 6864.897026544706, 6952.85277929136, 7165.498415110892, 7168.068151140318, 7193.496455248082, 12229.266244025386, 12553.0, 12634.0, 12677.429515672002, 12707.428165732748, 12759.87240127624, 12765.93617031909, 12781.233126012468, 12904.8064279034, 13005.739885202433, 9278.675246366345, 9317.487538185194, 9389.154976052188, 9437.669681561387, 9488.146066854017, 10393.116585090049, 10415.427151506437, 10487.737806554896, 10564.894351056699, 10573.52419141156, 8147.14454982242, 8395.286400656012, 8439.831203376021, 8475.067742548437, 8614.353923455641, 8412.663493460193, 8592.742217733228, 8653.69712060075, 8683.86974195375, 8843.51360675169, 7530.531546348629, 7653.272939070779, 7667.079950405987, 7705.845883082195, 7708.113566939874, 5506.972465137648, 5546.417626149197, 5625.156226566048, 5671.064274394678, 5774.56690748204, 5616.803411880564, 5622.269105016322, 5667.858303542444, 5719.399463056319, 5761.423857614205], "value": 5159.12308433769, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.77554793767547, 401.5963956223994, 402.9858954936576, 405.90055436418083, 415.5429028069124, 6018.578699491038, 6181.227346581677, 6190.709437508128, 6233.06504024396, 6238.5321100917445, 5903.970480147594, 5992.3108842483125, 6029.216201893748, 6031.969840150793, 6037.882991646548, 4729.337892695025, 4732.597729193023, 4750.809967601292, 4769.642276829243, 4778.784954677048, 4621.930671039937, 4766.952330476703, 4775.737334446621, 4776.641751868607, 4802.087603355369, 4723.952760472403, 4728.574428301452, 4730.739809310487, 4733.857984260478, 4745.359376484183, 4676.924307409298, 4691.926787953896, 4705.905881882378, 4717.221658426355, 4753.809847606091, 4152.314868046798, 4154.750714957112, 4158.189153115144, 4162.876023473646, 4170.91658166838, 5952.7023648817385, 5960.850978725523, 5961.0, 5967.283925928917, 5982.102684597346, 5402.8109016184635, 5413.133898576249, 5414.296141501619, 5428.240046393508, 5432.239486471857, 6340.714667839959, 6373.203349581302, 6405.5516113872045, 6450.838729031811, 6454.741810327581, 4515.729056256635, 4547.954520454786, 4554.521775213588, 4555.2711566149255, 4557.065801510682, 6460.773872914426, 6532.0, 6682.632455214961, 6752.0, 6874.793756187272, 4564.452265728068, 4581.518940511265, 4594.563516465931, 4601.930971035437, 4607.585317321457, 4647.16351056813, 4648.302754586839, 4649.744264065509, 4650.325702773079, 4674.415698037746, 5352.411234764173, 5355.875975498922, 5359.732013399393, 5373.0, 5375.811846585429, 6382.585131966407, 6384.32964538726, 6425.871482570323, 6439.388258115471, 6440.935590644033, 1623.4480276705976, 1637.983620163807, 1638.5248277999247, 1640.4176517336412, 1641.2860405723548, 1037.1547189040907, 1089.362722807151, 1094.124700239805, 1110.0897264243242, 1112.4215407987963, 5720.1991721159075, 5730.484256416859, 5741.732015853714, 5790.36306006339, 5800.564957628195, 6576.5067619928695, 6601.6234155703905, 6612.86774264512, 6614.570052946639, 6621.172353455818, 5711.200431939532, 5731.455511726379, 5733.254676891977, 5738.885222295531, 5784.479396854304, 3510.5962814276686, 3523.295340931824, 3542.8051457170104, 3545.7340699447645, 3549.290141971616, 6550.2794692583775, 6563.671816409161, 6569.540132190797, 6591.571547849375, 6615.239247486505, 6769.120014398097, 6786.796396108125, 6789.083473730983, 6826.180858296937, 6836.0, 6498.108341787954, 6516.446102081376, 6530.2816690164045, 6537.182852143482, 6538.574992625464, 6621.205455345389, 6627.834304142435, 6642.83392915181, 6647.235567909559, 6671.599704017581, 6481.351864813481, 6496.0, 6574.638394888327, 6589.24223714279, 6606.669666516751, 6019.247594050744, 6451.483881289391, 6510.73957041713, 6534.803955881332, 6612.660606393741, 4580.519045500175, 4592.196365636067, 4596.793144308581, 4605.746683932416, 4627.652926030494, 6362.395572420613, 6592.373724496165, 6629.585763331985, 6668.699298741926, 6698.866022679422, 6378.947473666979, 6395.456386207225, 6408.327125651739, 6408.878446271977, 6420.903686444613, 6380.553361264667, 6385.616862988236, 6429.688710314098, 6451.806445806634, 6464.5798023128345, 6347.238331400262, 6368.172137622265, 6374.139491168633, 6380.234371875405, 6397.936020639734, 6442.516811239082, 6477.578957367756, 6506.739730410731, 6518.185226846645, 6533.705983230671, 6200.193974783429, 6280.0, 6283.37166283368, 6313.842153946188, 6325.462335701332], "value": 4860.458238637735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.3908764357049, 755.803491092316, 779.2830595851816, 799.0970203669852, 831.7878940870081, 16242.35030598776, 16634.417795377165, 16656.25046872889, 16710.498685039438, 17482.912585437087, 18759.155837987288, 18866.622667546642, 19134.234630614792, 19150.712739308885, 19185.520361990923, 915.9908400915989, 940.8071345374182, 941.90110038446, 942.5334459442586, 945.399671208784, 907.9818403631923, 996.7657600463886, 1002.3885429887799, 1011.4234886114881, 1013.1692012549712, 1045.7490202351419, 1046.7697106636529, 1048.7430579507993, 1050.144132531988, 1051.0225490294024, 1035.6271742172812, 1037.8806437259698, 1042.0413219837767, 1043.1237760281324, 1046.0794500839213, 766.5094339622646, 767.7351313796731, 769.8806684963839, 770.9074911010658, 771.4175797273023, 16107.597310067225, 16807.32770689171, 17051.74422383653, 17072.48782536526, 17177.31290748381, 18270.0, 18387.908060459748, 18566.35017774385, 18721.251149953987, 18802.717959230624, 15237.542873713695, 15509.612259693598, 15569.455069072641, 15587.454439094578, 15590.922045389814, 3357.647447018077, 3428.3828910796046, 3461.152017755666, 3464.272502774395, 3485.3900567400606, 86970.56514717385, 88592.55703721504, 89478.0, 89511.55244223803, 89538.55230723805, 14424.350904209336, 14676.266186690622, 14775.187364695044, 14818.777718334233, 14857.10857348541, 26361.73638263631, 26768.464630707665, 27179.184624461297, 27258.5911211332, 27551.44897102047, 7697.153313135551, 7988.6804527819395, 8423.368247381472, 8443.324534037261, 8452.915470845335, 3961.4057891316534, 4084.9387259191135, 4087.693422993287, 4090.0, 4095.7337773044655, 3866.516685414323, 3950.051987523031, 3963.742356746802, 3975.7018223633345, 4265.253580623378, 858.9012263589642, 859.9312055035582, 869.443556124081, 872.0843114729508, 872.5637181409295, 653.2552889705739, 688.1157712339619, 689.1557841644046, 690.413148823506, 694.035290945586, 10384.948075259575, 11735.471903764352, 11835.585754498552, 12042.0, 12780.552680656132, 678.0744284052332, 684.428502200658, 688.9276625954203, 698.3435570563654, 716.373173473211, 5163.845084647466, 5427.864303392368, 5434.456554344534, 5472.2338872557875, 5696.544276457874, 87660.56169719239, 88049.0, 88837.0, 89816.0, 92529.53735231281, 74483.0, 75314.0, 75457.24542754501, 77798.0, 78596.60701696455, 70869.64565177141, 71906.76419561132, 72006.63996679983, 72520.99999999894, 73080.26919730841, 9998.400095994264, 10264.589699634555, 10514.107460656849, 10604.522796474022, 10955.17836162307, 29037.7096229035, 30246.697533024388, 30287.697123028487, 30454.847725762116, 31582.36835263328, 37169.25661486701, 37629.81185094057, 37692.246155076195, 37829.81085094557, 38593.614063859, 15197.544073677807, 15471.071735695445, 15489.0, 15569.455069072528, 15688.215589220721, 18229.0, 19622.313219037263, 19977.500562486053, 20407.18371265192, 20407.387778366672, 17010.744838827675, 17022.57443563921, 17097.0, 17238.741418878977, 17612.0, 14453.710925781636, 14522.128672279698, 14585.92707036458, 17147.399841005506, 17466.650666986843, 15108.093514389171, 15318.387264509294, 15336.769948451005, 15568.688626227638, 15757.606059848595, 12467.314297713712, 12518.0, 12551.3096779678, 12700.0, 12708.682282943, 13456.86543134556, 13830.861691382957, 14041.0, 14377.928110359382, 14421.0], "value": 8109.60859540092, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 111.0, 110.0, 113.0, 110.0, 112.0, 113.0, 114.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 131.0, 170.0, 125.0, 127.0, 124.0, 125.0, 146.0, 121.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 166.0, 164.0, 174.0, 170.0, 165.0, 172.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 109.0, 74.0, 76.0, 75.0, 75.0, 96.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 103.0, 82.0, 81.0, 82.0, 97.0, 81.0, 83.0, 104.0], "value": 87.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 154.0, 155.0, 150.0, 151.0, 151.0, 152.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 54.0, 56.0, 55.0, 58.0, 62.0, 58.0, 55.0, 56.0, 60.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 58.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 95.0, 87.0, 101.0, 86.0, 87.0, 88.0, 90.0, 123.0, 86.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 139.0, 130.0, 129.0, 128.0, 131.0, 131.0, 134.0, 130.0, 141.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 200.0, 193.0, 195.0, 194.0, 193.0, 192.0, 195.0, 204.0, 191.0], "value": 194.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 71.0, 75.0, 71.0, 70.0, 72.0, 71.0, 76.0, 70.0, 73.0], "value": 72.5, "unit": "score"}]}]} 09:14:23 INFO - Return code: 0 09:14:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:14:23 INFO - # TBPL SUCCESS # 09:14:23 INFO - Running post-action listener: _resource_record_post_action 09:14:23 INFO - [mozharness: 2017-06-02 16:14:23.511919Z] Finished run-tests step (success) 09:14:23 INFO - Running post-run listener: _resource_record_post_run 09:14:23 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431988736; Read time: 4; Write time: 260796 09:14:23 INFO - TinderboxPrint: CPU usage
12.7% 09:14:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 09:14:23 INFO - TinderboxPrint: I/O write bytes / time
431,988,736 / 260,796 09:14:23 INFO - TinderboxPrint: CPU idle
8,737.2 (87.3%) 09:14:23 INFO - TinderboxPrint: CPU user
1,215.4 (12.1%) 09:14:23 INFO - TinderboxPrint: Swap in / out
0 / 0 09:14:23 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 99991552; Read time: 0; Write time: 69980 09:14:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:14:23 INFO - run-tests - Wall time: 1237s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327364608; Read time: 4; Write time: 190268 09:14:24 INFO - Running post-run listener: _upload_blobber_files 09:14:24 INFO - Blob upload gear active. 09:14:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:14:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:14:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:14:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:14:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:30 INFO - (blobuploader) - INFO - Done attempting. 09:14:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:14:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:14:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:30 INFO - (blobuploader) - INFO - Done attempting. 09:14:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:14:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:14:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:31 INFO - (blobuploader) - INFO - Done attempting. 09:14:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:14:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:14:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:32 INFO - (blobuploader) - INFO - Done attempting. 09:14:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:32 INFO - Return code: 0 09:14:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/549195ac2aa980f8c7bc2b2eacaf9acf82c61c90d149cc027668e420d73a2ad3590ea570338ebc5bf9e04b45e923395358b50a5055948658f2817e03c91a8264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d66ac2e924ae7aacddee090164b1f19bac2a21fc41d55cfae8aadb54d0e2c21c663b3e1bbb78c0cf5fcf1fbaeabe5d678ef99736d4b475e63d261705f4d3e389", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e4c58758e8c9db1361f8ec85f706ac65ef848bcd0ae44766ab120d29b47e2d0e1141e6eeefc1ffdd2c42ebea53a6ffbdd2212155f0282038b8f2b042ba6724b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f964c00903692373503b8fec53113bcf65069257477cdb68b7bcb282e6810328e1378b74ab79a6cb0a6770b36975e1c3676022fececdeb9fc34806a0d74a21"} 09:14:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:32 INFO - Contents: 09:14:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/549195ac2aa980f8c7bc2b2eacaf9acf82c61c90d149cc027668e420d73a2ad3590ea570338ebc5bf9e04b45e923395358b50a5055948658f2817e03c91a8264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d66ac2e924ae7aacddee090164b1f19bac2a21fc41d55cfae8aadb54d0e2c21c663b3e1bbb78c0cf5fcf1fbaeabe5d678ef99736d4b475e63d261705f4d3e389", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e4c58758e8c9db1361f8ec85f706ac65ef848bcd0ae44766ab120d29b47e2d0e1141e6eeefc1ffdd2c42ebea53a6ffbdd2212155f0282038b8f2b042ba6724b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f964c00903692373503b8fec53113bcf65069257477cdb68b7bcb282e6810328e1378b74ab79a6cb0a6770b36975e1c3676022fececdeb9fc34806a0d74a21"} 09:14:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:32 INFO - Copying logs to upload dir... 09:14:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1314.909857 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-06-02 09:14:30.122706) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 09:14:30.127467) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589 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/sha512/549195ac2aa980f8c7bc2b2eacaf9acf82c61c90d149cc027668e420d73a2ad3590ea570338ebc5bf9e04b45e923395358b50a5055948658f2817e03c91a8264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d66ac2e924ae7aacddee090164b1f19bac2a21fc41d55cfae8aadb54d0e2c21c663b3e1bbb78c0cf5fcf1fbaeabe5d678ef99736d4b475e63d261705f4d3e389", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e4c58758e8c9db1361f8ec85f706ac65ef848bcd0ae44766ab120d29b47e2d0e1141e6eeefc1ffdd2c42ebea53a6ffbdd2212155f0282038b8f2b042ba6724b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f964c00903692373503b8fec53113bcf65069257477cdb68b7bcb282e6810328e1378b74ab79a6cb0a6770b36975e1c3676022fececdeb9fc34806a0d74a21"} build_url:https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/UrYeOsKRR3e_UsOLfZfxCA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/549195ac2aa980f8c7bc2b2eacaf9acf82c61c90d149cc027668e420d73a2ad3590ea570338ebc5bf9e04b45e923395358b50a5055948658f2817e03c91a8264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d66ac2e924ae7aacddee090164b1f19bac2a21fc41d55cfae8aadb54d0e2c21c663b3e1bbb78c0cf5fcf1fbaeabe5d678ef99736d4b475e63d261705f4d3e389", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e4c58758e8c9db1361f8ec85f706ac65ef848bcd0ae44766ab120d29b47e2d0e1141e6eeefc1ffdd2c42ebea53a6ffbdd2212155f0282038b8f2b042ba6724b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81f964c00903692373503b8fec53113bcf65069257477cdb68b7bcb282e6810328e1378b74ab79a6cb0a6770b36975e1c3676022fececdeb9fc34806a0d74a21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 09:14:30.154714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:14:30.155060) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1496409653.975878-46721589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:14:30.233892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 09:14:30.235528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 09:14:30.236325) ========= ========= Total master_lag: 0.17 =========