builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1493891115.45 results: success (0) revision: a8d597ee6dd58306e62e55a07c4ab20958726d6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:15.452746) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:15.453154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:15.453425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:15.511013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:15.511322) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 02:45:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-05-04 02:45:15 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119050 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:15.652826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:15.653159) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019165 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:15.707778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 02:45:15.708106) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8d597ee6dd58306e62e55a07c4ab20958726d6a --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 a8d597ee6dd58306e62e55a07c4ab20958726d6a --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=8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 02:45:15,986 truncating revision to first 12 chars 2017-05-04 02:45:15,987 Setting DEBUG logging. 2017-05-04 02:45:15,987 attempt 1/10 2017-05-04 02:45:15,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8d597ee6dd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 02:45:17,199 unpacking tar archive at: mozilla-central-a8d597ee6dd5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.551219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 02:45:17.280104) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:17.280444) ========= script_repo_revision: a8d597ee6dd58306e62e55a07c4ab20958726d6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:17.280865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:17.281148) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:17.294027) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-04 02:45:17.294394) ========= /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=8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:45:17 INFO - MultiFileLogger online at 20170504 02:45:17 in /builds/slave/test 02:45:17 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 02:45:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:17 INFO - {'append_to_log': False, 02:45:17 INFO - 'base_work_dir': '/builds/slave/test', 02:45:17 INFO - 'blob_upload_branch': 'Firefox', 02:45:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:17 INFO - 'branch': 'Firefox', 02:45:17 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:17 INFO - 'config_files': ('talos/linux_config.py',), 02:45:17 INFO - 'default_actions': ('clobber', 02:45:17 INFO - 'read-buildbot-config', 02:45:17 INFO - 'download-and-extract', 02:45:17 INFO - 'populate-webroot', 02:45:17 INFO - 'create-virtualenv', 02:45:17 INFO - 'install', 02:45:17 INFO - 'run-tests'), 02:45:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:17 INFO - 'download_minidump_stackwalk': True, 02:45:17 INFO - 'download_symbols': 'ondemand', 02:45:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:17 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:17 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:17 INFO - 'gecko_profile': False, 02:45:17 INFO - 'gecko_profile_interval': 0, 02:45:17 INFO - 'installer_path': 'installer.exe', 02:45:17 INFO - 'log_level': 'info', 02:45:17 INFO - 'log_name': 'talos', 02:45:17 INFO - 'log_to_console': True, 02:45:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:45:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:45:17 INFO - 'opt_config_files': (), 02:45:17 INFO - 'pip_index': False, 02:45:17 INFO - 'suite': 'dromaeojs-e10s', 02:45:17 INFO - 'system_bits': '32', 02:45:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:17 INFO - 'title': 'talos-linux64-ix-089', 02:45:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:17 INFO - 'use_talos_json': True, 02:45:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:17 INFO - 'work_dir': 'build'} 02:45:17 INFO - [mozharness: 2017-05-04 09:45:17.675191Z] Running clobber step. 02:45:17 INFO - Running pre-action listener: _resource_record_pre_action 02:45:17 INFO - Running main action method: clobber 02:45:17 INFO - rmtree: /builds/slave/test/build 02:45:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:18 INFO - Running post-action listener: _resource_record_post_action 02:45:18 INFO - [mozharness: 2017-05-04 09:45:18.612730Z] Finished clobber step (success) 02:45:18 INFO - [mozharness: 2017-05-04 09:45:18.612829Z] Running read-buildbot-config step. 02:45:18 INFO - Running pre-action listener: _resource_record_pre_action 02:45:18 INFO - Running main action method: read_buildbot_config 02:45:18 INFO - Using buildbot properties: 02:45:18 INFO - { 02:45:18 INFO - "project": "", 02:45:18 INFO - "product": "firefox", 02:45:18 INFO - "who": "cbook@mozilla.com", 02:45:18 INFO - "installer_path": "public/build/target.tar.bz2", 02:45:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:45:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:45:18 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:45:18 INFO - "stage_platform": "linux64-stylo", 02:45:18 INFO - "basedir": "/builds/slave/test", 02:45:18 INFO - "buildnumber": 70, 02:45:18 INFO - "platform": "ubuntu64_hw_stylo", 02:45:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:45:18 INFO - "slavebuilddir": "test", 02:45:18 INFO - "taskId": "Tu2TfdiHTaeKoodi8CYeTw", 02:45:18 INFO - "branch": "mozilla-central", 02:45:18 INFO - "script_repo_revision": "production", 02:45:18 INFO - "revision": "a8d597ee6dd58306e62e55a07c4ab20958726d6a", 02:45:18 INFO - "slavename": "talos-linux64-ix-089", 02:45:18 INFO - "repo_path": "mozilla-central" 02:45:18 INFO - } 02:45:18 INFO - Finding installer, test and symbols from parent task. 02:45:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tu2TfdiHTaeKoodi8CYeTw'}, attempt #1 02:45:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tu2TfdiHTaeKoodi8CYeTw'}, attempt #1 02:45:19 INFO - Task dependencies: ItSf58erR_KVtIfo-h7vLA 02:45:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA'}, attempt #1 02:45:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2 02:45:20 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/test_packages.json 02:45:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.crashreporter-symbols.zip 02:45:20 INFO - Running post-action listener: _resource_record_post_action 02:45:20 INFO - [mozharness: 2017-05-04 09:45:20.006429Z] Finished read-buildbot-config step (success) 02:45:20 INFO - [mozharness: 2017-05-04 09:45:20.006645Z] Running download-and-extract step. 02:45:20 INFO - Running pre-action listener: _resource_record_pre_action 02:45:20 INFO - Running main action method: download_and_extract 02:45:20 INFO - mkdir: /builds/slave/test/build/tests 02:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:20 INFO - trying https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.test_packages.json 02:45:20 INFO - Downloading https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:45:20 INFO - Downloaded 986 bytes. 02:45:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:45:20 INFO - Using the following test package requirements: 02:45:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:45:20 INFO - u'common': [u'target.common.tests.zip'], 02:45:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:45:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:45:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:45:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:45:20 INFO - u'mozbase': [u'target.common.tests.zip'], 02:45:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:45:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:45:20 INFO - u'web-platform': [u'target.common.tests.zip', 02:45:20 INFO - u'target.web-platform.tests.zip'], 02:45:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:45:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:45:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.common.tests.zip 02:45:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:45:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.common.tests.zip into memory 02:45:22 INFO - Content-Length response header: 58441542 02:45:22 INFO - Bytes received: 58441542 02:45:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:45:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.common.tests.zip 02:45:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:45:31 INFO - Fetch https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.common.tests.zip into memory 02:45:33 INFO - Content-Length response header: 58441542 02:45:33 INFO - Bytes received: 58441542 02:45:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.talos.tests.zip 02:45:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:45:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.talos.tests.zip into memory 02:45:45 INFO - Content-Length response header: 14408809 02:45:45 INFO - Bytes received: 14408809 02:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:45 INFO - trying https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2 02:45:45 INFO - Downloading https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:45:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:45:48 INFO - Downloaded 59906162 bytes. 02:45:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2 02:45:48 INFO - mkdir: /builds/slave/test/properties 02:45:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:45:48 INFO - Writing to file /builds/slave/test/properties/build_url 02:45:48 INFO - Contents: 02:45:48 INFO - build_url:https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2 02:45:48 INFO - Running post-action listener: _resource_record_post_action 02:45:48 INFO - Running post-action listener: set_extra_try_arguments 02:45:48 INFO - [mozharness: 2017-05-04 09:45:48.542421Z] Finished download-and-extract step (success) 02:45:48 INFO - [mozharness: 2017-05-04 09:45:48.542625Z] Running populate-webroot step. 02:45:48 INFO - Running pre-action listener: _resource_record_pre_action 02:45:48 INFO - Running main action method: populate_webroot 02:45:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:45:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:45:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:45:48 INFO - '--tppagecycles', 02:45:48 INFO - '7'], 02:45:48 INFO - 'tests': ['tsvgm']}}, 02:45:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:45:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:45:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:45:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:45:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:45:48 INFO - 'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:45:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:45:48 INFO - 'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['damp', 'tps']}, 02:45:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:45:48 INFO - 'tests': ['damp', 'tps']}, 02:45:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['dromaeo_dom']}, 02:45:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:45:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:45:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:45:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['a11yr', 02:45:48 INFO - 'ts_paint', 02:45:48 INFO - 'tpaint', 02:45:48 INFO - 'sessionrestore', 02:45:48 INFO - 'sessionrestore_no_auto_restore', 02:45:48 INFO - 'tabpaint']}, 02:45:48 INFO - 'other-e10s': {'tests': ['a11yr', 02:45:48 INFO - 'ts_paint', 02:45:48 INFO - 'tpaint', 02:45:48 INFO - 'sessionrestore', 02:45:48 INFO - 'sessionrestore_no_auto_restore', 02:45:48 INFO - 'tabpaint']}, 02:45:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:45:48 INFO - 'ts_paint', 02:45:48 INFO - 'tpaint', 02:45:48 INFO - 'sessionrestore', 02:45:48 INFO - 'sessionrestore_no_auto_restore', 02:45:48 INFO - 'tabpaint']}, 02:45:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:45:48 INFO - 'ts_paint', 02:45:48 INFO - 'tpaint', 02:45:48 INFO - 'sessionrestore', 02:45:48 INFO - 'sessionrestore_no_auto_restore', 02:45:48 INFO - 'tabpaint']}, 02:45:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['a11yr', 02:45:48 INFO - 'ts_paint', 02:45:48 INFO - 'tpaint', 02:45:48 INFO - 'sessionrestore', 02:45:48 INFO - 'sessionrestore_no_auto_restore', 02:45:48 INFO - 'tabpaint']}, 02:45:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['a11yr', 02:45:48 INFO - 'ts_paint', 02:45:48 INFO - 'tpaint', 02:45:48 INFO - 'sessionrestore', 02:45:48 INFO - 'sessionrestore_no_auto_restore', 02:45:48 INFO - 'tabpaint']}, 02:45:48 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:45:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:45:48 INFO - 'bloom_basic_ref']}, 02:45:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['tsvgx', 02:45:48 INFO - 'tsvgr_opacity', 02:45:48 INFO - 'tart', 02:45:48 INFO - 'tscrollx', 02:45:48 INFO - 'cart', 02:45:48 INFO - 'tsvg_static']}, 02:45:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:45:48 INFO - 'tsvgr_opacity', 02:45:48 INFO - 'tart', 02:45:48 INFO - 'tscrollx', 02:45:48 INFO - 'cart', 02:45:48 INFO - 'tsvg_static']}, 02:45:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:45:48 INFO - 'talos_options': ['--disable-e10s'], 02:45:48 INFO - 'tests': ['tp5o']}, 02:45:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:45:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:45:48 INFO - 'talos_options': ['--disable-e10s', 02:45:48 INFO - '--xperf_path', 02:45:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:48 INFO - 'tests': ['tp5n']}, 02:45:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:45:48 INFO - 'talos_options': ['--xperf_path', 02:45:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:48 INFO - 'tests': ['tp5n']}}, 02:45:48 INFO - 'talos.zip': {'path': '', 02:45:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:45:48 INFO - Running post-action listener: _resource_record_post_action 02:45:48 INFO - [mozharness: 2017-05-04 09:45:48.558364Z] Finished populate-webroot step (success) 02:45:48 INFO - [mozharness: 2017-05-04 09:45:48.558452Z] Running create-virtualenv step. 02:45:48 INFO - Running pre-action listener: _resource_record_pre_action 02:45:48 INFO - Running main action method: create_virtualenv 02:45:48 INFO - Creating virtualenv /builds/slave/test/build/venv 02:45:48 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 02:45:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:45:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:45:48 INFO - Using real prefix '/usr' 02:45:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:45:49 INFO - Installing distribute.............................................................................................................................................................................................done. 02:45:51 INFO - Installing pip.................done. 02:45:51 INFO - Return code: 0 02:45:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:45:51 INFO - Reading from file tmpfile_stdout 02:45:51 INFO - Output received: 02:45:51 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) 02:45:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:51 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1ea01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', '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 02:45:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:45:51 INFO - Using env: {'DISPLAY': ':0', 02:45:51 INFO - 'HOME': '/home/cltbld', 02:45:51 INFO - 'LANG': 'en_US.UTF-8', 02:45:51 INFO - 'LANGUAGE': 'en_US:en', 02:45:51 INFO - 'LOGNAME': 'cltbld', 02:45:51 INFO - 'MAIL': '/var/mail/cltbld', 02:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:51 INFO - 'MOZ_NO_REMOTE': '1', 02:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:51 INFO - 'NO_EM_RESTART': '1', 02:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:51 INFO - 'PWD': '/builds/slave/test', 02:45:51 INFO - 'SHELL': '/bin/bash', 02:45:51 INFO - 'SHLVL': '1', 02:45:51 INFO - 'TERM': 'linux', 02:45:51 INFO - 'TMOUT': '86400', 02:45:51 INFO - 'USER': 'cltbld', 02:45:51 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:51 INFO - '_': '/tools/buildbot/bin/python'} 02:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:51 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 02:45:51 INFO - Cleaning up... 02:45:51 INFO - Return code: 0 02:45:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:51 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1ea01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', '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 02:45:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:45:51 INFO - Using env: {'DISPLAY': ':0', 02:45:51 INFO - 'HOME': '/home/cltbld', 02:45:51 INFO - 'LANG': 'en_US.UTF-8', 02:45:51 INFO - 'LANGUAGE': 'en_US:en', 02:45:51 INFO - 'LOGNAME': 'cltbld', 02:45:51 INFO - 'MAIL': '/var/mail/cltbld', 02:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:51 INFO - 'MOZ_NO_REMOTE': '1', 02:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:51 INFO - 'NO_EM_RESTART': '1', 02:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:51 INFO - 'PWD': '/builds/slave/test', 02:45:51 INFO - 'SHELL': '/bin/bash', 02:45:51 INFO - 'SHLVL': '1', 02:45:51 INFO - 'TERM': 'linux', 02:45:51 INFO - 'TMOUT': '86400', 02:45:51 INFO - 'USER': 'cltbld', 02:45:51 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:51 INFO - '_': '/tools/buildbot/bin/python'} 02:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:51 INFO - Downloading/unpacking psutil>=3.1.1 02:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:45:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:52 INFO - Installing collected packages: psutil 02:45:52 INFO - Running setup.py install for psutil 02:45:53 INFO - building 'psutil._psutil_linux' extension 02:45:53 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 02:45:53 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 02:45:53 INFO - building 'psutil._psutil_posix' extension 02:45:53 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 02:45:53 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 02:45:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:53 INFO - Successfully installed psutil 02:45:53 INFO - Cleaning up... 02:45:53 INFO - Return code: 0 02:45:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1ea01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', '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 02:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:45:53 INFO - Using env: {'DISPLAY': ':0', 02:45:53 INFO - 'HOME': '/home/cltbld', 02:45:53 INFO - 'LANG': 'en_US.UTF-8', 02:45:53 INFO - 'LANGUAGE': 'en_US:en', 02:45:53 INFO - 'LOGNAME': 'cltbld', 02:45:53 INFO - 'MAIL': '/var/mail/cltbld', 02:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:53 INFO - 'MOZ_NO_REMOTE': '1', 02:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:53 INFO - 'NO_EM_RESTART': '1', 02:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:53 INFO - 'PWD': '/builds/slave/test', 02:45:53 INFO - 'SHELL': '/bin/bash', 02:45:53 INFO - 'SHLVL': '1', 02:45:53 INFO - 'TERM': 'linux', 02:45:53 INFO - 'TMOUT': '86400', 02:45:53 INFO - 'USER': 'cltbld', 02:45:53 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:53 INFO - '_': '/tools/buildbot/bin/python'} 02:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:45:54 INFO - Installing collected packages: mozsystemmonitor 02:45:54 INFO - Running setup.py install for mozsystemmonitor 02:45:54 INFO - Successfully installed mozsystemmonitor 02:45:54 INFO - Cleaning up... 02:45:54 INFO - Return code: 0 02:45:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1ea01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', '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 02:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:45:54 INFO - Using env: {'DISPLAY': ':0', 02:45:54 INFO - 'HOME': '/home/cltbld', 02:45:54 INFO - 'LANG': 'en_US.UTF-8', 02:45:54 INFO - 'LANGUAGE': 'en_US:en', 02:45:54 INFO - 'LOGNAME': 'cltbld', 02:45:54 INFO - 'MAIL': '/var/mail/cltbld', 02:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:54 INFO - 'MOZ_NO_REMOTE': '1', 02:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:54 INFO - 'NO_EM_RESTART': '1', 02:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:55 INFO - 'PWD': '/builds/slave/test', 02:45:55 INFO - 'SHELL': '/bin/bash', 02:45:55 INFO - 'SHLVL': '1', 02:45:55 INFO - 'TERM': 'linux', 02:45:55 INFO - 'TMOUT': '86400', 02:45:55 INFO - 'USER': 'cltbld', 02:45:55 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:55 INFO - '_': '/tools/buildbot/bin/python'} 02:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:55 INFO - Downloading/unpacking jsonschema==2.5.1 02:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:45:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:56 INFO - Downloading functools32-3.2.3-2.tar.gz 02:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:45:56 INFO - warning: no files found matching '*.txt' 02:45:56 INFO - no previously-included directories found matching 'build' 02:45:56 INFO - no previously-included directories found matching 'dist' 02:45:56 INFO - no previously-included directories found matching '.git*' 02:45:56 INFO - Installing collected packages: jsonschema, functools32 02:45:56 INFO - Running setup.py install for functools32 02:45:56 INFO - warning: no files found matching '*.txt' 02:45:56 INFO - no previously-included directories found matching 'build' 02:45:56 INFO - no previously-included directories found matching 'dist' 02:45:56 INFO - no previously-included directories found matching '.git*' 02:45:56 INFO - Successfully installed jsonschema functools32 02:45:56 INFO - Cleaning up... 02:45:56 INFO - Return code: 0 02:45:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:56 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1ea01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', '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 02:45:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:45:56 INFO - Using env: {'DISPLAY': ':0', 02:45:56 INFO - 'HOME': '/home/cltbld', 02:45:56 INFO - 'LANG': 'en_US.UTF-8', 02:45:56 INFO - 'LANGUAGE': 'en_US:en', 02:45:56 INFO - 'LOGNAME': 'cltbld', 02:45:56 INFO - 'MAIL': '/var/mail/cltbld', 02:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:56 INFO - 'MOZ_NO_REMOTE': '1', 02:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:56 INFO - 'NO_EM_RESTART': '1', 02:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:56 INFO - 'PWD': '/builds/slave/test', 02:45:56 INFO - 'SHELL': '/bin/bash', 02:45:56 INFO - 'SHLVL': '1', 02:45:56 INFO - 'TERM': 'linux', 02:45:56 INFO - 'TMOUT': '86400', 02:45:56 INFO - 'USER': 'cltbld', 02:45:56 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:56 INFO - '_': '/tools/buildbot/bin/python'} 02:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:45:56 INFO - Cleaning up... 02:45:56 INFO - Return code: 0 02:45:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:56 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1ea01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', '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 02:45:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:45:56 INFO - Using env: {'DISPLAY': ':0', 02:45:56 INFO - 'HOME': '/home/cltbld', 02:45:56 INFO - 'LANG': 'en_US.UTF-8', 02:45:56 INFO - 'LANGUAGE': 'en_US:en', 02:45:56 INFO - 'LOGNAME': 'cltbld', 02:45:56 INFO - 'MAIL': '/var/mail/cltbld', 02:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:56 INFO - 'MOZ_NO_REMOTE': '1', 02:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:56 INFO - 'NO_EM_RESTART': '1', 02:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:56 INFO - 'PWD': '/builds/slave/test', 02:45:56 INFO - 'SHELL': '/bin/bash', 02:45:56 INFO - 'SHLVL': '1', 02:45:56 INFO - 'TERM': 'linux', 02:45:56 INFO - 'TMOUT': '86400', 02:45:56 INFO - 'USER': 'cltbld', 02:45:56 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:56 INFO - '_': '/tools/buildbot/bin/python'} 02:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:45:57 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 02:45:57 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 02:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:57 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 02:45:57 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 02:45:58 INFO - Downloading blobuploader-1.2.4.tar.gz 02:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:45:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:45:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:58 INFO - Downloading docopt-0.6.1.tar.gz 02:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:45:58 INFO - Installing collected packages: blobuploader, requests, docopt 02:45:58 INFO - Running setup.py install for blobuploader 02:45:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:45:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:45:58 INFO - Running setup.py install for requests 02:45:59 INFO - Running setup.py install for docopt 02:45:59 INFO - Successfully installed blobuploader requests docopt 02:45:59 INFO - Cleaning up... 02:45:59 INFO - Return code: 0 02:45:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1ea01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', '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 02:45:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:45:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:45:59 INFO - Using env: {'DISPLAY': ':0', 02:45:59 INFO - 'HOME': '/home/cltbld', 02:45:59 INFO - 'LANG': 'en_US.UTF-8', 02:45:59 INFO - 'LANGUAGE': 'en_US:en', 02:45:59 INFO - 'LOGNAME': 'cltbld', 02:45:59 INFO - 'MAIL': '/var/mail/cltbld', 02:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:59 INFO - 'MOZ_NO_REMOTE': '1', 02:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:59 INFO - 'NO_EM_RESTART': '1', 02:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:59 INFO - 'PWD': '/builds/slave/test', 02:45:59 INFO - 'SHELL': '/bin/bash', 02:45:59 INFO - 'SHLVL': '1', 02:45:59 INFO - 'TERM': 'linux', 02:45:59 INFO - 'TMOUT': '86400', 02:45:59 INFO - 'USER': 'cltbld', 02:45:59 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:59 INFO - '_': '/tools/buildbot/bin/python'} 02:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:59 INFO - Running setup.py (path:/tmp/pip-yAxnMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:59 INFO - Running setup.py (path:/tmp/pip-xM4RDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:59 INFO - Running setup.py (path:/tmp/pip-JJ3ZZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:59 INFO - Running setup.py (path:/tmp/pip-mqdQ1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:59 INFO - Running setup.py (path:/tmp/pip-qltH63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:59 INFO - Running setup.py (path:/tmp/pip-oiBRNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:00 INFO - Running setup.py (path:/tmp/pip-vC5CMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:00 INFO - Running setup.py (path:/tmp/pip-Qq_oyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:00 INFO - Running setup.py (path:/tmp/pip-o7LpUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:00 INFO - Running setup.py (path:/tmp/pip-NXpt2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:00 INFO - Running setup.py (path:/tmp/pip-gYfcvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:00 INFO - Running setup.py (path:/tmp/pip-xm10ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:00 INFO - Running setup.py (path:/tmp/pip-GoEHFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:00 INFO - Running setup.py (path:/tmp/pip-9dyW7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:00 INFO - Running setup.py (path:/tmp/pip-t3hXrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:00 INFO - Running setup.py (path:/tmp/pip-q8WY4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:00 INFO - Running setup.py (path:/tmp/pip-GwtQlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:46:00 INFO - Running setup.py install for manifestparser 02:46:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:46:00 INFO - Running setup.py install for mozcrash 02:46:00 INFO - Running setup.py install for mozdebug 02:46:01 INFO - Running setup.py install for mozdevice 02:46:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:46:01 INFO - Running setup.py install for mozfile 02:46:01 INFO - Running setup.py install for mozhttpd 02:46:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:46:01 INFO - Running setup.py install for mozinfo 02:46:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:46:01 INFO - Running setup.py install for mozInstall 02:46:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:46:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:46:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:46:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:46:01 INFO - Running setup.py install for mozleak 02:46:01 INFO - Running setup.py install for mozlog 02:46:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:46:01 INFO - Running setup.py install for moznetwork 02:46:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:46:01 INFO - Running setup.py install for mozprocess 02:46:02 INFO - Running setup.py install for mozprofile 02:46:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:46:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:46:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:46:02 INFO - Running setup.py install for mozrunner 02:46:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:46:02 INFO - Running setup.py install for mozscreenshot 02:46:02 INFO - Running setup.py install for moztest 02:46:02 INFO - Running setup.py install for mozversion 02:46:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:46:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:46:02 INFO - Cleaning up... 02:46:02 INFO - Return code: 0 02:46:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1ea01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', '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 02:46:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:46:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:02 INFO - Using env: {'DISPLAY': ':0', 02:46:02 INFO - 'HOME': '/home/cltbld', 02:46:02 INFO - 'LANG': 'en_US.UTF-8', 02:46:02 INFO - 'LANGUAGE': 'en_US:en', 02:46:02 INFO - 'LOGNAME': 'cltbld', 02:46:02 INFO - 'MAIL': '/var/mail/cltbld', 02:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:02 INFO - 'MOZ_NO_REMOTE': '1', 02:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:02 INFO - 'NO_EM_RESTART': '1', 02:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:02 INFO - 'PWD': '/builds/slave/test', 02:46:02 INFO - 'SHELL': '/bin/bash', 02:46:02 INFO - 'SHLVL': '1', 02:46:02 INFO - 'TERM': 'linux', 02:46:02 INFO - 'TMOUT': '86400', 02:46:02 INFO - 'USER': 'cltbld', 02:46:02 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:02 INFO - '_': '/tools/buildbot/bin/python'} 02:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:02 INFO - Running setup.py (path:/tmp/pip-vvXRXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:02 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)) 02:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:02 INFO - Running setup.py (path:/tmp/pip-gWgoQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:02 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)) 02:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:02 INFO - Running setup.py (path:/tmp/pip-fA0l3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:03 INFO - Running setup.py (path:/tmp/pip-SSisn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:03 INFO - Running setup.py (path:/tmp/pip-E2cwyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:03 INFO - Running setup.py (path:/tmp/pip-NjaV0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:03 INFO - Running setup.py (path:/tmp/pip-nXCUg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:03 INFO - Running setup.py (path:/tmp/pip-f25Thm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:03 INFO - Running setup.py (path:/tmp/pip-KNcuAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:03 INFO - Running setup.py (path:/tmp/pip-wOGtNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:03 INFO - Running setup.py (path:/tmp/pip-RGRSpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:03 INFO - Running setup.py (path:/tmp/pip-DpzdAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:03 INFO - Running setup.py (path:/tmp/pip-EVrgh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:03 INFO - Running setup.py (path:/tmp/pip-YqLEIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:03 INFO - Running setup.py (path:/tmp/pip-gMGWK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:03 INFO - Running setup.py (path:/tmp/pip-tuXiwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:03 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)) 02:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:03 INFO - Running setup.py (path:/tmp/pip-brAO0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:04 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)) 02:46:04 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)) 02:46:04 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)) 02:46:04 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)) 02:46:04 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:04 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:05 INFO - Downloading blessings-1.6.tar.gz 02:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:46:05 INFO - Installing collected packages: blessings 02:46:05 INFO - Running setup.py install for blessings 02:46:05 INFO - Successfully installed blessings 02:46:05 INFO - Cleaning up... 02:46:05 INFO - Return code: 0 02:46:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:05 INFO - Reading from file tmpfile_stdout 02:46:05 INFO - Current package versions: 02:46:05 INFO - argparse == 1.2.1 02:46:05 INFO - blessings == 1.6 02:46:05 INFO - blobuploader == 1.2.4 02:46:05 INFO - docopt == 0.6.1 02:46:05 INFO - functools32 == 3.2.3-2 02:46:05 INFO - jsonschema == 2.5.1 02:46:05 INFO - manifestparser == 1.1 02:46:05 INFO - mozInstall == 1.12 02:46:05 INFO - mozcrash == 1.0 02:46:05 INFO - mozdebug == 0.1 02:46:05 INFO - mozdevice == 0.50 02:46:05 INFO - mozfile == 1.2 02:46:05 INFO - mozhttpd == 0.7 02:46:05 INFO - mozinfo == 0.9 02:46:05 INFO - mozleak == 0.1 02:46:05 INFO - mozlog == 3.4 02:46:05 INFO - moznetwork == 0.27 02:46:05 INFO - mozprocess == 0.25 02:46:05 INFO - mozprofile == 0.28 02:46:05 INFO - mozrunner == 6.13 02:46:05 INFO - mozscreenshot == 0.1 02:46:05 INFO - mozsystemmonitor == 0.3 02:46:05 INFO - moztest == 0.8 02:46:05 INFO - mozversion == 1.4 02:46:05 INFO - psutil == 3.1.1 02:46:05 INFO - requests == 1.2.3 02:46:05 INFO - wsgiref == 0.1.2 02:46:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1ea01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', '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 02:46:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:46:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:05 INFO - Using env: {'DISPLAY': ':0', 02:46:05 INFO - 'HOME': '/home/cltbld', 02:46:05 INFO - 'LANG': 'en_US.UTF-8', 02:46:05 INFO - 'LANGUAGE': 'en_US:en', 02:46:05 INFO - 'LOGNAME': 'cltbld', 02:46:05 INFO - 'MAIL': '/var/mail/cltbld', 02:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:05 INFO - 'MOZ_NO_REMOTE': '1', 02:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:05 INFO - 'NO_EM_RESTART': '1', 02:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:05 INFO - 'PWD': '/builds/slave/test', 02:46:05 INFO - 'SHELL': '/bin/bash', 02:46:05 INFO - 'SHLVL': '1', 02:46:05 INFO - 'TERM': 'linux', 02:46:05 INFO - 'TMOUT': '86400', 02:46:05 INFO - 'USER': 'cltbld', 02:46:05 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:05 INFO - '_': '/tools/buildbot/bin/python'} 02:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:05 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)) 02:46:05 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)) 02:46:05 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)) 02:46:05 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)) 02:46:05 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)) 02:46:05 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)) 02:46:05 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)) 02:46:05 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)) 02:46:05 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)) 02:46:05 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)) 02:46:05 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)) 02:46:05 INFO - Cleaning up... 02:46:05 INFO - Return code: 0 02:46:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1ea01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', '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 02:46:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:46:05 INFO - Using env: {'DISPLAY': ':0', 02:46:05 INFO - 'HOME': '/home/cltbld', 02:46:05 INFO - 'LANG': 'en_US.UTF-8', 02:46:05 INFO - 'LANGUAGE': 'en_US:en', 02:46:05 INFO - 'LOGNAME': 'cltbld', 02:46:05 INFO - 'MAIL': '/var/mail/cltbld', 02:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:05 INFO - 'MOZ_NO_REMOTE': '1', 02:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:05 INFO - 'NO_EM_RESTART': '1', 02:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:05 INFO - 'PWD': '/builds/slave/test', 02:46:05 INFO - 'SHELL': '/bin/bash', 02:46:05 INFO - 'SHLVL': '1', 02:46:05 INFO - 'TERM': 'linux', 02:46:05 INFO - 'TMOUT': '86400', 02:46:05 INFO - 'USER': 'cltbld', 02:46:05 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:05 INFO - '_': '/tools/buildbot/bin/python'} 02:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:46:05 INFO - Cleaning up... 02:46:06 INFO - Return code: 0 02:46:06 INFO - Running post-action listener: _resource_record_post_action 02:46:06 INFO - Running post-action listener: _start_resource_monitoring 02:46:06 INFO - Starting resource monitoring. 02:46:06 INFO - [mozharness: 2017-05-04 09:46:06.033167Z] Finished create-virtualenv step (success) 02:46:06 INFO - [mozharness: 2017-05-04 09:46:06.033674Z] Running install step. 02:46:06 INFO - Running pre-action listener: _resource_record_pre_action 02:46:06 INFO - Running main action method: install 02:46:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:06 INFO - Reading from file tmpfile_stdout 02:46:06 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:06 INFO - Reading from file tmpfile_stdout 02:46:06 INFO - Output received: 02:46:06 INFO - Usage: mozinstall [options] installer 02:46:06 INFO - Options: 02:46:06 INFO - -h, --help show this help message and exit 02:46:06 INFO - -d DEST, --destination=DEST 02:46:06 INFO - Directory to install application into. [default: 02:46:06 INFO - "/builds/slave/test"] 02:46:06 INFO - --app=APP Application being installed. [default: firefox] 02:46:06 INFO - mkdir: /builds/slave/test/build/application 02:46:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:46:21 INFO - Reading from file tmpfile_stdout 02:46:21 INFO - Output received: 02:46:21 INFO - /builds/slave/test/build/application/firefox/firefox 02:46:21 INFO - Running post-action listener: _resource_record_post_action 02:46:21 INFO - [mozharness: 2017-05-04 09:46:21.740119Z] Finished install step (success) 02:46:21 INFO - [mozharness: 2017-05-04 09:46:21.740260Z] Running run-tests step. 02:46:21 INFO - Running pre-action listener: _resource_record_pre_action 02:46:21 INFO - Running main action method: run_tests 02:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:46:21 INFO - Python 2.7.3 02:46:21 INFO - Return code: 0 02:46:21 INFO - grabbing minidump binary from tooltool 02:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:46:21 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 0x213b290>, '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 0x213bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:46:21 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 02:46:21 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 02:46:21 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 02:46:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:46:21 INFO - Return code: 0 02:46:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:46:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:46:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:46:21 INFO - ENV: RUST_BACKTRACE is now 1 02:46:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:46:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:46:21 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/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 02:46:21 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/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 02:46:21 INFO - Using env: {'DISPLAY': ':0', 02:46:21 INFO - 'HOME': '/home/cltbld', 02:46:21 INFO - 'LANG': 'en_US.UTF-8', 02:46:21 INFO - 'LANGUAGE': 'en_US:en', 02:46:21 INFO - 'LOGNAME': 'cltbld', 02:46:21 INFO - 'MAIL': '/var/mail/cltbld', 02:46:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:46:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:21 INFO - 'MOZ_NO_REMOTE': '1', 02:46:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:21 INFO - 'NO_EM_RESTART': '1', 02:46:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:21 INFO - 'PWD': '/builds/slave/test', 02:46:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:46:21 INFO - 'RUST_BACKTRACE': '1', 02:46:21 INFO - 'SHELL': '/bin/bash', 02:46:21 INFO - 'SHLVL': '1', 02:46:21 INFO - 'TERM': 'linux', 02:46:21 INFO - 'TMOUT': '86400', 02:46:21 INFO - 'USER': 'cltbld', 02:46:21 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648', 02:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:21 INFO - '_': '/tools/buildbot/bin/python'} 02:46:21 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/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 02:46:22 INFO - mozversion application_buildid: 20170504091347 02:46:22 INFO - mozversion application_changeset: a8d597ee6dd58306e62e55a07c4ab20958726d6a 02:46:22 INFO - mozversion application_display_name: Nightly 02:46:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:46:22 INFO - mozversion application_name: Firefox 02:46:22 INFO - mozversion application_remotingname: firefox 02:46:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:46:22 INFO - mozversion application_vendor: Mozilla 02:46:22 INFO - mozversion application_version: 55.0a1 02:46:22 INFO - mozversion platform_buildid: 20170504091347 02:46:22 INFO - mozversion platform_changeset: a8d597ee6dd58306e62e55a07c4ab20958726d6a 02:46:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:46:22 INFO - mozversion platform_version: 55.0a1 02:46:22 INFO - using testdate: 1493891182 02:46:22 INFO - actual date: 1493891182 02:46:22 INFO - starting webserver on 'localhost:57528' 02:46:22 INFO - SUITE-START | Running 2 tests 02:46:22 INFO - TEST-START | dromaeo_css 02:46:22 INFO - operating with platform_type : linux_ 02:46:22 INFO - Initialising browser for dromaeo_css test... 02:46:22 INFO - TEST-INFO | started process 25228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRrPRJA/profile http://localhost:57528/getInfo.html) 02:46:26 INFO - PID 25228 | __metrics Screen width/height:1600/1200 02:46:26 INFO - PID 25228 | colorDepth:24 02:46:26 INFO - PID 25228 | Browser inner width/height: 1024/695 02:46:26 INFO - PID 25228 | __metrics 02:46:28 INFO - TEST-INFO | 25228: exit 0 02:46:28 INFO - Browser initialized. 02:46:28 INFO - Running cycle 1/1 for dromaeo_css test... 02:46:28 INFO - TEST-INFO | started process 25420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRrPRJA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:40 INFO - PID 25420 | RSS: Main: 174600192 02:46:40 INFO - PID 25420 | 02:49:46 INFO - PID 25420 | Cycle 1(1): loaded http://localhost:57528/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57528/tests/dromaeo/cssquery-ext.html) 02:49:47 INFO - PID 25420 | RSS: Main: 182996992 02:49:47 INFO - PID 25420 | 02:52:49 INFO - PID 25420 | Cycle 1(1): loaded http://localhost:57528/tests/dromaeo/cssquery-ext.html (next: http://localhost:57528/tests/dromaeo/cssquery-jquery.html) 02:52:50 INFO - PID 25420 | RSS: Main: 179605504 02:52:50 INFO - PID 25420 | 02:55:52 INFO - PID 25420 | Cycle 1(1): loaded http://localhost:57528/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57528/tests/dromaeo/cssquery-mootools.html) 02:55:52 INFO - PID 25420 | RSS: Main: 187834368 02:55:52 INFO - PID 25420 | 02:58:54 INFO - PID 25420 | Cycle 1(1): loaded http://localhost:57528/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57528/tests/dromaeo/cssquery-prototype.html) 02:58:55 INFO - PID 25420 | RSS: Main: 181084160 02:58:55 INFO - PID 25420 | 03:01:58 INFO - PID 25420 | Cycle 1(1): loaded http://localhost:57528/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57528/tests/dromaeo/cssquery-yui.html) 03:01:59 INFO - PID 25420 | RSS: Main: 186822656 03:01:59 INFO - PID 25420 | 03:05:00 INFO - PID 25420 | Cycle 1(1): loaded http://localhost:57528/tests/dromaeo/cssquery-yui.html (next: http://localhost:57528/tests/dromaeo/cssquery-dojo.html) 03:05:01 INFO - PID 25420 | RSS: Main: 188723200 03:05:01 INFO - PID 25420 | 03:05:01 INFO - PID 25420 | __start_tp_report 03:05:01 INFO - PID 25420 | _x_x_mozilla_page_load 03:05:01 INFO - PID 25420 | _x_x_mozilla_page_load_details 03:05:01 INFO - PID 25420 | |i|pagename|runs| 03:05:01 INFO - PID 25420 | |0;dojo.html;2746.8351898886067;2751.092139593934;2773.833569985801;2784.4152727927135;2791.665000199975;5124.154514505102;5295.31160949077;5302.416734159239;5330.413654498012;5355.8393248202565;5217.37391513019;5285.418603953562;5296.867578310545;5300.840974770754;5361.3834409042975;4640.0255946251245;4647.488776234612;4652.162610730067;4670.509596492353;4686.578207961283;4723.504032076634;4734.289856521515;4737.407824021997;4758.405199350082;4775.904481910377;4569.771511424448;4628.745419001953;4651.906961860744;4703.576678098988;4733.360996265495;4757.476677565465;4761.381020467352;4772.832950846739;4788.425388953313;4822.252550854588;4676.50896655853;4724.45668748095;4726.409198850144;4733.053389322149;4771.737554434505;5071.619628527875;5118.795248190068;5137.8201762938115;5224;5264;5793.65238085712;5799.971000144972;5821.621594596338;5848.853778655525;5857.619254748428;5799.5650326225705;5815.88368232633;5821.53427725781;5824.068149096167;5843.5325173985975;5278.076336641073;5327.680339179662;5364.195370694349;5380.139177731544;5389.51494365509;5809.244798176294;5863.765449382062;5865.090910908816;5895.705214739246;5914.526837852962;5546.833594992076;5595.804146854841;5610;5638.436156384329;5701.572382071361;5700.486956173964;5780.306363236355;5782.277215348082;5799.971000145057;5806.071028635398;5551.195076713854;5632;5716.857078573069;5733.713314334266;5740.827775166752;5675.602707810496;5764.875849209364;5772.826815195551;5782.335031471351;5802.042662960649;4803.375561177025;4808.927866082012;4816.386510518945;4816.470188279286;4819.325294458778;4069.0437747129995;4074.3888416737727;4090.6931980101613;4092.1611069730634;4145.813438395279;4839.41926968766;4860.708357498562;4867.440244371943;4874.707517548958;4902.994886048352;5593.440655934455;5625.971870140623;5718.685472299064;5741.1388291756575;5776.595638305363;4817.638677099231;4862.5380588844;4863.95136048635;4864.0028794097125;4865.416150061945;5085.46602606721;5091.541761241506;5096.133657278272;5096.286519887219;5097.413797413271;5278.947210527999;5284.233786100917;5284.788608455772;5293.57651387888;5304.655197412233;5727.31272247333;5739.5695322850115;5755.5971082025535;5760.510356619734;5766;5244.1085015548215;5273.419923808455;5275.973620132028;5280.577553795764;5296.788128474818;5610.803621873215;5629.746661400329;5661.915071273852;5713.371529131709;5737.74180161902;5716.742746576498;5727.31272247333;5731.541476681772;5734.913976290442;5739.397363276796;5463.31708536433;5499.972500137474;5512.448755124456;5521.337439507124;5541.750621222135;5566;5595.748191331319;5616.466435688603;5640.238567793295;5659.518940889906;5429.40276569585;5432.402435732145;5436.075867102523;5461.644993075437;5471.534919531884;5519.365272993497;5597.42302794207;5608;5611.354694210218;5663.57523185771;5372.892542149057;5384.21928820311;5439.048166570913;5439.5648348132845;5439.5920305978 03:05:01 INFO - PID 25420 | |1;ext.html;689.5104475822166;739.5008369350688;761.033487470912;1063.4151216830746;1088.395940253159;32453.350932981357;33378.83310583447;33458;33488.16279593005;33494;34800.47799283006;35092.12269693259;35139;35209.295814083765;35282.82358588203;6903.620300883449;6912.412444942161;7029.683664235096;7048.0837491126085;7097.325754053357;7017.789466315993;7067.929320706804;7070.434365250768;7103.964480177618;7134.108236470442;7016.543924644907;7154.391876690487;7159.749408770694;7161.785146445589;7172.9641351793425;7111.1822140454;7125.572465652026;7139.964300178518;7141.464390170758;7144.67848946796;7001.05485759421;7026.402755765715;7029.578225306498;7030.543014704028;7060.152781666182;31901;31918.521222181687;31958.20104497383;32065.358692826012;32176.839115804505;2990.2524368907775;3022.909312720622;3036.316828713544;3047.923801904948;3049.9542506862413;24910.750892491025;25020.49959000828;25095.121670741435;25157.62263566048;25254.368640783945;2992.2668946108124;3016.0499442675487;3028.21266470717;3037.3014206732355;3055.724984751383;141432.29283853516;141669;153697;157218;157492.99999999886;39886.800565996986;40012;40061.39907901384;40105;40134;42224.57775422268;42435.363469547985;42523.787381063514;42627.36058959118;42701.786491067345;10981.780364392667;11071.612493562687;11106.888931110747;11143.108551315876;11161.665150045512;8981.820363592691;9114.726558203265;9117.133872282122;9124;9156.6795162169;13069.477220911058;13215.21594584738;13304.268265245311;13336.599902002956;13503;5288.127458969304;5326.36083669962;5330.946690533123;5419.485148910847;5432.375276843213;872.616048938465;907.5507623726297;929.7582628516499;943.9008904065112;962.6101428921158;19236.80763192378;19546.90226548858;19901.502462438555;20092.69860952087;20159.697604535944;988.5106872098214;998.4009594243396;1004.3421558878946;1009.8030883977701;1028.922830787694;10007.299489035697;10563.524641391155;10694.893051069545;10703.25077244601;10834.566617335218;157068;158654;159398;159436;160251;45536.3169552457;45776.313355299695;45965.310520342224;46035.53964460312;46058.30912536314;1266.0567876931561;1266.9746605067846;1271.0403645247593;1271.5422447918743;1291.438224372401;25029.624555631315;25158.874205628854;26355.60466593041;26486.337841554116;26509.204723858315;28522.286942826595;36916.26167476582;37629.435558467194;37651.246975060894;37818.62181378261;159228;160731;160866;161166;161263.19368403082;30322.545161823033;31002.224944376572;31136.68863311338;31173.220669483446;31362.529562057043;35719.46420803742;36338.27323453569;37245;37384.252314954094;37811.81094094512;28209.294767630152;28363.149105526867;28588.857055714587;28821.42357152887;29423;27730.584041238995;27773.58339624867;28078.719212808428;28518.42963140767;28932;31895.043148705576;31908.680913190572;31923.68076319207;31998;32009.35981280408;27211.31971700644;27380.452390951672;27462.862685686443;27852.72147278501;28444.146675599764;22087.558248835256;22959.65560516627;23030.654540182244;23048.4237894054;23057.884710576338 03:05:01 INFO - PID 25420 | |2;jquery.html;415.1820912801783;417.3447687131205;430.5995424255442;436.64195359804955;439.2094230385306;16623.66752664946;17304;18083.728744068834;18106.366277180285;18182.545436364097;16577;16615.335386584524;16823.074730889795;18190.588434207057;18389.632207355844;5395.244665746799;5421.701806400646;5449.536789372888;5527.695976721278;5582.609217354787;5448.509634132927;5465.9180112298345;5501.092319767234;5531.834044978637;5533.3083364579425;5457.345118585776;5474.91787623186;5494.835154945338;5495.587830912677;5516.531094856942;5321.680699158062;5433.375161856397;5472.7263636818;5481.232627432163;5498.065328894098;4793.209120495114;4928.7535623219055;4940.950590494085;4964.429090654585;4970.627202959757;21107.47231319214;21743;21758.564828703496;21896.671549926763;21974.450638734;1635.6319828038716;1679.7732306138637;1680.8907421017595;1683.1668324179486;1684.4609724888041;14074.2962851857;14659.926700366537;14736.631584210374;14754.557363279118;14916.105033697904;2071.399294204679;2119.279444988696;2147.4631342164457;2157.4067131538795;2166.0252886201274;78439.60780196119;87046;89810;96195.9999999993;98251.50874245654;10929.234953553176;11116.833247501294;11175.608853690244;11244.49399777012;11326.207165498501;15310.770338444932;15347.309371078329;15364.692706145814;15376.154311512973;15380.30788614515;6926.783429302574;7106.964465177744;7234.457415693844;7240;7272.272772722686;6042.6978651067275;6134.294556126013;6187.504999600022;6294;6299.590526615755;6936.514443988873;6995.635851009004;7024.5082844200415;7029.824254393681;7266.781996540112;2078.5011597216558;2089.798365939591;2123.4585180778804;2127.1704035426196;2166.71832661753;873.2839071960931;902.8871391076116;904.0642934562827;906.6328137104483;932.3194068330157;16788.83211167897;16862.494125176265;17233.913830430767;17382.826171738372;17485.562860928578;880.4497189256715;885.751989442957;899.3569597737649;901.8421776189141;915.3318077803241;9278.95360523193;9467.059252853149;9702.854457183148;9707.514624268759;9758.219342452587;349980;354309.34061264136;355426;356848;357886;72584.63707681533;74187.62906185434;74723;75556;75644.62177689077;1059.142094903131;1081.929674571166;1107.2581370481796;1111.360967443723;1116.609186784619;14622.92688536593;14680.926595366955;14729.779053313994;14817;15299.617509561906;38514.229715404974;38982.4152637705;39672;39798.60201398065;40016.79991600024;46351.76824115858;46354;46410;46517.302240465746;46720.766396167804;8461;8528.445651032664;8564.229219370287;8737.43206691563;8928.241099506615;13181.60455186346;13360.398782055025;13409.932950335186;13464.798028029392;13473.461061557427;10727.356358618508;11528.538858445569;11667.883321166679;12078.456469459072;12144.696382590506;9955.552000159865;10010;10023.749406264902;10039.598416063276;10056.849147262943;10956.616518422135;11085.224034317844;11310.095192384424;11503.137264705014;11708.180427370344;8436.873446898178;8524.147585241675;8589.355798315026;8696.521691306785;8707.259882910024;11294.265872718248;11303.660890173307;11462.197646164688;11675.708107297385;11967.880321197024 03:05:01 INFO - PID 25420 | |3;mootools.html;1241.112604487791;1308.9214647121173;1318.7626227279093;1327;1327.8978447888253;9725.562349694263;10102.4443655599;10143.594256229742;10175.287729858903;10332.535035923383;10145.442000689978;10300.536475858586;10321.793564128731;10328.845067323997;10363.378197308166;2294.5066810635753;2331.4171457135717;2333.0317918063984;2334.941626459335;2340;2206.9558608827815;2269.795718385345;2274.9772502275014;2280.384296240014;2288.794008539231;2247.955040899181;2252.718410198725;2300.1374484568287;2302.2172461363134;2303.49323148907;2156.0621129808505;2162.675598660198;2214.059024914413;2215.3353993801957;2220.3449982255274;2078.490769761403;2199.175309259028;2205.349421920537;2210.8673479591275;2212.723409573803;9851.704448866545;9934.105930466221;9937.80124397508;9939.453330066843;9955.601775928953;5472.699001554913;5668.376478587352;5679.318481782213;5694.658320500742;5711.114777209539;3242.789218700777;3492.6681965213265;3532.7703699259723;3540.2211513466996;3570.553680789901;1077.9059254856327;1096.7861267052929;1109.2567979453786;1129.4578602270874;1129.6554550861983;14550.927245363811;14594.197319147443;14632.780508292492;14675.559733208021;14698.412063517446;4631.235846085426;4818.8795280118275;4957.132501812169;5008.524190201925;5028.472010438924;10816.945915270373;10864;10872.238943273895;10916.399598022184;10931.890681093088;5488.890222195534;5494.2857428534035;5498.010358135494;5500.092484739973;5504.311961004874;4937.21004639256;5044.596432285409;5046.1169295373165;5059.595232381401;5114.539691427789;3516.7186625069935;3629.1471504196493;3689.870854520079;3713.4801127842125;3715.405535114423;1084.810158222308;1090.3185509056839;1115.642994241851;1115.9218854680257;1130.4856290387854;675.7297081167573;695.4505940307201;698.6611493425685;714.7105422303976;725.9020032295679;5072.797088116434;5181.4559471255725;5204.141316682781;5297;5314.123169677037;552.2820333566348;561.9325680918316;571.1404336473581;571.871328950991;573.3643492364199;3143.4927808165153;3159.273367125574;3414.1805966567845;3513.1568423578155;3530.2409981854025;12514.3742812859;12949;13171.73656526864;13213.933930330288;13248.735025299633;12577.18248313875;12919.160254583421;13067.411966461532;13318.400671969785;13385.263810490516;7709.730159444504;7788.610569471503;7901.762947111481;7901.960490197627;7937.3650107991225;5493.890122197614;5576.163575463713;5619.241402410622;5928.851778705567;5930.614510056833;11377.54489820431;11681.591144309908;11711.88288117108;11720.94139529331;11817.586384476503;11775.705607359885;11994.820077699016;12066.39668016578;12161.635150945485;12173.75652486963;7653.464257502144;8114.269715725613;8213.753587392388;8233.641449160821;8285.875711864206;8955;9201.493917834316;9218.677346292847;9219.03200163973;9221.123993220634;7626.504277221963;8002;8368.330533557422;8388.958055209685;8412.579371031547;7785.727499537489;7913.050433947733;8037.075736290401;8044.637991290523;8080.636371363185;6766.560173588701;6892.620905850226;6900.03399524077;6922.134733158356;6936.34104760047;4501.864944051684;4572.291294849304;4594.632429405573;5039.244113383022;5066.645334826527;4940.357753492023;5033.345665063518;5073.2897394365555;5081.898362032813;5120.590352771844 03:05:01 INFO - PID 25420 | |4;prototype.html;361.5968195462059;370.9054191181248;375.457463964571;389.06235971309144;395.8535341923488;5393.1370980643105;5568.888622227553;5711.228984087152;5712.400197979209;5722.6280291781;5381.730913454331;5519.475649813261;5524.392316845154;5552.639078459897;5597.272354593907;4389.714668546542;4394.824207031731;4401.163778882018;4405.911881762363;4407.853957970935;4311.943573824417;4369.584889435499;4390.5609439056;4429.800658970338;4434.246178149722;4380.5838445347645;4382.824687012531;4384.18892504886;4392.3191905254735;4409.29451287794;4378.8029538670835;4398.7580683062415;4403.603675669189;4407.449068866392;4418.4256046714045;3921.490206273166;3958.2083583283456;3989.501312335958;3991.3813358929124;4000.4999375078114;5325.920111198335;5342.813001544927;5348.946510534884;5361.865953351158;5383.757730902119;5228.816991405282;5246.239295302198;5248.265242866002;5268.420473747885;5268.631195816294;5588.720563971785;5800.245968024172;5886.941130588682;5897.823065308047;5921.934051870661;4043.2722110020186;4060.248853961997;4065.6950728695465;4067.430559721641;4074;6066.332703402622;6238.376162383771;6245.281792593864;6297.433231009231;6314.0844577536;4150.792460376969;4151.484708081529;4158.625723684883;4170.812313445902;4172.958270417318;4192.3082691355585;4243.469566304212;4243.490781106287;4249.235137675249;4252.4046633471335;4769.499202583748;4839.322494850724;4892.363992680928;4897.094037603055;4899.240617704261;5872.853178670482;5872.911906321408;5889.469947704727;5889.617174883619;5900.7049647518315;1428.649980754701;1433.2332202271944;1438.216172186161;1443.4226309476294;1446.797448357231;962.2734835199379;970.4807927758616;977.5600979559226;979.2166266986383;983.2822039910905;5137.227656458515;5137.306463627438;5151.9484805152215;5165.612579056586;5198.740062996835;6104.694765261719;6121.755129794758;6138.815835524942;6141.907871381933;6146.446819786241;4973.154563724175;5079.593632509391;5114.948850511447;5124.256982737482;5148.704828909501;3229.176559977238;3257.120577444124;3257.153140183522;3257.9022629321157;3271.362084393568;5534.418886016911;5667.971660141756;5671.404502527175;5675.708089308191;5703.8859222816145;6270.623762574261;6304.9912014078445;6306.65313407767;6308.842278943063;6334.651594162273;5640.210370548045;5689.68706721126;5709.628874123168;5711.286089238845;5711.428857114339;5972.25346831646;6073.757049717962;6100.572959892765;6119.632822030692;6145.784897528565;5808.767649293981;6018.645804693909;6034.969825150846;6036.275646922398;6054.485368743706;5669.801556945487;5672.517835983823;5689.2319536862;5721.1990321354215;5729.942700572941;4105.425240466397;4138.544760076329;4138.627523522898;4156.459660244149;4169.60388763067;6013.308469525886;6172.321044684992;6182.072689096492;6186.412290832363;6196.47329976957;5901.203337549376;5906.26171728534;5925.748335506082;5934.169216309807;5937.406259374028;5697;5892.499137573354;5895.9705201475435;5898.705064746831;5931;5743.310802703702;5799.565032622654;5841.211436456024;5850.683596190823;5854.326752423526;5931.288245410578;5950.464458198783;5955.166276721349;5957.523398128053;5974;5586.888262234814;5771.5671324649975;5775.133729940542;5795.82612521625;5817.476427121579 03:05:01 INFO - PID 25420 | |5;yui.html;670.4703284405321;698.9196242432121;702.5328156775741;704.067111077822;704.3555147040458;12476.438560264787;12973.935130324347;13014.219146851183;14863.702725945475;16070.116143612126;14853.331600077996;15229.390824367012;15475.071495710265;15482.84517154828;15878.603034924105;894.8434024045798;912.771807048238;916.6883259691704;916.9679061232858;918.2516249256835;901.4906577783531;928.3316012471043;928.6842473558988;929.1173385283973;934.4766930518897;977.6822532676908;980;980.1423754215061;980.7940332530142;981.1464026297095;976.2434113561975;976.7313988653107;977.2719324103552;979.7991411760572;981.5779214937573;713.2938390992931;715.3347386930153;718.1095441652366;718.2135561560135;721.4949535325293;13746;13908.721825563533;13918.164910105426;14134.434622615083;14746.336414861356;14093.365798539091;14207.786883196657;14318.64203394913;14541.927290363587;14587.854121458755;11722.413879306087;11953.342566158857;12010.399480025964;12046.096542759327;12097.395130243453;2857.4856525825344;2878.5250433678625;2884.120343295294;2886.3649997000625;2909.214512081747;70049.64975175091;70204.64897675479;70355;71241.6437917807;72073.2792672077;12197.817032744517;12388;12479.875201248053;12497.25016499013;12526.74946501065;20839;22063.11747530113;22198.778012219995;22293.888530557244;22493.887530562242;6277.654728989858;6345.302016778151;6351.2060992375955;6512.153420055362;6551.39490824751;3066.3100802319746;3110.2379916920045;3128.749700023993;3131.4519959007084;3142.9214269642985;3377.105067157205;3429.1941393772445;3458.152752575635;3463.428534291814;3497.3529896968635;667.2693400726197;675.1796567170911;675.7567275780814;677.2381071294793;682.5972676121013;584.3046774338524;597.0745344715673;599.8170557979859;603.0742809786956;616.9691515424211;8762;9044.954775226213;9263.444193348421;9407.717768466957;9780.853287200698;582.4728620598365;592.5141384065112;594.76209516193;600.7957294519884;602.4638072115821;4147.709660323809;4220.767857767853;4222.366645003212;4252.064545799919;4270.850520231777;57248;58392.7080364604;59869.10196347058;60188;60747.392526075055;53841.73079134658;54030.729846350514;54278.18582721263;54400;55742;49308.50691493111;49828;50168.247476287885;51074.74462627663;51470.485295147315;8691.565421728761;8711.825763484569;8738.995015573291;8963.641454341754;8985.146411090936;25116;26078;26178.60732088982;26465.206043818715;27357;31227.53158702576;31463.685363146076;31574.842125789222;32108.19729506781;32262.838685806422;11787.705307367385;12107.273563586214;12151.635450936486;12195.390230488618;12368.567100151451;12767.680807979876;12829.61511154667;12853.036022298178;12914.354282286036;13114.475420983053;11289.604863829727;11465.082793376343;11553;11664.708382290512;11723.296602203895;11469.025132863466;11508.48211830453;11515.424228788695;11593.362365070003;11690.240134391237;11231.326120432801;11322.207445479067;11409;11457.796931322424;11610.825837612274;8805.207531322212;9132.49771262587;10499.370037797757;10785.784284314426;10850.348979061282;11319.698234703115;11521;11795.233309834834;11857;11954.701132471759 03:05:01 INFO - PID 25420 | __end_tp_report 03:05:01 INFO - PID 25420 | __start_cc_report 03:05:01 INFO - PID 25420 | _x_x_mozilla_cycle_collect,361 03:05:01 INFO - PID 25420 | __end_cc_report 03:05:01 INFO - PID 25420 | __startTimestamp1493892301214__endTimestamp 03:05:01 INFO - PID 25420 | 03:05:01 INFO - PID 25420 | ------- Summary: start ------- 03:05:01 INFO - PID 25420 | Number of tests: 6 03:05:01 INFO - PID 25420 | 03:05:01 INFO - PID 25420 | [#0] dojo.html Cycles:165 Average:5226.67 Median:5364.20 stddev:620.70 (11.6%) stddev-sans-first:591.34 03:05:01 INFO - PID 25420 | Values: 2746.8 2751.1 2773.8 2784.4 2791.7 5124.2 5295.3 5302.4 5330.4 5355.8 5217.4 5285.4 5296.9 5300.8 5361.4 4640.0 4647.5 4652.2 4670.5 4686.6 4723.5 4734.3 4737.4 4758.4 4775.9 4569.8 4628.7 4651.9 4703.6 4733.4 4757.5 4761.4 4772.8 4788.4 4822.3 4676.5 4724.5 4726.4 4733.1 4771.7 5071.6 5118.8 5137.8 5224.0 5264.0 5793.7 5800.0 5821.6 5848.9 5857.6 5799.6 5815.9 5821.5 5824.1 5843.5 5278.1 5327.7 5364.2 5380.1 5389.5 5809.2 5863.8 5865.1 5895.7 5914.5 5546.8 5595.8 5610.0 5638.4 5701.6 5700.5 5780.3 5782.3 5800.0 5806.1 5551.2 5632.0 5716.9 5733.7 5740.8 5675.6 5764.9 5772.8 5782.3 5802.0 4803.4 4808.9 4816.4 4816.5 4819.3 4069.0 4074.4 4090.7 4092.2 4145.8 4839.4 4860.7 4867.4 4874.7 4903.0 5593.4 5626.0 5718.7 5741.1 5776.6 4817.6 4862.5 4864.0 4864.0 4865.4 5085.5 5091.5 5096.1 5096.3 5097.4 5278.9 5284.2 5284.8 5293.6 5304.7 5727.3 5739.6 5755.6 5760.5 5766.0 5244.1 5273.4 5276.0 5280.6 5296.8 5610.8 5629.7 5661.9 5713.4 5737.7 5716.7 5727.3 5731.5 5734.9 5739.4 5463.3 5500.0 5512.4 5521.3 5541.8 5566.0 5595.7 5616.5 5640.2 5659.5 5429.4 5432.4 5436.1 5461.6 5471.5 5519.4 5597.4 5608.0 5611.4 5663.6 5372.9 5384.2 5439.0 5439.6 5439.6 03:05:01 INFO - PID 25420 | 03:05:01 INFO - PID 25420 | [#1] ext.html Cycles:180 Average:30758.95 Median:31628.79 stddev:40446.44 (127.9%) stddev-sans-first:40496.88 03:05:01 INFO - PID 25420 | Values: 689.5 739.5 761.0 1063.4 1088.4 32453.4 33378.8 33458.0 33488.2 33494.0 34800.5 35092.1 35139.0 35209.3 35282.8 6903.6 6912.4 7029.7 7048.1 7097.3 7017.8 7067.9 7070.4 7104.0 7134.1 7016.5 7154.4 7159.7 7161.8 7173.0 7111.2 7125.6 7140.0 7141.5 7144.7 7001.1 7026.4 7029.6 7030.5 7060.2 31901.0 31918.5 31958.2 32065.4 32176.8 2990.3 3022.9 3036.3 3047.9 3050.0 24910.8 25020.5 25095.1 25157.6 25254.4 2992.3 3016.0 3028.2 3037.3 3055.7 141432.3 141669.0 153697.0 157218.0 157493.0 39886.8 40012.0 40061.4 40105.0 40134.0 42224.6 42435.4 42523.8 42627.4 42701.8 10981.8 11071.6 11106.9 11143.1 11161.7 8981.8 9114.7 9117.1 9124.0 9156.7 13069.5 13215.2 13304.3 13336.6 13503.0 5288.1 5326.4 5330.9 5419.5 5432.4 872.6 907.6 929.8 943.9 962.6 19236.8 19546.9 19901.5 20092.7 20159.7 988.5 998.4 1004.3 1009.8 1028.9 10007.3 10563.5 10694.9 10703.3 10834.6 157068.0 158654.0 159398.0 159436.0 160251.0 45536.3 45776.3 45965.3 46035.5 46058.3 1266.1 1267.0 1271.0 1271.5 1291.4 25029.6 25158.9 26355.6 26486.3 26509.2 28522.3 36916.3 37629.4 37651.2 37818.6 159228.0 160731.0 160866.0 161166.0 161263.2 30322.5 31002.2 31136.7 31173.2 31362.5 35719.5 36338.3 37245.0 37384.3 37811.8 28209.3 28363.1 28588.9 28821.4 29423.0 27730.6 27773.6 28078.7 28518.4 28932.0 31895.0 31908.7 31923.7 31998.0 32009.4 27211.3 27380.5 27462.9 27852.7 28444.1 22087.6 22959.7 23030.7 23048.4 23057.9 03:05:01 INFO - PID 25420 | 03:05:01 INFO - PID 25420 | [#2] jquery.html Cycles:180 Average:24339.00 Median:39327.21 stddev:59190.38 (150.5%) stddev-sans-first:59329.17 03:05:01 INFO - PID 25420 | Values: 415.2 417.3 430.6 436.6 439.2 16623.7 17304.0 18083.7 18106.4 18182.5 16577.0 16615.3 16823.1 18190.6 18389.6 5395.2 5421.7 5449.5 5527.7 5582.6 5448.5 5465.9 5501.1 5531.8 5533.3 5457.3 5474.9 5494.8 5495.6 5516.5 5321.7 5433.4 5472.7 5481.2 5498.1 4793.2 4928.8 4941.0 4964.4 4970.6 21107.5 21743.0 21758.6 21896.7 21974.5 1635.6 1679.8 1680.9 1683.2 1684.5 14074.3 14659.9 14736.6 14754.6 14916.1 2071.4 2119.3 2147.5 2157.4 2166.0 78439.6 87046.0 89810.0 96196.0 98251.5 10929.2 11116.8 11175.6 11244.5 11326.2 15310.8 15347.3 15364.7 15376.2 15380.3 6926.8 7107.0 7234.5 7240.0 7272.3 6042.7 6134.3 6187.5 6294.0 6299.6 6936.5 6995.6 7024.5 7029.8 7266.8 2078.5 2089.8 2123.5 2127.2 2166.7 873.3 902.9 904.1 906.6 932.3 16788.8 16862.5 17233.9 17382.8 17485.6 880.4 885.8 899.4 901.8 915.3 9279.0 9467.1 9702.9 9707.5 9758.2 349980.0 354309.3 355426.0 356848.0 357886.0 72584.6 74187.6 74723.0 75556.0 75644.6 1059.1 1081.9 1107.3 1111.4 1116.6 14622.9 14680.9 14729.8 14817.0 15299.6 38514.2 38982.4 39672.0 39798.6 40016.8 46351.8 46354.0 46410.0 46517.3 46720.8 8461.0 8528.4 8564.2 8737.4 8928.2 13181.6 13360.4 13409.9 13464.8 13473.5 10727.4 11528.5 11667.9 12078.5 12144.7 9955.6 10010.0 10023.7 10039.6 10056.8 10956.6 11085.2 11310.1 11503.1 11708.2 8436.9 8524.1 8589.4 8696.5 8707.3 11294.3 11303.7 11462.2 11675.7 11967.9 03:05:01 INFO - PID 25420 | 03:05:01 INFO - PID 25420 | [#3] mootools.html Cycles:180 Average:6167.65 Median:3659.51 stddev:3974.80 (108.6%) stddev-sans-first:3968.72 03:05:01 INFO - PID 25420 | Values: 1241.1 1308.9 1318.8 1327.0 1327.9 9725.6 10102.4 10143.6 10175.3 10332.5 10145.4 10300.5 10321.8 10328.8 10363.4 2294.5 2331.4 2333.0 2334.9 2340.0 2207.0 2269.8 2275.0 2280.4 2288.8 2248.0 2252.7 2300.1 2302.2 2303.5 2156.1 2162.7 2214.1 2215.3 2220.3 2078.5 2199.2 2205.3 2210.9 2212.7 9851.7 9934.1 9937.8 9939.5 9955.6 5472.7 5668.4 5679.3 5694.7 5711.1 3242.8 3492.7 3532.8 3540.2 3570.6 1077.9 1096.8 1109.3 1129.5 1129.7 14550.9 14594.2 14632.8 14675.6 14698.4 4631.2 4818.9 4957.1 5008.5 5028.5 10816.9 10864.0 10872.2 10916.4 10931.9 5488.9 5494.3 5498.0 5500.1 5504.3 4937.2 5044.6 5046.1 5059.6 5114.5 3516.7 3629.1 3689.9 3713.5 3715.4 1084.8 1090.3 1115.6 1115.9 1130.5 675.7 695.5 698.7 714.7 725.9 5072.8 5181.5 5204.1 5297.0 5314.1 552.3 561.9 571.1 571.9 573.4 3143.5 3159.3 3414.2 3513.2 3530.2 12514.4 12949.0 13171.7 13213.9 13248.7 12577.2 12919.2 13067.4 13318.4 13385.3 7709.7 7788.6 7901.8 7902.0 7937.4 5493.9 5576.2 5619.2 5928.9 5930.6 11377.5 11681.6 11711.9 11720.9 11817.6 11775.7 11994.8 12066.4 12161.6 12173.8 7653.5 8114.3 8213.8 8233.6 8285.9 8955.0 9201.5 9218.7 9219.0 9221.1 7626.5 8002.0 8368.3 8389.0 8412.6 7785.7 7913.1 8037.1 8044.6 8080.6 6766.6 6892.6 6900.0 6922.1 6936.3 4501.9 4572.3 4594.6 5039.2 5066.6 4940.4 5033.3 5073.3 5081.9 5120.6 03:05:01 INFO - PID 25420 | 03:05:01 INFO - PID 25420 | [#4] prototype.html Cycles:180 Average:4888.46 Median:5560.76 stddev:1435.90 (25.8%) stddev-sans-first:1399.15 03:05:01 INFO - PID 25420 | Values: 361.6 370.9 375.5 389.1 395.9 5393.1 5568.9 5711.2 5712.4 5722.6 5381.7 5519.5 5524.4 5552.6 5597.3 4389.7 4394.8 4401.2 4405.9 4407.9 4311.9 4369.6 4390.6 4429.8 4434.2 4380.6 4382.8 4384.2 4392.3 4409.3 4378.8 4398.8 4403.6 4407.4 4418.4 3921.5 3958.2 3989.5 3991.4 4000.5 5325.9 5342.8 5348.9 5361.9 5383.8 5228.8 5246.2 5248.3 5268.4 5268.6 5588.7 5800.2 5886.9 5897.8 5921.9 4043.3 4060.2 4065.7 4067.4 4074.0 6066.3 6238.4 6245.3 6297.4 6314.1 4150.8 4151.5 4158.6 4170.8 4173.0 4192.3 4243.5 4243.5 4249.2 4252.4 4769.5 4839.3 4892.4 4897.1 4899.2 5872.9 5872.9 5889.5 5889.6 5900.7 1428.6 1433.2 1438.2 1443.4 1446.8 962.3 970.5 977.6 979.2 983.3 5137.2 5137.3 5151.9 5165.6 5198.7 6104.7 6121.8 6138.8 6141.9 6146.4 4973.2 5079.6 5114.9 5124.3 5148.7 3229.2 3257.1 3257.2 3257.9 3271.4 5534.4 5668.0 5671.4 5675.7 5703.9 6270.6 6305.0 6306.7 6308.8 6334.7 5640.2 5689.7 5709.6 5711.3 5711.4 5972.3 6073.8 6100.6 6119.6 6145.8 5808.8 6018.6 6035.0 6036.3 6054.5 5669.8 5672.5 5689.2 5721.2 5729.9 4105.4 4138.5 4138.6 4156.5 4169.6 6013.3 6172.3 6182.1 6186.4 6196.5 5901.2 5906.3 5925.7 5934.2 5937.4 5697.0 5892.5 5896.0 5898.7 5931.0 5743.3 5799.6 5841.2 5850.7 5854.3 5931.3 5950.5 5955.2 5957.5 5974.0 5586.9 5771.6 5775.1 5795.8 5817.5 03:05:01 INFO - PID 25420 | 03:05:01 INFO - PID 25420 | [#5] yui.html Cycles:180 Average:14538.34 Median:3460.79 stddev:17481.99 (505.1%) stddev-sans-first:17500.02 03:05:01 INFO - PID 25420 | Values: 670.5 698.9 702.5 704.1 704.4 12476.4 12973.9 13014.2 14863.7 16070.1 14853.3 15229.4 15475.1 15482.8 15878.6 894.8 912.8 916.7 917.0 918.3 901.5 928.3 928.7 929.1 934.5 977.7 980.0 980.1 980.8 981.1 976.2 976.7 977.3 979.8 981.6 713.3 715.3 718.1 718.2 721.5 13746.0 13908.7 13918.2 14134.4 14746.3 14093.4 14207.8 14318.6 14541.9 14587.9 11722.4 11953.3 12010.4 12046.1 12097.4 2857.5 2878.5 2884.1 2886.4 2909.2 70049.6 70204.6 70355.0 71241.6 72073.3 12197.8 12388.0 12479.9 12497.3 12526.7 20839.0 22063.1 22198.8 22293.9 22493.9 6277.7 6345.3 6351.2 6512.2 6551.4 3066.3 3110.2 3128.7 3131.5 3142.9 3377.1 3429.2 3458.2 3463.4 3497.4 667.3 675.2 675.8 677.2 682.6 584.3 597.1 599.8 603.1 617.0 8762.0 9045.0 9263.4 9407.7 9780.9 582.5 592.5 594.8 600.8 602.5 4147.7 4220.8 4222.4 4252.1 4270.9 57248.0 58392.7 59869.1 60188.0 60747.4 53841.7 54030.7 54278.2 54400.0 55742.0 49308.5 49828.0 50168.2 51074.7 51470.5 8691.6 8711.8 8739.0 8963.6 8985.1 25116.0 26078.0 26178.6 26465.2 27357.0 31227.5 31463.7 31574.8 32108.2 32262.8 11787.7 12107.3 12151.6 12195.4 12368.6 12767.7 12829.6 12853.0 12914.4 13114.5 11289.6 11465.1 11553.0 11664.7 11723.3 11469.0 11508.5 11515.4 11593.4 11690.2 11231.3 11322.2 11409.0 11457.8 11610.8 8805.2 9132.5 10499.4 10785.8 10850.3 11319.7 11521.0 11795.2 11857.0 11954.7 03:05:01 INFO - PID 25420 | -------- Summary: end -------- 03:05:01 INFO - PID 25420 | 03:05:02 INFO - TEST-INFO | 25420: exit 0 03:05:02 INFO - TEST-OK | dromaeo_css | took 1120023ms 03:05:02 INFO - TEST-START | kraken 03:05:02 INFO - operating with platform_type : linux_ 03:05:02 INFO - Initialising browser for kraken test... 03:05:02 INFO - TEST-INFO | started process 25857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwmjLt1/profile http://localhost:57528/getInfo.html) 03:05:06 INFO - PID 25857 | __metrics Screen width/height:1600/1200 03:05:06 INFO - PID 25857 | colorDepth:24 03:05:06 INFO - PID 25857 | Browser inner width/height: 1024/695 03:05:06 INFO - PID 25857 | __metrics 03:05:08 INFO - TEST-INFO | 25857: exit 0 03:05:08 INFO - Browser initialized. 03:05:08 INFO - Running cycle 1/1 for kraken test... 03:05:08 INFO - TEST-INFO | started process 26044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwmjLt1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:20 INFO - PID 26044 | RSS: Main: 174895104 03:05:20 INFO - PID 26044 | 03:05:23 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57528/tests/kraken/driver.html?testName=audio-beat-detection) 03:05:24 INFO - PID 26044 | RSS: Main: 183238656 03:05:24 INFO - PID 26044 | 03:05:26 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57528/tests/kraken/driver.html?testName=audio-dft) 03:05:27 INFO - PID 26044 | RSS: Main: 182259712 03:05:27 INFO - PID 26044 | 03:05:30 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57528/tests/kraken/driver.html?testName=audio-fft) 03:05:31 INFO - PID 26044 | RSS: Main: 178716672 03:05:31 INFO - PID 26044 | 03:05:33 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57528/tests/kraken/driver.html?testName=audio-oscillator) 03:05:33 INFO - PID 26044 | RSS: Main: 179552256 03:05:33 INFO - PID 26044 | 03:05:35 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57528/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:05:36 INFO - PID 26044 | RSS: Main: 179535872 03:05:36 INFO - PID 26044 | 03:05:39 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57528/tests/kraken/driver.html?testName=imaging-darkroom) 03:05:40 INFO - PID 26044 | RSS: Main: 183660544 03:05:40 INFO - PID 26044 | 03:05:43 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57528/tests/kraken/driver.html?testName=imaging-desaturate) 03:05:44 INFO - PID 26044 | RSS: Main: 180998144 03:05:44 INFO - PID 26044 | 03:05:47 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57528/tests/kraken/driver.html?testName=json-parse-financial) 03:05:48 INFO - PID 26044 | RSS: Main: 182366208 03:05:48 INFO - PID 26044 | 03:05:49 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57528/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:05:50 INFO - PID 26044 | RSS: Main: 184025088 03:05:50 INFO - PID 26044 | 03:05:52 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57528/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:05:52 INFO - PID 26044 | RSS: Main: 184594432 03:05:52 INFO - PID 26044 | 03:05:54 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57528/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:05:55 INFO - PID 26044 | RSS: Main: 184205312 03:05:55 INFO - PID 26044 | 03:05:58 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:05:58 INFO - PID 26044 | RSS: Main: 184401920 03:05:58 INFO - PID 26044 | 03:06:02 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:02 INFO - PID 26044 | RSS: Main: 184614912 03:06:02 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | Cycle 1(1): loaded http://localhost:57528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57528/tests/kraken/driver.html?testName=ai-astar) 03:06:04 INFO - PID 26044 | RSS: Main: 186675200 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | __start_tp_report 03:06:04 INFO - PID 26044 | _x_x_mozilla_page_load 03:06:04 INFO - PID 26044 | _x_x_mozilla_page_load_details 03:06:04 INFO - PID 26044 | |i|pagename|runs| 03:06:04 INFO - PID 26044 | |0;ai-astar;104;115;113;111;113;111;111;113;112;111 03:06:04 INFO - PID 26044 | |1;audio-beat-detection;145;126;123;169;123;124;125;122;145;134 03:06:04 INFO - PID 26044 | |2;audio-dft;163;165;165;166;169;173;163;163;164;162 03:06:04 INFO - PID 26044 | |3;audio-fft;74;74;77;112;75;76;75;75;95;75 03:06:04 INFO - PID 26044 | |4;audio-oscillator;85;81;110;84;84;82;100;82;82;103 03:06:04 INFO - PID 26044 | |5;imaging-gaussian-blur;115;115;118;114;114;114;116;121;117;121 03:06:04 INFO - PID 26044 | |6;imaging-darkroom;149;154;149;151;150;149;151;149;149;151 03:06:04 INFO - PID 26044 | |7;imaging-desaturate;94;95;94;94;94;95;95;94;94;94 03:06:04 INFO - PID 26044 | |8;json-parse-financial;53;55;56;54;54;56;55;55;54;54 03:06:04 INFO - PID 26044 | |9;json-stringify-tinderbox;55;55;55;57;55;56;56;56;55;54 03:06:04 INFO - PID 26044 | |10;stanford-crypto-aes;80;83;80;80;82;81;88;81;80;85 03:06:04 INFO - PID 26044 | |11;stanford-crypto-ccm;133;138;128;131;127;131;129;143;177;136 03:06:04 INFO - PID 26044 | |12;stanford-crypto-pbkdf2;189;197;186;191;192;193;187;191;182;202 03:06:04 INFO - PID 26044 | |13;stanford-crypto-sha256-iterative;75;71;73;70;71;72;72;70;69;71 03:06:04 INFO - PID 26044 | __end_tp_report 03:06:04 INFO - PID 26044 | __start_cc_report 03:06:04 INFO - PID 26044 | _x_x_mozilla_cycle_collect,824 03:06:04 INFO - PID 26044 | __end_cc_report 03:06:04 INFO - PID 26044 | __startTimestamp1493892364777__endTimestamp 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | ------- Summary: start ------- 03:06:04 INFO - PID 26044 | Number of tests: 14 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:2.91 (2.6%) stddev-sans-first:1.39 03:06:04 INFO - PID 26044 | Values: 104.0 115.0 113.0 111.0 113.0 111.0 111.0 113.0 112.0 111.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:130.00 stddev:15.26 (11.7%) stddev-sans-first:15.62 03:06:04 INFO - PID 26044 | Values: 145.0 126.0 123.0 169.0 123.0 124.0 125.0 122.0 145.0 134.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:3.37 (2.0%) stddev-sans-first:3.47 03:06:04 INFO - PID 26044 | Values: 163.0 165.0 165.0 166.0 169.0 173.0 163.0 163.0 164.0 162.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:12.65 (16.9%) stddev-sans-first:13.17 03:06:04 INFO - PID 26044 | Values: 74.0 74.0 77.0 112.0 75.0 76.0 75.0 75.0 95.0 75.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.00 stddev:10.72 (13.1%) stddev-sans-first:11.26 03:06:04 INFO - PID 26044 | Values: 85.0 81.0 110.0 84.0 84.0 82.0 100.0 82.0 82.0 103.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:2.72 (2.3%) stddev-sans-first:2.83 03:06:04 INFO - PID 26044 | Values: 115.0 115.0 118.0 114.0 114.0 114.0 116.0 121.0 117.0 121.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.50 stddev:1.62 (1.1%) stddev-sans-first:1.66 03:06:04 INFO - PID 26044 | Values: 149.0 154.0 149.0 151.0 150.0 149.0 151.0 149.0 149.0 151.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:06:04 INFO - PID 26044 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.83 03:06:04 INFO - PID 26044 | Values: 53.0 55.0 56.0 54.0 54.0 56.0 55.0 55.0 54.0 54.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.84 (1.5%) stddev-sans-first:0.88 03:06:04 INFO - PID 26044 | Values: 55.0 55.0 55.0 57.0 55.0 56.0 56.0 56.0 55.0 54.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:2.67 (3.3%) stddev-sans-first:2.73 03:06:04 INFO - PID 26044 | Values: 80.0 83.0 80.0 80.0 82.0 81.0 88.0 81.0 80.0 85.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:134.50 stddev:14.80 (11.0%) stddev-sans-first:15.61 03:06:04 INFO - PID 26044 | Values: 133.0 138.0 128.0 131.0 127.0 131.0 129.0 143.0 177.0 136.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.00 Median:191.50 stddev:5.66 (3.0%) stddev-sans-first:5.95 03:06:04 INFO - PID 26044 | Values: 189.0 197.0 186.0 191.0 192.0 193.0 187.0 191.0 182.0 202.0 03:06:04 INFO - PID 26044 | 03:06:04 INFO - PID 26044 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.71 (2.4%) stddev-sans-first:1.22 03:06:04 INFO - PID 26044 | Values: 75.0 71.0 73.0 70.0 71.0 72.0 72.0 70.0 69.0 71.0 03:06:04 INFO - PID 26044 | -------- Summary: end -------- 03:06:04 INFO - PID 26044 | 03:06:06 INFO - TEST-INFO | 26044: exit 0 03:06:06 INFO - TEST-OK | kraken | took 64039ms 03:06:06 INFO - SUITE-END | took 1184s 03:06:06 INFO - Completed test suite (00:19:44) 03:06:06 INFO - javascript benchmark 03:06:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6703.007218978595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2746.8351898886067, 2751.092139593934, 2773.833569985801, 2784.4152727927135, 2791.665000199975, 5124.154514505102, 5295.31160949077, 5302.416734159239, 5330.413654498012, 5355.8393248202565, 5217.37391513019, 5285.418603953562, 5296.867578310545, 5300.840974770754, 5361.3834409042975, 4640.0255946251245, 4647.488776234612, 4652.162610730067, 4670.509596492353, 4686.578207961283, 4723.504032076634, 4734.289856521515, 4737.407824021997, 4758.405199350082, 4775.904481910377, 4569.771511424448, 4628.745419001953, 4651.906961860744, 4703.576678098988, 4733.360996265495, 4757.476677565465, 4761.381020467352, 4772.832950846739, 4788.425388953313, 4822.252550854588, 4676.50896655853, 4724.45668748095, 4726.409198850144, 4733.053389322149, 4771.737554434505, 5071.619628527875, 5118.795248190068, 5137.8201762938115, 5224.0, 5264.0, 5793.65238085712, 5799.971000144972, 5821.621594596338, 5848.853778655525, 5857.619254748428, 5799.5650326225705, 5815.88368232633, 5821.53427725781, 5824.068149096167, 5843.5325173985975, 5278.076336641073, 5327.680339179662, 5364.195370694349, 5380.139177731544, 5389.51494365509, 5809.244798176294, 5863.765449382062, 5865.090910908816, 5895.705214739246, 5914.526837852962, 5546.833594992076, 5595.804146854841, 5610.0, 5638.436156384329, 5701.572382071361, 5700.486956173964, 5780.306363236355, 5782.277215348082, 5799.971000145057, 5806.071028635398, 5551.195076713854, 5632.0, 5716.857078573069, 5733.713314334266, 5740.827775166752, 5675.602707810496, 5764.875849209364, 5772.826815195551, 5782.335031471351, 5802.042662960649, 4803.375561177025, 4808.927866082012, 4816.386510518945, 4816.470188279286, 4819.325294458778, 4069.0437747129995, 4074.3888416737727, 4090.6931980101613, 4092.1611069730634, 4145.813438395279, 4839.41926968766, 4860.708357498562, 4867.440244371943, 4874.707517548958, 4902.994886048352, 5593.440655934455, 5625.971870140623, 5718.685472299064, 5741.1388291756575, 5776.595638305363, 4817.638677099231, 4862.5380588844, 4863.95136048635, 4864.0028794097125, 4865.416150061945, 5085.46602606721, 5091.541761241506, 5096.133657278272, 5096.286519887219, 5097.413797413271, 5278.947210527999, 5284.233786100917, 5284.788608455772, 5293.57651387888, 5304.655197412233, 5727.31272247333, 5739.5695322850115, 5755.5971082025535, 5760.510356619734, 5766.0, 5244.1085015548215, 5273.419923808455, 5275.973620132028, 5280.577553795764, 5296.788128474818, 5610.803621873215, 5629.746661400329, 5661.915071273852, 5713.371529131709, 5737.74180161902, 5716.742746576498, 5727.31272247333, 5731.541476681772, 5734.913976290442, 5739.397363276796, 5463.31708536433, 5499.972500137474, 5512.448755124456, 5521.337439507124, 5541.750621222135, 5566.0, 5595.748191331319, 5616.466435688603, 5640.238567793295, 5659.518940889906, 5429.40276569585, 5432.402435732145, 5436.075867102523, 5461.644993075437, 5471.534919531884, 5519.365272993497, 5597.42302794207, 5608.0, 5611.354694210218, 5663.57523185771, 5372.892542149057, 5384.21928820311, 5439.048166570913, 5439.5648348132845, 5439.5920305978], "value": 5181.384276827268, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.5104475822166, 739.5008369350688, 761.033487470912, 1063.4151216830746, 1088.395940253159, 32453.350932981357, 33378.83310583447, 33458.0, 33488.16279593005, 33494.0, 34800.47799283006, 35092.12269693259, 35139.0, 35209.295814083765, 35282.82358588203, 6903.620300883449, 6912.412444942161, 7029.683664235096, 7048.0837491126085, 7097.325754053357, 7017.789466315993, 7067.929320706804, 7070.434365250768, 7103.964480177618, 7134.108236470442, 7016.543924644907, 7154.391876690487, 7159.749408770694, 7161.785146445589, 7172.9641351793425, 7111.1822140454, 7125.572465652026, 7139.964300178518, 7141.464390170758, 7144.67848946796, 7001.05485759421, 7026.402755765715, 7029.578225306498, 7030.543014704028, 7060.152781666182, 31901.0, 31918.521222181687, 31958.20104497383, 32065.358692826012, 32176.839115804505, 2990.2524368907775, 3022.909312720622, 3036.316828713544, 3047.923801904948, 3049.9542506862413, 24910.750892491025, 25020.49959000828, 25095.121670741435, 25157.62263566048, 25254.368640783945, 2992.2668946108124, 3016.0499442675487, 3028.21266470717, 3037.3014206732355, 3055.724984751383, 141432.29283853516, 141669.0, 153697.0, 157218.0, 157492.99999999886, 39886.800565996986, 40012.0, 40061.39907901384, 40105.0, 40134.0, 42224.57775422268, 42435.363469547985, 42523.787381063514, 42627.36058959118, 42701.786491067345, 10981.780364392667, 11071.612493562687, 11106.888931110747, 11143.108551315876, 11161.665150045512, 8981.820363592691, 9114.726558203265, 9117.133872282122, 9124.0, 9156.6795162169, 13069.477220911058, 13215.21594584738, 13304.268265245311, 13336.599902002956, 13503.0, 5288.127458969304, 5326.36083669962, 5330.946690533123, 5419.485148910847, 5432.375276843213, 872.616048938465, 907.5507623726297, 929.7582628516499, 943.9008904065112, 962.6101428921158, 19236.80763192378, 19546.90226548858, 19901.502462438555, 20092.69860952087, 20159.697604535944, 988.5106872098214, 998.4009594243396, 1004.3421558878946, 1009.8030883977701, 1028.922830787694, 10007.299489035697, 10563.524641391155, 10694.893051069545, 10703.25077244601, 10834.566617335218, 157068.0, 158654.0, 159398.0, 159436.0, 160251.0, 45536.3169552457, 45776.313355299695, 45965.310520342224, 46035.53964460312, 46058.30912536314, 1266.0567876931561, 1266.9746605067846, 1271.0403645247593, 1271.5422447918743, 1291.438224372401, 25029.624555631315, 25158.874205628854, 26355.60466593041, 26486.337841554116, 26509.204723858315, 28522.286942826595, 36916.26167476582, 37629.435558467194, 37651.246975060894, 37818.62181378261, 159228.0, 160731.0, 160866.0, 161166.0, 161263.19368403082, 30322.545161823033, 31002.224944376572, 31136.68863311338, 31173.220669483446, 31362.529562057043, 35719.46420803742, 36338.27323453569, 37245.0, 37384.252314954094, 37811.81094094512, 28209.294767630152, 28363.149105526867, 28588.857055714587, 28821.42357152887, 29423.0, 27730.584041238995, 27773.58339624867, 28078.719212808428, 28518.42963140767, 28932.0, 31895.043148705576, 31908.680913190572, 31923.68076319207, 31998.0, 32009.35981280408, 27211.31971700644, 27380.452390951672, 27462.862685686443, 27852.72147278501, 28444.146675599764, 22087.558248835256, 22959.65560516627, 23030.654540182244, 23048.4237894054, 23057.884710576338], "value": 14759.635153561503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.1820912801783, 417.3447687131205, 430.5995424255442, 436.64195359804955, 439.2094230385306, 16623.66752664946, 17304.0, 18083.728744068834, 18106.366277180285, 18182.545436364097, 16577.0, 16615.335386584524, 16823.074730889795, 18190.588434207057, 18389.632207355844, 5395.244665746799, 5421.701806400646, 5449.536789372888, 5527.695976721278, 5582.609217354787, 5448.509634132927, 5465.9180112298345, 5501.092319767234, 5531.834044978637, 5533.3083364579425, 5457.345118585776, 5474.91787623186, 5494.835154945338, 5495.587830912677, 5516.531094856942, 5321.680699158062, 5433.375161856397, 5472.7263636818, 5481.232627432163, 5498.065328894098, 4793.209120495114, 4928.7535623219055, 4940.950590494085, 4964.429090654585, 4970.627202959757, 21107.47231319214, 21743.0, 21758.564828703496, 21896.671549926763, 21974.450638734, 1635.6319828038716, 1679.7732306138637, 1680.8907421017595, 1683.1668324179486, 1684.4609724888041, 14074.2962851857, 14659.926700366537, 14736.631584210374, 14754.557363279118, 14916.105033697904, 2071.399294204679, 2119.279444988696, 2147.4631342164457, 2157.4067131538795, 2166.0252886201274, 78439.60780196119, 87046.0, 89810.0, 96195.9999999993, 98251.50874245654, 10929.234953553176, 11116.833247501294, 11175.608853690244, 11244.49399777012, 11326.207165498501, 15310.770338444932, 15347.309371078329, 15364.692706145814, 15376.154311512973, 15380.30788614515, 6926.783429302574, 7106.964465177744, 7234.457415693844, 7240.0, 7272.272772722686, 6042.6978651067275, 6134.294556126013, 6187.504999600022, 6294.0, 6299.590526615755, 6936.514443988873, 6995.635851009004, 7024.5082844200415, 7029.824254393681, 7266.781996540112, 2078.5011597216558, 2089.798365939591, 2123.4585180778804, 2127.1704035426196, 2166.71832661753, 873.2839071960931, 902.8871391076116, 904.0642934562827, 906.6328137104483, 932.3194068330157, 16788.83211167897, 16862.494125176265, 17233.913830430767, 17382.826171738372, 17485.562860928578, 880.4497189256715, 885.751989442957, 899.3569597737649, 901.8421776189141, 915.3318077803241, 9278.95360523193, 9467.059252853149, 9702.854457183148, 9707.514624268759, 9758.219342452587, 349980.0, 354309.34061264136, 355426.0, 356848.0, 357886.0, 72584.63707681533, 74187.62906185434, 74723.0, 75556.0, 75644.62177689077, 1059.142094903131, 1081.929674571166, 1107.2581370481796, 1111.360967443723, 1116.609186784619, 14622.92688536593, 14680.926595366955, 14729.779053313994, 14817.0, 15299.617509561906, 38514.229715404974, 38982.4152637705, 39672.0, 39798.60201398065, 40016.79991600024, 46351.76824115858, 46354.0, 46410.0, 46517.302240465746, 46720.766396167804, 8461.0, 8528.445651032664, 8564.229219370287, 8737.43206691563, 8928.241099506615, 13181.60455186346, 13360.398782055025, 13409.932950335186, 13464.798028029392, 13473.461061557427, 10727.356358618508, 11528.538858445569, 11667.883321166679, 12078.456469459072, 12144.696382590506, 9955.552000159865, 10010.0, 10023.749406264902, 10039.598416063276, 10056.849147262943, 10956.616518422135, 11085.224034317844, 11310.095192384424, 11503.137264705014, 11708.180427370344, 8436.873446898178, 8524.147585241675, 8589.355798315026, 8696.521691306785, 8707.259882910024, 11294.265872718248, 11303.660890173307, 11462.197646164688, 11675.708107297385, 11967.880321197024], "value": 8814.08263384487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.112604487791, 1308.9214647121173, 1318.7626227279093, 1327.0, 1327.8978447888253, 9725.562349694263, 10102.4443655599, 10143.594256229742, 10175.287729858903, 10332.535035923383, 10145.442000689978, 10300.536475858586, 10321.793564128731, 10328.845067323997, 10363.378197308166, 2294.5066810635753, 2331.4171457135717, 2333.0317918063984, 2334.941626459335, 2340.0, 2206.9558608827815, 2269.795718385345, 2274.9772502275014, 2280.384296240014, 2288.794008539231, 2247.955040899181, 2252.718410198725, 2300.1374484568287, 2302.2172461363134, 2303.49323148907, 2156.0621129808505, 2162.675598660198, 2214.059024914413, 2215.3353993801957, 2220.3449982255274, 2078.490769761403, 2199.175309259028, 2205.349421920537, 2210.8673479591275, 2212.723409573803, 9851.704448866545, 9934.105930466221, 9937.80124397508, 9939.453330066843, 9955.601775928953, 5472.699001554913, 5668.376478587352, 5679.318481782213, 5694.658320500742, 5711.114777209539, 3242.789218700777, 3492.6681965213265, 3532.7703699259723, 3540.2211513466996, 3570.553680789901, 1077.9059254856327, 1096.7861267052929, 1109.2567979453786, 1129.4578602270874, 1129.6554550861983, 14550.927245363811, 14594.197319147443, 14632.780508292492, 14675.559733208021, 14698.412063517446, 4631.235846085426, 4818.8795280118275, 4957.132501812169, 5008.524190201925, 5028.472010438924, 10816.945915270373, 10864.0, 10872.238943273895, 10916.399598022184, 10931.890681093088, 5488.890222195534, 5494.2857428534035, 5498.010358135494, 5500.092484739973, 5504.311961004874, 4937.21004639256, 5044.596432285409, 5046.1169295373165, 5059.595232381401, 5114.539691427789, 3516.7186625069935, 3629.1471504196493, 3689.870854520079, 3713.4801127842125, 3715.405535114423, 1084.810158222308, 1090.3185509056839, 1115.642994241851, 1115.9218854680257, 1130.4856290387854, 675.7297081167573, 695.4505940307201, 698.6611493425685, 714.7105422303976, 725.9020032295679, 5072.797088116434, 5181.4559471255725, 5204.141316682781, 5297.0, 5314.123169677037, 552.2820333566348, 561.9325680918316, 571.1404336473581, 571.871328950991, 573.3643492364199, 3143.4927808165153, 3159.273367125574, 3414.1805966567845, 3513.1568423578155, 3530.2409981854025, 12514.3742812859, 12949.0, 13171.73656526864, 13213.933930330288, 13248.735025299633, 12577.18248313875, 12919.160254583421, 13067.411966461532, 13318.400671969785, 13385.263810490516, 7709.730159444504, 7788.610569471503, 7901.762947111481, 7901.960490197627, 7937.3650107991225, 5493.890122197614, 5576.163575463713, 5619.241402410622, 5928.851778705567, 5930.614510056833, 11377.54489820431, 11681.591144309908, 11711.88288117108, 11720.94139529331, 11817.586384476503, 11775.705607359885, 11994.820077699016, 12066.39668016578, 12161.635150945485, 12173.75652486963, 7653.464257502144, 8114.269715725613, 8213.753587392388, 8233.641449160821, 8285.875711864206, 8955.0, 9201.493917834316, 9218.677346292847, 9219.03200163973, 9221.123993220634, 7626.504277221963, 8002.0, 8368.330533557422, 8388.958055209685, 8412.579371031547, 7785.727499537489, 7913.050433947733, 8037.075736290401, 8044.637991290523, 8080.636371363185, 6766.560173588701, 6892.620905850226, 6900.03399524077, 6922.134733158356, 6936.34104760047, 4501.864944051684, 4572.291294849304, 4594.632429405573, 5039.244113383022, 5066.645334826527, 4940.357753492023, 5033.345665063518, 5073.2897394365555, 5081.898362032813, 5120.590352771844], "value": 4624.180938939712, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5968195462059, 370.9054191181248, 375.457463964571, 389.06235971309144, 395.8535341923488, 5393.1370980643105, 5568.888622227553, 5711.228984087152, 5712.400197979209, 5722.6280291781, 5381.730913454331, 5519.475649813261, 5524.392316845154, 5552.639078459897, 5597.272354593907, 4389.714668546542, 4394.824207031731, 4401.163778882018, 4405.911881762363, 4407.853957970935, 4311.943573824417, 4369.584889435499, 4390.5609439056, 4429.800658970338, 4434.246178149722, 4380.5838445347645, 4382.824687012531, 4384.18892504886, 4392.3191905254735, 4409.29451287794, 4378.8029538670835, 4398.7580683062415, 4403.603675669189, 4407.449068866392, 4418.4256046714045, 3921.490206273166, 3958.2083583283456, 3989.501312335958, 3991.3813358929124, 4000.4999375078114, 5325.920111198335, 5342.813001544927, 5348.946510534884, 5361.865953351158, 5383.757730902119, 5228.816991405282, 5246.239295302198, 5248.265242866002, 5268.420473747885, 5268.631195816294, 5588.720563971785, 5800.245968024172, 5886.941130588682, 5897.823065308047, 5921.934051870661, 4043.2722110020186, 4060.248853961997, 4065.6950728695465, 4067.430559721641, 4074.0, 6066.332703402622, 6238.376162383771, 6245.281792593864, 6297.433231009231, 6314.0844577536, 4150.792460376969, 4151.484708081529, 4158.625723684883, 4170.812313445902, 4172.958270417318, 4192.3082691355585, 4243.469566304212, 4243.490781106287, 4249.235137675249, 4252.4046633471335, 4769.499202583748, 4839.322494850724, 4892.363992680928, 4897.094037603055, 4899.240617704261, 5872.853178670482, 5872.911906321408, 5889.469947704727, 5889.617174883619, 5900.7049647518315, 1428.649980754701, 1433.2332202271944, 1438.216172186161, 1443.4226309476294, 1446.797448357231, 962.2734835199379, 970.4807927758616, 977.5600979559226, 979.2166266986383, 983.2822039910905, 5137.227656458515, 5137.306463627438, 5151.9484805152215, 5165.612579056586, 5198.740062996835, 6104.694765261719, 6121.755129794758, 6138.815835524942, 6141.907871381933, 6146.446819786241, 4973.154563724175, 5079.593632509391, 5114.948850511447, 5124.256982737482, 5148.704828909501, 3229.176559977238, 3257.120577444124, 3257.153140183522, 3257.9022629321157, 3271.362084393568, 5534.418886016911, 5667.971660141756, 5671.404502527175, 5675.708089308191, 5703.8859222816145, 6270.623762574261, 6304.9912014078445, 6306.65313407767, 6308.842278943063, 6334.651594162273, 5640.210370548045, 5689.68706721126, 5709.628874123168, 5711.286089238845, 5711.428857114339, 5972.25346831646, 6073.757049717962, 6100.572959892765, 6119.632822030692, 6145.784897528565, 5808.767649293981, 6018.645804693909, 6034.969825150846, 6036.275646922398, 6054.485368743706, 5669.801556945487, 5672.517835983823, 5689.2319536862, 5721.1990321354215, 5729.942700572941, 4105.425240466397, 4138.544760076329, 4138.627523522898, 4156.459660244149, 4169.60388763067, 6013.308469525886, 6172.321044684992, 6182.072689096492, 6186.412290832363, 6196.47329976957, 5901.203337549376, 5906.26171728534, 5925.748335506082, 5934.169216309807, 5937.406259374028, 5697.0, 5892.499137573354, 5895.9705201475435, 5898.705064746831, 5931.0, 5743.310802703702, 5799.565032622654, 5841.211436456024, 5850.683596190823, 5854.326752423526, 5931.288245410578, 5950.464458198783, 5955.166276721349, 5957.523398128053, 5974.0, 5586.888262234814, 5771.5671324649975, 5775.133729940542, 5795.82612521625, 5817.476427121579], "value": 4437.440248039977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.4703284405321, 698.9196242432121, 702.5328156775741, 704.067111077822, 704.3555147040458, 12476.438560264787, 12973.935130324347, 13014.219146851183, 14863.702725945475, 16070.116143612126, 14853.331600077996, 15229.390824367012, 15475.071495710265, 15482.84517154828, 15878.603034924105, 894.8434024045798, 912.771807048238, 916.6883259691704, 916.9679061232858, 918.2516249256835, 901.4906577783531, 928.3316012471043, 928.6842473558988, 929.1173385283973, 934.4766930518897, 977.6822532676908, 980.0, 980.1423754215061, 980.7940332530142, 981.1464026297095, 976.2434113561975, 976.7313988653107, 977.2719324103552, 979.7991411760572, 981.5779214937573, 713.2938390992931, 715.3347386930153, 718.1095441652366, 718.2135561560135, 721.4949535325293, 13746.0, 13908.721825563533, 13918.164910105426, 14134.434622615083, 14746.336414861356, 14093.365798539091, 14207.786883196657, 14318.64203394913, 14541.927290363587, 14587.854121458755, 11722.413879306087, 11953.342566158857, 12010.399480025964, 12046.096542759327, 12097.395130243453, 2857.4856525825344, 2878.5250433678625, 2884.120343295294, 2886.3649997000625, 2909.214512081747, 70049.64975175091, 70204.64897675479, 70355.0, 71241.6437917807, 72073.2792672077, 12197.817032744517, 12388.0, 12479.875201248053, 12497.25016499013, 12526.74946501065, 20839.0, 22063.11747530113, 22198.778012219995, 22293.888530557244, 22493.887530562242, 6277.654728989858, 6345.302016778151, 6351.2060992375955, 6512.153420055362, 6551.39490824751, 3066.3100802319746, 3110.2379916920045, 3128.749700023993, 3131.4519959007084, 3142.9214269642985, 3377.105067157205, 3429.1941393772445, 3458.152752575635, 3463.428534291814, 3497.3529896968635, 667.2693400726197, 675.1796567170911, 675.7567275780814, 677.2381071294793, 682.5972676121013, 584.3046774338524, 597.0745344715673, 599.8170557979859, 603.0742809786956, 616.9691515424211, 8762.0, 9044.954775226213, 9263.444193348421, 9407.717768466957, 9780.853287200698, 582.4728620598365, 592.5141384065112, 594.76209516193, 600.7957294519884, 602.4638072115821, 4147.709660323809, 4220.767857767853, 4222.366645003212, 4252.064545799919, 4270.850520231777, 57248.0, 58392.7080364604, 59869.10196347058, 60188.0, 60747.392526075055, 53841.73079134658, 54030.729846350514, 54278.18582721263, 54400.0, 55742.0, 49308.50691493111, 49828.0, 50168.247476287885, 51074.74462627663, 51470.485295147315, 8691.565421728761, 8711.825763484569, 8738.995015573291, 8963.641454341754, 8985.146411090936, 25116.0, 26078.0, 26178.60732088982, 26465.206043818715, 27357.0, 31227.53158702576, 31463.685363146076, 31574.842125789222, 32108.19729506781, 32262.838685806422, 11787.705307367385, 12107.273563586214, 12151.635450936486, 12195.390230488618, 12368.567100151451, 12767.680807979876, 12829.61511154667, 12853.036022298178, 12914.354282286036, 13114.475420983053, 11289.604863829727, 11465.082793376343, 11553.0, 11664.708382290512, 11723.296602203895, 11469.025132863466, 11508.48211830453, 11515.424228788695, 11593.362365070003, 11690.240134391237, 11231.326120432801, 11322.207445479067, 11409.0, 11457.796931322424, 11610.825837612274, 8805.207531322212, 9132.49771262587, 10499.370037797757, 10785.784284314426, 10850.348979061282, 11319.698234703115, 11521.0, 11795.233309834834, 11857.0, 11954.701132471759], "value": 6557.230677376361, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 111.0, 113.0, 111.0, 111.0, 113.0, 112.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 126.0, 123.0, 169.0, 123.0, 124.0, 125.0, 122.0, 145.0, 134.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 166.0, 169.0, 173.0, 163.0, 163.0, 164.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 112.0, 75.0, 76.0, 75.0, 75.0, 95.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 110.0, 84.0, 84.0, 82.0, 100.0, 82.0, 82.0, 103.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 118.0, 114.0, 114.0, 114.0, 116.0, 121.0, 117.0, 121.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 154.0, 149.0, 151.0, 150.0, 149.0, 151.0, 149.0, 149.0, 151.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 56.0, 54.0, 54.0, 56.0, 55.0, 55.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 57.0, 55.0, 56.0, 56.0, 56.0, 55.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 80.0, 80.0, 82.0, 81.0, 88.0, 81.0, 80.0, 85.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 138.0, 128.0, 131.0, 127.0, 131.0, 129.0, 143.0, 177.0, 136.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 197.0, 186.0, 191.0, 192.0, 193.0, 187.0, 191.0, 182.0, 202.0], "value": 191.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 71.0, 73.0, 70.0, 71.0, 72.0, 72.0, 70.0, 69.0, 71.0], "value": 71.4, "unit": "score"}]}]} 03:06:06 INFO - Return code: 0 03:06:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:06:06 INFO - # TBPL SUCCESS # 03:06:06 INFO - Running post-action listener: _resource_record_post_action 03:06:06 INFO - [mozharness: 2017-05-04 10:06:06.575496Z] Finished run-tests step (success) 03:06:06 INFO - Running post-run listener: _resource_record_post_run 03:06:06 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 12288; Write bytes: 357347328; Read time: 208; Write time: 181932 03:06:06 INFO - TinderboxPrint: CPU usage
13.3% 03:06:06 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 208 03:06:06 INFO - TinderboxPrint: I/O write bytes / time
357,347,328 / 181,932 03:06:06 INFO - TinderboxPrint: CPU idle
8,303.7 (86.7%) 03:06:06 INFO - TinderboxPrint: CPU user
1,216.3 (12.7%) 03:06:06 INFO - TinderboxPrint: Swap in / out
0 / 0 03:06:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 73740288; Read time: 44; Write time: 20100 03:06:06 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 254099456; Read time: 164; Write time: 118768 03:06:07 INFO - Running post-run listener: _upload_blobber_files 03:06:07 INFO - Blob upload gear active. 03:06:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06:07 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 03:06:07 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'] 03:06:07 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 03:06:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:06:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:06:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:08 INFO - (blobuploader) - INFO - Done attempting. 03:06:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:06:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:06:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:10 INFO - (blobuploader) - INFO - Done attempting. 03:06:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:06:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:06:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:10 INFO - (blobuploader) - INFO - Done attempting. 03:06:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:06:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:06:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:14 INFO - (blobuploader) - INFO - Done attempting. 03:06:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:14 INFO - Return code: 0 03:06:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faefa9e67dce41f31f116d0f8854fbea41086601faea223a142c80299d5b86e2b7a2fbdae3a283499997a89620774972e67a517065bdd18610ffd3218352b784", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4c18cb1381d7eed77eaac5829d5c1813a7f5e8aaaabf217a888543b909b5397b8f3ec18157a2c1fb8706630c73c47f70a058a6d7405b0bfbf438317267ef44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcd3b248a41f3157e9b55832794bd9815c24c01abf586b21a145d5c5fa71b61d563eabca075f992bf588522acfa9df3852a2eca9058dc1dc9708b6991486ead6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68524c5789a5d6d33258cb25f2a60f7cf1a24f54613150ffe5a6ebdcd18ae5e16dbf221f807daabfe3b49a9d4c05a83b039af172a8ec836568c6e7ed2f9f0a6d"} 03:06:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:14 INFO - Contents: 03:06:14 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faefa9e67dce41f31f116d0f8854fbea41086601faea223a142c80299d5b86e2b7a2fbdae3a283499997a89620774972e67a517065bdd18610ffd3218352b784", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4c18cb1381d7eed77eaac5829d5c1813a7f5e8aaaabf217a888543b909b5397b8f3ec18157a2c1fb8706630c73c47f70a058a6d7405b0bfbf438317267ef44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcd3b248a41f3157e9b55832794bd9815c24c01abf586b21a145d5c5fa71b61d563eabca075f992bf588522acfa9df3852a2eca9058dc1dc9708b6991486ead6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68524c5789a5d6d33258cb25f2a60f7cf1a24f54613150ffe5a6ebdcd18ae5e16dbf221f807daabfe3b49a9d4c05a83b039af172a8ec836568c6e7ed2f9f0a6d"} 03:06:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:14 INFO - Copying logs to upload dir... 03:06:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.784755 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-04 03:06:14.086715) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 03:06:14.089943) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faefa9e67dce41f31f116d0f8854fbea41086601faea223a142c80299d5b86e2b7a2fbdae3a283499997a89620774972e67a517065bdd18610ffd3218352b784", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4c18cb1381d7eed77eaac5829d5c1813a7f5e8aaaabf217a888543b909b5397b8f3ec18157a2c1fb8706630c73c47f70a058a6d7405b0bfbf438317267ef44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcd3b248a41f3157e9b55832794bd9815c24c01abf586b21a145d5c5fa71b61d563eabca075f992bf588522acfa9df3852a2eca9058dc1dc9708b6991486ead6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68524c5789a5d6d33258cb25f2a60f7cf1a24f54613150ffe5a6ebdcd18ae5e16dbf221f807daabfe3b49a9d4c05a83b039af172a8ec836568c6e7ed2f9f0a6d"} build_url:https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faefa9e67dce41f31f116d0f8854fbea41086601faea223a142c80299d5b86e2b7a2fbdae3a283499997a89620774972e67a517065bdd18610ffd3218352b784", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4c18cb1381d7eed77eaac5829d5c1813a7f5e8aaaabf217a888543b909b5397b8f3ec18157a2c1fb8706630c73c47f70a058a6d7405b0bfbf438317267ef44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcd3b248a41f3157e9b55832794bd9815c24c01abf586b21a145d5c5fa71b61d563eabca075f992bf588522acfa9df3852a2eca9058dc1dc9708b6991486ead6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68524c5789a5d6d33258cb25f2a60f7cf1a24f54613150ffe5a6ebdcd18ae5e16dbf221f807daabfe3b49a9d4c05a83b039af172a8ec836568c6e7ed2f9f0a6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 03:06:14.117037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:06:14.117619) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1493887415.929948-1080718648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:06:14.200246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 03:06:14.200569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 03:06:14.200852) ========= ========= Total master_lag: 0.18 =========