builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1493891134.35 results: success (0) revision: a8d597ee6dd58306e62e55a07c4ab20958726d6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:34.350475) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:34.350870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:34.351467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:34.384012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:34.384291) ========= 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=4300f881736b422476174874000001bc-1493890086.329458-1850836592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 02:45:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.2M=0s 2017-05-04 02:45:34 (69.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083040 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:34.481724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:34.482013) ========= 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=4300f881736b422476174874000001bc-1493890086.329458-1850836592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:34.534915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 02:45:34.535232) ========= 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=4300f881736b422476174874000001bc-1493890086.329458-1850836592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 02:45:34,936 truncating revision to first 12 chars 2017-05-04 02:45:34,936 Setting DEBUG logging. 2017-05-04 02:45:34,936 attempt 1/10 2017-05-04 02:45:34,936 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:35,692 unpacking tar archive at: mozilla-central-a8d597ee6dd5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.064634 ========= master_lag: 0.41 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 02:45:36.006832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:36.007109) ========= script_repo_revision: a8d597ee6dd58306e62e55a07c4ab20958726d6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:36.013487) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:36.013774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 02:45:36.067223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-04 02:45:36.067531) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=4300f881736b422476174874000001bc-1493890086.329458-1850836592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:45:36 INFO - MultiFileLogger online at 20170504 02:45:36 in /builds/slave/test 02:45:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:45:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:36 INFO - {'append_to_log': False, 02:45:36 INFO - 'base_work_dir': '/builds/slave/test', 02:45:36 INFO - 'blob_upload_branch': 'Firefox', 02:45:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:36 INFO - 'branch': 'Firefox', 02:45:36 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:36 INFO - 'config_files': ('talos/linux_config.py',), 02:45:36 INFO - 'default_actions': ('clobber', 02:45:36 INFO - 'read-buildbot-config', 02:45:36 INFO - 'download-and-extract', 02:45:36 INFO - 'populate-webroot', 02:45:36 INFO - 'create-virtualenv', 02:45:36 INFO - 'install', 02:45:36 INFO - 'run-tests'), 02:45:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:36 INFO - 'download_minidump_stackwalk': True, 02:45:36 INFO - 'download_symbols': 'ondemand', 02:45:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:36 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:36 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:36 INFO - 'gecko_profile': False, 02:45:36 INFO - 'gecko_profile_interval': 0, 02:45:36 INFO - 'installer_path': 'installer.exe', 02:45:36 INFO - 'log_level': 'info', 02:45:36 INFO - 'log_name': 'talos', 02:45:36 INFO - 'log_to_console': True, 02:45:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:45:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:45:36 INFO - 'opt_config_files': (), 02:45:36 INFO - 'pip_index': False, 02:45:36 INFO - 'suite': 'dromaeojs', 02:45:36 INFO - 'system_bits': '32', 02:45:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:36 INFO - 'title': 'talos-linux64-ix-045', 02:45:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:36 INFO - 'use_talos_json': True, 02:45:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:36 INFO - 'work_dir': 'build'} 02:45:36 INFO - [mozharness: 2017-05-04 09:45:36.584796Z] Running clobber step. 02:45:36 INFO - Running pre-action listener: _resource_record_pre_action 02:45:36 INFO - Running main action method: clobber 02:45:36 INFO - rmtree: /builds/slave/test/build 02:45:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:37 INFO - Running post-action listener: _resource_record_post_action 02:45:37 INFO - [mozharness: 2017-05-04 09:45:37.519462Z] Finished clobber step (success) 02:45:37 INFO - [mozharness: 2017-05-04 09:45:37.519563Z] Running read-buildbot-config step. 02:45:37 INFO - Running pre-action listener: _resource_record_pre_action 02:45:37 INFO - Running main action method: read_buildbot_config 02:45:37 INFO - Using buildbot properties: 02:45:37 INFO - { 02:45:37 INFO - "project": "", 02:45:37 INFO - "product": "firefox", 02:45:37 INFO - "who": "cbook@mozilla.com", 02:45:37 INFO - "installer_path": "public/build/target.tar.bz2", 02:45:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 02:45:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:45:37 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 02:45:37 INFO - "stage_platform": "linux64-stylo", 02:45:37 INFO - "basedir": "/builds/slave/test", 02:45:37 INFO - "buildnumber": 76, 02:45:37 INFO - "platform": "ubuntu64_hw_stylo", 02:45:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:45:37 INFO - "slavebuilddir": "test", 02:45:37 INFO - "taskId": "ANP6otWdT7uAjINvNQPK7A", 02:45:37 INFO - "branch": "mozilla-central", 02:45:37 INFO - "script_repo_revision": "production", 02:45:37 INFO - "revision": "a8d597ee6dd58306e62e55a07c4ab20958726d6a", 02:45:37 INFO - "slavename": "talos-linux64-ix-045", 02:45:37 INFO - "repo_path": "mozilla-central" 02:45:37 INFO - } 02:45:37 INFO - Finding installer, test and symbols from parent task. 02:45:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ANP6otWdT7uAjINvNQPK7A'}, attempt #1 02:45:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ANP6otWdT7uAjINvNQPK7A'}, attempt #1 02:45:38 INFO - Task dependencies: ItSf58erR_KVtIfo-h7vLA 02:45:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA'}, attempt #1 02:45:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2 02:45:38 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/test_packages.json 02:45:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.crashreporter-symbols.zip 02:45:38 INFO - Running post-action listener: _resource_record_post_action 02:45:38 INFO - [mozharness: 2017-05-04 09:45:38.874644Z] Finished read-buildbot-config step (success) 02:45:38 INFO - [mozharness: 2017-05-04 09:45:38.874863Z] Running download-and-extract step. 02:45:38 INFO - Running pre-action listener: _resource_record_pre_action 02:45:38 INFO - Running main action method: download_and_extract 02:45:38 INFO - mkdir: /builds/slave/test/build/tests 02:45:38 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:38 INFO - trying https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.test_packages.json 02:45:38 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:38 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:39 INFO - Downloaded 986 bytes. 02:45:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:45:39 INFO - Using the following test package requirements: 02:45:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:45:39 INFO - u'common': [u'target.common.tests.zip'], 02:45:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:45:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:45:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:45:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:45:39 INFO - u'mozbase': [u'target.common.tests.zip'], 02:45:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:45:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:45:39 INFO - u'web-platform': [u'target.common.tests.zip', 02:45:39 INFO - u'target.web-platform.tests.zip'], 02:45:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:45:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:45:39 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:39 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:39 INFO - Fetch https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.common.tests.zip into memory 02:45:40 INFO - Content-Length response header: 58441542 02:45:40 INFO - Bytes received: 58441542 02:45:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:45:50 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:50 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:50 INFO - Fetch https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.common.tests.zip into memory 02:45:51 INFO - Content-Length response header: 58441542 02:45:51 INFO - Bytes received: 58441542 02:46:02 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:46:02 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:46:02 INFO - Fetch https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.talos.tests.zip into memory 02:46:02 INFO - Content-Length response header: 14408809 02:46:02 INFO - Bytes received: 14408809 02:46:03 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:03 INFO - trying https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2 02:46:03 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:46:03 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:46:04 INFO - Downloaded 59906162 bytes. 02:46:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2 02:46:04 INFO - mkdir: /builds/slave/test/properties 02:46:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:46:04 INFO - Writing to file /builds/slave/test/properties/build_url 02:46:04 INFO - Contents: 02:46:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2 02:46:04 INFO - Running post-action listener: _resource_record_post_action 02:46:04 INFO - Running post-action listener: set_extra_try_arguments 02:46:04 INFO - [mozharness: 2017-05-04 09:46:04.132278Z] Finished download-and-extract step (success) 02:46:04 INFO - [mozharness: 2017-05-04 09:46:04.132374Z] Running populate-webroot step. 02:46:04 INFO - Running pre-action listener: _resource_record_pre_action 02:46:04 INFO - Running main action method: populate_webroot 02:46:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:46:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:46:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:46:04 INFO - '--tppagecycles', 02:46:04 INFO - '7'], 02:46:04 INFO - 'tests': ['tsvgm']}}, 02:46:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:46:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:46:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:46:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:46:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:46:04 INFO - 'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:46:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:46:04 INFO - 'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['damp', 'tps']}, 02:46:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:46:04 INFO - 'tests': ['damp', 'tps']}, 02:46:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['dromaeo_dom']}, 02:46:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:46:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:46:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:46:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['a11yr', 02:46:04 INFO - 'ts_paint', 02:46:04 INFO - 'tpaint', 02:46:04 INFO - 'sessionrestore', 02:46:04 INFO - 'sessionrestore_no_auto_restore', 02:46:04 INFO - 'tabpaint']}, 02:46:04 INFO - 'other-e10s': {'tests': ['a11yr', 02:46:04 INFO - 'ts_paint', 02:46:04 INFO - 'tpaint', 02:46:04 INFO - 'sessionrestore', 02:46:04 INFO - 'sessionrestore_no_auto_restore', 02:46:04 INFO - 'tabpaint']}, 02:46:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:46:04 INFO - 'ts_paint', 02:46:04 INFO - 'tpaint', 02:46:04 INFO - 'sessionrestore', 02:46:04 INFO - 'sessionrestore_no_auto_restore', 02:46:04 INFO - 'tabpaint']}, 02:46:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:46:04 INFO - 'ts_paint', 02:46:04 INFO - 'tpaint', 02:46:04 INFO - 'sessionrestore', 02:46:04 INFO - 'sessionrestore_no_auto_restore', 02:46:04 INFO - 'tabpaint']}, 02:46:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['a11yr', 02:46:04 INFO - 'ts_paint', 02:46:04 INFO - 'tpaint', 02:46:04 INFO - 'sessionrestore', 02:46:04 INFO - 'sessionrestore_no_auto_restore', 02:46:04 INFO - 'tabpaint']}, 02:46:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['a11yr', 02:46:04 INFO - 'ts_paint', 02:46:04 INFO - 'tpaint', 02:46:04 INFO - 'sessionrestore', 02:46:04 INFO - 'sessionrestore_no_auto_restore', 02:46:04 INFO - 'tabpaint']}, 02:46:04 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:46:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:46:04 INFO - 'bloom_basic_ref']}, 02:46:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['tsvgx', 02:46:04 INFO - 'tsvgr_opacity', 02:46:04 INFO - 'tart', 02:46:04 INFO - 'tscrollx', 02:46:04 INFO - 'cart', 02:46:04 INFO - 'tsvg_static']}, 02:46:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:46:04 INFO - 'tsvgr_opacity', 02:46:04 INFO - 'tart', 02:46:04 INFO - 'tscrollx', 02:46:04 INFO - 'cart', 02:46:04 INFO - 'tsvg_static']}, 02:46:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:46:04 INFO - 'talos_options': ['--disable-e10s'], 02:46:04 INFO - 'tests': ['tp5o']}, 02:46:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:46:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:46:04 INFO - 'talos_options': ['--disable-e10s', 02:46:04 INFO - '--xperf_path', 02:46:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:04 INFO - 'tests': ['tp5n']}, 02:46:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:46:04 INFO - 'talos_options': ['--xperf_path', 02:46:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:04 INFO - 'tests': ['tp5n']}}, 02:46:04 INFO - 'talos.zip': {'path': '', 02:46:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:46:04 INFO - Running post-action listener: _resource_record_post_action 02:46:04 INFO - [mozharness: 2017-05-04 09:46:04.146028Z] Finished populate-webroot step (success) 02:46:04 INFO - [mozharness: 2017-05-04 09:46:04.146117Z] Running create-virtualenv step. 02:46:04 INFO - Running pre-action listener: _resource_record_pre_action 02:46:04 INFO - Running main action method: create_virtualenv 02:46:04 INFO - Creating virtualenv /builds/slave/test/build/venv 02:46:04 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:46:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:46:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:46:04 INFO - Using real prefix '/usr' 02:46:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:46:04 INFO - Installing distribute.............................................................................................................................................................................................done. 02:46:06 INFO - Installing pip.................done. 02:46:06 INFO - Return code: 0 02:46:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:46:06 INFO - Reading from file tmpfile_stdout 02:46:06 INFO - Output received: 02:46:06 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:46:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:46:06 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:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:06 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:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:06 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 0x137b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', '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:06 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:46:06 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:46:06 INFO - Using env: {'DISPLAY': ':0', 02:46:06 INFO - 'HOME': '/home/cltbld', 02:46:06 INFO - 'LANG': 'en_US.UTF-8', 02:46:06 INFO - 'LANGUAGE': 'en_US:en', 02:46:06 INFO - 'LOGNAME': 'cltbld', 02:46:06 INFO - 'MAIL': '/var/mail/cltbld', 02:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:06 INFO - 'MOZ_NO_REMOTE': '1', 02:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:06 INFO - 'NO_EM_RESTART': '1', 02:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:06 INFO - 'PWD': '/builds/slave/test', 02:46:06 INFO - 'SHELL': '/bin/bash', 02:46:06 INFO - 'SHLVL': '1', 02:46:06 INFO - 'TERM': 'linux', 02:46:06 INFO - 'TMOUT': '86400', 02:46:06 INFO - 'USER': 'cltbld', 02:46:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:06 INFO - '_': '/tools/buildbot/bin/python'} 02:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:07 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:46:07 INFO - Cleaning up... 02:46:07 INFO - Return code: 0 02:46:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:46:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:07 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 0x137b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', '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:07 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:46:07 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:46:07 INFO - Using env: {'DISPLAY': ':0', 02:46:07 INFO - 'HOME': '/home/cltbld', 02:46:07 INFO - 'LANG': 'en_US.UTF-8', 02:46:07 INFO - 'LANGUAGE': 'en_US:en', 02:46:07 INFO - 'LOGNAME': 'cltbld', 02:46:07 INFO - 'MAIL': '/var/mail/cltbld', 02:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:07 INFO - 'MOZ_NO_REMOTE': '1', 02:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:07 INFO - 'NO_EM_RESTART': '1', 02:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:07 INFO - 'PWD': '/builds/slave/test', 02:46:07 INFO - 'SHELL': '/bin/bash', 02:46:07 INFO - 'SHLVL': '1', 02:46:07 INFO - 'TERM': 'linux', 02:46:07 INFO - 'TMOUT': '86400', 02:46:07 INFO - 'USER': 'cltbld', 02:46:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:07 INFO - '_': '/tools/buildbot/bin/python'} 02:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:07 INFO - Downloading/unpacking psutil>=3.1.1 02:46:07 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:07 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:07 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:07 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:07 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:07 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:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:46:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:08 INFO - Installing collected packages: psutil 02:46:08 INFO - Running setup.py install for psutil 02:46:08 INFO - building 'psutil._psutil_linux' extension 02:46:08 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:46:08 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:46:08 INFO - building 'psutil._psutil_posix' extension 02:46:08 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:46:09 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:46:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:09 INFO - Successfully installed psutil 02:46:09 INFO - Cleaning up... 02:46:09 INFO - Return code: 0 02:46:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:46:09 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:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:09 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:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:09 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 0x137b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', '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:09 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:46:09 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:46:09 INFO - Using env: {'DISPLAY': ':0', 02:46:09 INFO - 'HOME': '/home/cltbld', 02:46:09 INFO - 'LANG': 'en_US.UTF-8', 02:46:09 INFO - 'LANGUAGE': 'en_US:en', 02:46:09 INFO - 'LOGNAME': 'cltbld', 02:46:09 INFO - 'MAIL': '/var/mail/cltbld', 02:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:09 INFO - 'MOZ_NO_REMOTE': '1', 02:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:09 INFO - 'NO_EM_RESTART': '1', 02:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:09 INFO - 'PWD': '/builds/slave/test', 02:46:09 INFO - 'SHELL': '/bin/bash', 02:46:09 INFO - 'SHLVL': '1', 02:46:09 INFO - 'TERM': 'linux', 02:46:09 INFO - 'TMOUT': '86400', 02:46:09 INFO - 'USER': 'cltbld', 02:46:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:09 INFO - '_': '/tools/buildbot/bin/python'} 02:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:46:09 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:09 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:09 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:09 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:09 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:09 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:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:46:10 INFO - Installing collected packages: mozsystemmonitor 02:46:10 INFO - Running setup.py install for mozsystemmonitor 02:46:10 INFO - Successfully installed mozsystemmonitor 02:46:10 INFO - Cleaning up... 02:46:10 INFO - Return code: 0 02:46:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:46:10 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:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:10 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:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:10 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 0x137b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', '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:10 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:46:10 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:46:10 INFO - Using env: {'DISPLAY': ':0', 02:46:10 INFO - 'HOME': '/home/cltbld', 02:46:10 INFO - 'LANG': 'en_US.UTF-8', 02:46:10 INFO - 'LANGUAGE': 'en_US:en', 02:46:10 INFO - 'LOGNAME': 'cltbld', 02:46:10 INFO - 'MAIL': '/var/mail/cltbld', 02:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:10 INFO - 'MOZ_NO_REMOTE': '1', 02:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:10 INFO - 'NO_EM_RESTART': '1', 02:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:10 INFO - 'PWD': '/builds/slave/test', 02:46:10 INFO - 'SHELL': '/bin/bash', 02:46:10 INFO - 'SHLVL': '1', 02:46:10 INFO - 'TERM': 'linux', 02:46:10 INFO - 'TMOUT': '86400', 02:46:10 INFO - 'USER': 'cltbld', 02:46:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:10 INFO - '_': '/tools/buildbot/bin/python'} 02:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:10 INFO - Downloading/unpacking jsonschema==2.5.1 02:46:10 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:10 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:10 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:10 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:10 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:10 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:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:46:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:46:11 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:11 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:11 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:11 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:11 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:11 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:12 INFO - Downloading functools32-3.2.3-2.tar.gz 02:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:46:12 INFO - warning: no files found matching '*.txt' 02:46:12 INFO - no previously-included directories found matching 'build' 02:46:12 INFO - no previously-included directories found matching 'dist' 02:46:12 INFO - no previously-included directories found matching '.git*' 02:46:12 INFO - Installing collected packages: jsonschema, functools32 02:46:12 INFO - Running setup.py install for functools32 02:46:12 INFO - warning: no files found matching '*.txt' 02:46:12 INFO - no previously-included directories found matching 'build' 02:46:12 INFO - no previously-included directories found matching 'dist' 02:46:12 INFO - no previously-included directories found matching '.git*' 02:46:12 INFO - Successfully installed jsonschema functools32 02:46:12 INFO - Cleaning up... 02:46:12 INFO - Return code: 0 02:46:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:46:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x137b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', '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:12 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:46:12 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:46:12 INFO - Using env: {'DISPLAY': ':0', 02:46:12 INFO - 'HOME': '/home/cltbld', 02:46:12 INFO - 'LANG': 'en_US.UTF-8', 02:46:12 INFO - 'LANGUAGE': 'en_US:en', 02:46:12 INFO - 'LOGNAME': 'cltbld', 02:46:12 INFO - 'MAIL': '/var/mail/cltbld', 02:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:12 INFO - 'MOZ_NO_REMOTE': '1', 02:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:12 INFO - 'NO_EM_RESTART': '1', 02:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:12 INFO - 'PWD': '/builds/slave/test', 02:46:12 INFO - 'SHELL': '/bin/bash', 02:46:12 INFO - 'SHLVL': '1', 02:46:12 INFO - 'TERM': 'linux', 02:46:12 INFO - 'TMOUT': '86400', 02:46:12 INFO - 'USER': 'cltbld', 02:46:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:12 INFO - '_': '/tools/buildbot/bin/python'} 02:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:46:12 INFO - Cleaning up... 02:46:12 INFO - Return code: 0 02:46:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:46:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x137b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', '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:12 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:46:12 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:46:12 INFO - Using env: {'DISPLAY': ':0', 02:46:12 INFO - 'HOME': '/home/cltbld', 02:46:12 INFO - 'LANG': 'en_US.UTF-8', 02:46:12 INFO - 'LANGUAGE': 'en_US:en', 02:46:12 INFO - 'LOGNAME': 'cltbld', 02:46:12 INFO - 'MAIL': '/var/mail/cltbld', 02:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:12 INFO - 'MOZ_NO_REMOTE': '1', 02:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:12 INFO - 'NO_EM_RESTART': '1', 02:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:12 INFO - 'PWD': '/builds/slave/test', 02:46:12 INFO - 'SHELL': '/bin/bash', 02:46:12 INFO - 'SHLVL': '1', 02:46:12 INFO - 'TERM': 'linux', 02:46:12 INFO - 'TMOUT': '86400', 02:46:12 INFO - 'USER': 'cltbld', 02:46:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:12 INFO - '_': '/tools/buildbot/bin/python'} 02:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:12 INFO - Downloading/unpacking blobuploader==1.2.4 02:46:12 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:12 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:12 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:12 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:12 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:12 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:13 INFO - Downloading blobuploader-1.2.4.tar.gz 02:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:46:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:13 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:13 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:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:46:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:46:14 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:14 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:14 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:14 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:14 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:14 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:14 INFO - Downloading docopt-0.6.1.tar.gz 02:46:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:46:14 INFO - Installing collected packages: blobuploader, requests, docopt 02:46:14 INFO - Running setup.py install for blobuploader 02:46:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:46:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:46:14 INFO - Running setup.py install for requests 02:46:14 INFO - Running setup.py install for docopt 02:46:14 INFO - Successfully installed blobuploader requests docopt 02:46:14 INFO - Cleaning up... 02:46:14 INFO - Return code: 0 02:46:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:14 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 0x137b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', '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:14 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:46:14 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:46:15 INFO - Using env: {'DISPLAY': ':0', 02:46:15 INFO - 'HOME': '/home/cltbld', 02:46:15 INFO - 'LANG': 'en_US.UTF-8', 02:46:15 INFO - 'LANGUAGE': 'en_US:en', 02:46:15 INFO - 'LOGNAME': 'cltbld', 02:46:15 INFO - 'MAIL': '/var/mail/cltbld', 02:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:15 INFO - 'MOZ_NO_REMOTE': '1', 02:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:15 INFO - 'NO_EM_RESTART': '1', 02:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:15 INFO - 'PWD': '/builds/slave/test', 02:46:15 INFO - 'SHELL': '/bin/bash', 02:46:15 INFO - 'SHLVL': '1', 02:46:15 INFO - 'TERM': 'linux', 02:46:15 INFO - 'TMOUT': '86400', 02:46:15 INFO - 'USER': 'cltbld', 02:46:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:15 INFO - '_': '/tools/buildbot/bin/python'} 02:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:15 INFO - Running setup.py (path:/tmp/pip-3UGCNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:15 INFO - Running setup.py (path:/tmp/pip-wxgICk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:15 INFO - Running setup.py (path:/tmp/pip-nQZtjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:15 INFO - Running setup.py (path:/tmp/pip-OOrzK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:15 INFO - Running setup.py (path:/tmp/pip-ooZ4rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:15 INFO - Running setup.py (path:/tmp/pip-AkO2jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:15 INFO - Running setup.py (path:/tmp/pip-mWGD7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:15 INFO - Running setup.py (path:/tmp/pip-NpRxSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:15 INFO - Running setup.py (path:/tmp/pip-vJGzTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:15 INFO - Running setup.py (path:/tmp/pip-ichRcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:15 INFO - Running setup.py (path:/tmp/pip-xNOex9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:16 INFO - Running setup.py (path:/tmp/pip-D18cCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:16 INFO - Running setup.py (path:/tmp/pip-U3iQAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:16 INFO - Running setup.py (path:/tmp/pip-nQoHKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:16 INFO - Running setup.py (path:/tmp/pip-Cm2U8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:16 INFO - Running setup.py (path:/tmp/pip-MBkQX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:16 INFO - Running setup.py (path:/tmp/pip-kfDVJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:46:16 INFO - Running setup.py install for manifestparser 02:46:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:46:16 INFO - Running setup.py install for mozcrash 02:46:16 INFO - Running setup.py install for mozdebug 02:46:16 INFO - Running setup.py install for mozdevice 02:46:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:46:16 INFO - Running setup.py install for mozfile 02:46:16 INFO - Running setup.py install for mozhttpd 02:46:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Running setup.py install for mozinfo 02:46:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Running setup.py install for mozInstall 02:46:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Running setup.py install for mozleak 02:46:17 INFO - Running setup.py install for mozlog 02:46:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Running setup.py install for moznetwork 02:46:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Running setup.py install for mozprocess 02:46:17 INFO - Running setup.py install for mozprofile 02:46:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Running setup.py install for mozrunner 02:46:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:46:17 INFO - Running setup.py install for mozscreenshot 02:46:18 INFO - Running setup.py install for moztest 02:46:18 INFO - Running setup.py install for mozversion 02:46:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:46:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:46:18 INFO - Cleaning up... 02:46:18 INFO - Return code: 0 02:46:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:18 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:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:18 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:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:18 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 0x137b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', '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:18 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:18 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:18 INFO - Using env: {'DISPLAY': ':0', 02:46:18 INFO - 'HOME': '/home/cltbld', 02:46:18 INFO - 'LANG': 'en_US.UTF-8', 02:46:18 INFO - 'LANGUAGE': 'en_US:en', 02:46:18 INFO - 'LOGNAME': 'cltbld', 02:46:18 INFO - 'MAIL': '/var/mail/cltbld', 02:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:18 INFO - 'MOZ_NO_REMOTE': '1', 02:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:18 INFO - 'NO_EM_RESTART': '1', 02:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:18 INFO - 'PWD': '/builds/slave/test', 02:46:18 INFO - 'SHELL': '/bin/bash', 02:46:18 INFO - 'SHLVL': '1', 02:46:18 INFO - 'TERM': 'linux', 02:46:18 INFO - 'TMOUT': '86400', 02:46:18 INFO - 'USER': 'cltbld', 02:46:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:18 INFO - '_': '/tools/buildbot/bin/python'} 02:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:18 INFO - Running setup.py (path:/tmp/pip-zmgZId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:18 INFO - Running setup.py (path:/tmp/pip-wbVPiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:18 INFO - Running setup.py (path:/tmp/pip-f1xIyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:18 INFO - Running setup.py (path:/tmp/pip-4BGA_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:18 INFO - Running setup.py (path:/tmp/pip-UFkvNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:18 INFO - Running setup.py (path:/tmp/pip-mgH_aN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:18 INFO - Running setup.py (path:/tmp/pip-BXxKIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:18 INFO - Running setup.py (path:/tmp/pip-FLsUjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:19 INFO - Running setup.py (path:/tmp/pip-qzKw5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:19 INFO - Running setup.py (path:/tmp/pip-UD0IoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:19 INFO - Running setup.py (path:/tmp/pip-0j0wL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:19 INFO - Running setup.py (path:/tmp/pip-JZY1cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:19 INFO - Running setup.py (path:/tmp/pip-T0eGKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:19 INFO - Running setup.py (path:/tmp/pip-wYMs9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:19 INFO - Running setup.py (path:/tmp/pip-_eFt3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:19 INFO - Running setup.py (path:/tmp/pip-2KcIBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:19 INFO - Running setup.py (path:/tmp/pip-Iyw4rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:19 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:19 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:19 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:19 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:19 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:19 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:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:19 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:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:20 INFO - Downloading blessings-1.6.tar.gz 02:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:46:20 INFO - Installing collected packages: blessings 02:46:20 INFO - Running setup.py install for blessings 02:46:20 INFO - Successfully installed blessings 02:46:20 INFO - Cleaning up... 02:46:21 INFO - Return code: 0 02:46:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:21 INFO - Reading from file tmpfile_stdout 02:46:21 INFO - Current package versions: 02:46:21 INFO - argparse == 1.2.1 02:46:21 INFO - blessings == 1.6 02:46:21 INFO - blobuploader == 1.2.4 02:46:21 INFO - docopt == 0.6.1 02:46:21 INFO - functools32 == 3.2.3-2 02:46:21 INFO - jsonschema == 2.5.1 02:46:21 INFO - manifestparser == 1.1 02:46:21 INFO - mozInstall == 1.12 02:46:21 INFO - mozcrash == 1.0 02:46:21 INFO - mozdebug == 0.1 02:46:21 INFO - mozdevice == 0.50 02:46:21 INFO - mozfile == 1.2 02:46:21 INFO - mozhttpd == 0.7 02:46:21 INFO - mozinfo == 0.9 02:46:21 INFO - mozleak == 0.1 02:46:21 INFO - mozlog == 3.4 02:46:21 INFO - moznetwork == 0.27 02:46:21 INFO - mozprocess == 0.25 02:46:21 INFO - mozprofile == 0.28 02:46:21 INFO - mozrunner == 6.13 02:46:21 INFO - mozscreenshot == 0.1 02:46:21 INFO - mozsystemmonitor == 0.3 02:46:21 INFO - moztest == 0.8 02:46:21 INFO - mozversion == 1.4 02:46:21 INFO - psutil == 3.1.1 02:46:21 INFO - requests == 1.2.3 02:46:21 INFO - wsgiref == 0.1.2 02:46:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:21 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 0x137b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', '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:21 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:21 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: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 - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:21 INFO - 'MOZ_NO_REMOTE': '1', 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': '/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 - '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:21 INFO - '_': '/tools/buildbot/bin/python'} 02:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 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:21 INFO - Cleaning up... 02:46:21 INFO - Return code: 0 02:46:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x137b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', '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:21 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:21 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: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 - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:21 INFO - 'MOZ_NO_REMOTE': '1', 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': '/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 - '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': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:21 INFO - '_': '/tools/buildbot/bin/python'} 02:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:46:21 INFO - Cleaning up... 02:46:21 INFO - Return code: 0 02:46:21 INFO - Running post-action listener: _resource_record_post_action 02:46:21 INFO - Running post-action listener: _start_resource_monitoring 02:46:21 INFO - Starting resource monitoring. 02:46:21 INFO - [mozharness: 2017-05-04 09:46:21.753257Z] Finished create-virtualenv step (success) 02:46:21 INFO - [mozharness: 2017-05-04 09:46:21.753797Z] Running install step. 02:46:21 INFO - Running pre-action listener: _resource_record_pre_action 02:46:21 INFO - Running main action method: install 02:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:21 INFO - Reading from file tmpfile_stdout 02:46:21 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:22 INFO - Reading from file tmpfile_stdout 02:46:22 INFO - Output received: 02:46:22 INFO - Usage: mozinstall [options] installer 02:46:22 INFO - Options: 02:46:22 INFO - -h, --help show this help message and exit 02:46:22 INFO - -d DEST, --destination=DEST 02:46:22 INFO - Directory to install application into. [default: 02:46:22 INFO - "/builds/slave/test"] 02:46:22 INFO - --app=APP Application being installed. [default: firefox] 02:46:22 INFO - mkdir: /builds/slave/test/build/application 02:46:22 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:22 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:37 INFO - Reading from file tmpfile_stdout 02:46:37 INFO - Output received: 02:46:37 INFO - /builds/slave/test/build/application/firefox/firefox 02:46:37 INFO - Running post-action listener: _resource_record_post_action 02:46:37 INFO - [mozharness: 2017-05-04 09:46:37.446627Z] Finished install step (success) 02:46:37 INFO - [mozharness: 2017-05-04 09:46:37.446897Z] Running run-tests step. 02:46:37 INFO - Running pre-action listener: _resource_record_pre_action 02:46:37 INFO - Running main action method: run_tests 02:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:46:37 INFO - Python 2.7.3 02:46:37 INFO - Return code: 0 02:46:37 INFO - grabbing minidump binary from tooltool 02:46:37 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:37 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 0x1616400>, '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 0x16173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:46:37 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:37 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:37 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:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:46:37 INFO - Return code: 0 02:46:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:46:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:46:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:46:37 INFO - ENV: RUST_BACKTRACE is now 1 02:46:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:46:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--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-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --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-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:46:37 INFO - Using env: {'DISPLAY': ':0', 02:46:37 INFO - 'HOME': '/home/cltbld', 02:46:37 INFO - 'LANG': 'en_US.UTF-8', 02:46:37 INFO - 'LANGUAGE': 'en_US:en', 02:46:37 INFO - 'LOGNAME': 'cltbld', 02:46:37 INFO - 'MAIL': '/var/mail/cltbld', 02:46:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:46:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:37 INFO - 'MOZ_NO_REMOTE': '1', 02:46:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:37 INFO - 'NO_EM_RESTART': '1', 02:46:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:37 INFO - 'PWD': '/builds/slave/test', 02:46:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:46:37 INFO - 'RUST_BACKTRACE': '1', 02:46:37 INFO - 'SHELL': '/bin/bash', 02:46:37 INFO - 'SHLVL': '1', 02:46:37 INFO - 'TERM': 'linux', 02:46:37 INFO - 'TMOUT': '86400', 02:46:37 INFO - 'USER': 'cltbld', 02:46:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1493890086.329458-1850836592', 02:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:37 INFO - '_': '/tools/buildbot/bin/python'} 02:46:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--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-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:46:37 INFO - mozversion application_buildid: 20170504091347 02:46:37 INFO - mozversion application_changeset: a8d597ee6dd58306e62e55a07c4ab20958726d6a 02:46:37 INFO - mozversion application_display_name: Nightly 02:46:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:46:37 INFO - mozversion application_name: Firefox 02:46:37 INFO - mozversion application_remotingname: firefox 02:46:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:46:37 INFO - mozversion application_vendor: Mozilla 02:46:37 INFO - mozversion application_version: 55.0a1 02:46:37 INFO - mozversion platform_buildid: 20170504091347 02:46:37 INFO - mozversion platform_changeset: a8d597ee6dd58306e62e55a07c4ab20958726d6a 02:46:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:46:37 INFO - mozversion platform_version: 55.0a1 02:46:37 INFO - using testdate: 1493891197 02:46:37 INFO - actual date: 1493891197 02:46:37 INFO - starting webserver on 'localhost:51117' 02:46:37 INFO - SUITE-START | Running 2 tests 02:46:37 INFO - TEST-START | dromaeo_css 02:46:37 INFO - operating with platform_type : linux_ 02:46:37 INFO - Initialising browser for dromaeo_css test... 02:46:37 INFO - TEST-INFO | started process 28605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkWF16X/profile http://localhost:51117/getInfo.html) 02:46:42 INFO - PID 28605 | __metrics Screen width/height:1600/1200 02:46:42 INFO - PID 28605 | colorDepth:24 02:46:42 INFO - PID 28605 | Browser inner width/height: 1024/695 02:46:42 INFO - PID 28605 | __metrics 02:46:43 INFO - PID 28605 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:46:43 INFO - PID 28605 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:46:44 INFO - TEST-INFO | 28605: exit 0 02:46:44 INFO - Browser initialized. 02:46:44 INFO - Running cycle 1/1 for dromaeo_css test... 02:46:44 INFO - TEST-INFO | started process 28704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkWF16X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:56 INFO - PID 28704 | RSS: Main: 168329216 02:46:56 INFO - PID 28704 | 02:50:02 INFO - PID 28704 | Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51117/tests/dromaeo/cssquery-ext.html) 02:50:04 INFO - PID 28704 | RSS: Main: 293601280 02:50:04 INFO - PID 28704 | 02:53:06 INFO - PID 28704 | Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-ext.html (next: http://localhost:51117/tests/dromaeo/cssquery-jquery.html) 02:53:07 INFO - PID 28704 | RSS: Main: 255807488 02:53:07 INFO - PID 28704 | 02:56:09 INFO - PID 28704 | Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51117/tests/dromaeo/cssquery-mootools.html) 02:56:09 INFO - PID 28704 | RSS: Main: 197554176 02:56:09 INFO - PID 28704 | 02:59:12 INFO - PID 28704 | Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51117/tests/dromaeo/cssquery-prototype.html) 02:59:12 INFO - PID 28704 | RSS: Main: 235552768 02:59:12 INFO - PID 28704 | 03:02:16 INFO - PID 28704 | Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51117/tests/dromaeo/cssquery-yui.html) 03:02:16 INFO - PID 28704 | RSS: Main: 203505664 03:02:16 INFO - PID 28704 | 03:05:18 INFO - PID 28704 | Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-yui.html (next: http://localhost:51117/tests/dromaeo/cssquery-dojo.html) 03:05:19 INFO - PID 28704 | RSS: Main: 292438016 03:05:19 INFO - PID 28704 | 03:05:19 INFO - PID 28704 | __start_tp_report 03:05:19 INFO - PID 28704 | _x_x_mozilla_page_load 03:05:19 INFO - PID 28704 | _x_x_mozilla_page_load_details 03:05:19 INFO - PID 28704 | |i|pagename|runs| 03:05:19 INFO - PID 28704 | |0;dojo.html;2692.6364940733;2708.9051883184093;2742.0402858999355;2743.0810678422727;2751.4084471838564;5023.372078490189;5155.407128180261;5173.327467429229;5213.66111202772;5254.6847189168675;5090.821821236257;5120.769565369558;5139.640225184238;5158.458361872005;5191.896162076756;4300.161468513641;4520.819167233307;4569.337446070318;4632.907341853161;4650.0932318197965;4613.999999999984;4664.043871006453;4664.86005419838;4671.766411679402;4675.181843177447;4500.684952053325;4538;4541.909161816779;4561.657875659339;4606.60843828275;4553.430821147356;4558.339040839093;4566.70316429431;4567.474740404863;4569.428821397325;4516.864494065183;4542.068875880436;4542.6138778203895;4615.076984603093;4641.396618439615;5063.772130254148;5109.284700141983;5126.974365128151;5139.511746384125;5145.099607568661;5593.52455041322;5598.216249725042;5609;5612.69130197839;5621.213030175779;5543.113101903717;5618.2415373924405;5648.124540696199;5658.009848276576;5733.655980641175;5182.093133701587;5184.274201611777;5195;5198.16829307309;5200.791968321225;5654.123610840326;5723.141528770718;5727.341355744059;5729.742161602738;5737.77048918047;5430.56555475561;5472.945270547243;5527.613067085346;5533;5535.003699334158;5579.218909352694;5585.748641311151;5608.186812912105;5610.775568977195;5614.29821272341;5478.369987451414;5516.007118718589;5535.916961245584;5540.113581826889;5612.943870561242;5517.668939863621;5522.502974732293;5583.637063590853;5588.580856435784;5610.298712660918;4658.557437043475;4664.86005419838;4669.929951050737;4673.462551806586;4704.482506924235;3929.233799409145;3965.18713663704;3980.44273801668;4019.8191081401405;4028.697847661437;4633;4671.346011558385;4687;4759.524047595212;4765;5641.802536911188;5653.575981801381;5655.0386434306265;5655.095184770417;5691.857703557444;4752.405949256343;4757.952420475751;4761.809527618926;4765.7140571565815;4801.663883528119;4888.828890988798;4931;4963.305137280783;5005.324281221989;5011.4236862761245;5183.170692689152;5217.713025783618;5218.55642270396;5228.085085110167;5253.632245742914;5406.486383793534;5481.671099734029;5496.587755918402;5517.144842549411;5618.381977982337;5219.686818790885;5238.580913526833;5258.316418865523;5271.525562699376;5274.472552744848;5427.48438898304;5428.430014848542;5494.532964698045;5500.58745594074;5513.448655134454;5545.417731138173;5597.04850175463;5611.6352437091455;5638.15427685834;5672.262605861211;5417.377001644703;5426.728663566885;5432.701201433959;5434.619576629598;5445.373782015119;5259.605529585373;5331.520163185177;5348.7593058311695;5432;5480.424555421623;5385.8114965976;5388.676679399248;5426.755795989111;5428.185772134211;5437.157240627709;5476.288082549243;5476.315460567429;5479.835604931858;5480.068388373907;5491.176323551499;5167.793288268427;5263.315768950012;5333.06671332523;5336.199570064521;5387.138057910715 03:05:19 INFO - PID 28704 | |1;ext.html;636.9713362898669;691.5366704308113;709.3792931185213;1009.4195837393501;1017.242154594826;25321.36696582584;31720;32489.350212995727;32562.67437325626;32623.836880815594;33025.66974330256;33310.83344583274;33382.165445863866;33422.66577334232;33481.16297092574;4994.825181118662;5017.19724844025;6751.493637977159;6875.7937261882225;6879.071325371061;6693.933060669379;6825.590464572117;6826.112605361321;6826.522143449961;6827.044213810046;6877.7592784252565;6962.930370696279;6963.303669633022;6968.128983877015;6995.055667484875;6847.965760171217;6848.14398200225;6879.071325371086;6913.032175495435;6923.238443771181;6653.567518111356;6723.697433615499;6777.62723050232;6790.117284753;6795;30829.537556936662;30893.536596951064;30975.76096956119;31120.221994450094;31142;3067.2638566744045;3092.597962264914;3108.689131086896;3109.5335699645007;3110.673379295164;23296.06815727369;23404.18085367004;23420.64869026966;23655.408614784767;23656.881715591484;2966.970330296691;2974.3456439583256;2977.077106097117;2986.1041687493666;2989.5067313893182;138336.30831845876;139208;139303;139311;139706;40440.39339409911;40634.79682601568;40655.18689626191;40669.18661626751;40737.79631101825;42768.78615606964;42780;42922;43009.35485967713;43014.78492607517;12420.689482763004;12427.31649759254;12431.191972521758;12440.626781196579;12447.75104497905;8937.553122343857;9124.771880702903;10018.899811001942;10026.197904167795;10044.045815647502;11667.124965627612;11704.297742135499;11743.88256117428;11754.106520657044;11850.288982661068;4882.389701287339;4892.944963115428;4902.131903752649;4903.280944880327;4919.4834542373255;901.2204443156622;920.5351297594672;921.9308551858637;934.2479304160216;954.88063992001;20082.799172008094;20226.595468090556;20385.694214586794;20814.985113630104;20913.26803561868;1005.3917379985149;1011.600417834951;1027.6454623155;1030.2685093583639;1036.9222308326905;10293.16221375952;10923.235373523936;11043;11048.779024419628;11129.109671226282;163761;164100;164130;164795;165190;37331;37358.62641373552;37448.251034979694;37471.43792843109;37524.24951500955;1216.635009497165;1246.8005119181068;1247.289045244202;1267.113020885384;1273.5669872243298;18986.335478258196;19699.40901772949;20201.393958181277;20326.491837703583;20597.58804823925;28480.145595632162;28545.860850176192;28559.28601784972;28570.714292857636;28590.85704571547;150425.2478737643;150602;150951;151362;151546.24226878796;23717.52564948726;24231.15190968378;24238.272851814472;27772.583411249252;27925.720742793124;28811.56782648304;28968.420631587673;32296.515552267203;32882.17794555155;33589.3282134351;25026.499470010134;25579.104731334315;25989.31069480478;26018.479630407666;26953.86523067372;25053.624195637443;25673.35816604525;25931.61102583425;26297.342566435993;26622.06822761194;28179;28252.15243542615;28360.43279134447;28397;29141.56287655729;26480.602790958535;26692.261667331008;26833;26889.193324200307;27265;20568.485787855425;21660.675089873348;21765.347039588836;21888.671669924646;22058 03:05:19 INFO - PID 28704 | |2;jquery.html;412.65543271368404;415.8211968853392;427.15636617680076;430.37165738022486;431.1205141511317;11087.50106245219;16652.916735416322;17302.48092557222;17437.738433923485;17983;14103.92948035261;14178.515402523963;16581.91709041456;17488.912555437204;18246.17892194851;5382.6232163748555;5431.158170483582;5568.443155684419;5592.6085174037835;5594.8601284968;5523.033469142904;5561.916571251434;5561.944380556183;5562.9443705562835;5564.10974244121;5413.702246376448;5419.214213938996;5434.2935418395555;5470.8085217017415;5501.394846566875;5450.836474905759;5465.098258787295;5489.39616642169;5498.5876059295715;5508.7521061552325;4942.18453955097;5058.519440653132;5059.924101138486;5060.924086138711;5064.5441910228255;20216.21675654869;21370.78629213719;21505.67741483879;21565.784342156534;21702.89148554263;1705.4883534939593;1720.8537274331698;1732.436957988646;1735.1064201936013;1738.1917408405152;14190.148591084464;14260.429582816674;14381.065230759967;14429.639259018504;14689.118652880754;1975.7233987241798;2052.794720527935;2084.135083940163;2084.5830833833293;2092.0899408757086;83588.58205708994;86624.56687716521;86754.5662271691;87625.12374876233;88768.55615721944;10759.085477734323;10822.350658960488;10905.236633435741;10907.345559266469;11208.49561769706;15452.304646290944;15458;15522.922385388227;15538.844611553966;15543.145127018122;6736.966315168393;7032.12098487689;7377.9631101845225;7610.657520411595;7844.843103137905;6799.524033317719;6912.412444942236;7152.4278057755255;7159.856802863914;7251.7099316027825;6755.2906944771075;6831.316868313129;6884.208316043619;6933.37599616037;6964.582125072512;1957.7161311609736;2008.8694234874686;2013.3154727392757;2035.4606029401923;2089.3418573149715;860.5353109320897;891.362675686874;895.8566629339274;900.3922352412096;924.3899026642383;16201.432949846934;16386.918065409598;16507.669846603;16518.504444866674;17100.230489627997;881.6297155194834;890.6749036601594;896.5830888636815;900.9729708108767;924.4083786376724;9011.459312441275;9060.818783624423;9265.305102117369;9378.202852757591;9410.247180225566;337634;339228;344670;344870;346645;75610.6219468899;75812;76049;76370.61814691003;76787.61606191934;1033.395463653771;1043.8642976413018;1078.4607696151925;1078.6440474643505;1079.8985035264143;13849.723005540034;14176.362063707364;14208.573742787732;14268.928655357073;14649.780253296422;35804.82097589495;35957.460638090975;36115.097122572144;36297.45553816642;36489.81755091208;45289.547104529855;45477.54522454865;46037;47012.059758803945;47857.5214247867;8082.434229603871;8151.5109093454585;8273.296769774637;8357.707480238163;8643.615692777996;12610.117291789487;13074.28091454979;13128.671783205496;13264.801027984395;13378.531751388655;10290.897091029294;10459.326507758722;10506.212034097625;10620.09729173029;10854.67435976922;9931.602735890483;10221.23340749432;10252.179825614083;10497.370157790558;10501.737456563647;11046.98516442049;11079.16906232052;11105.37138769982;11508.36703981289;11739.295642261492;8174;8205.79485512867;8337.95831020841;8354.039285482004;8369.455985361175;10585.788284234119;10586.656422588328;10627.840582391116;10669.786604267716;11181.32912025281 03:05:19 INFO - PID 28704 | |3;mootools.html;1233.0936761480311;1280.609414128691;1283.3134273163853;1298.026480139895;1300.8504022037457;9614.37506562073;9922.156616687591;9946.850797238047;9948.204143668507;9950.751231219223;9958.253131015184;10175.542100605471;10184.74538136547;10191.643292484765;10203.948980255089;2243.4054975431523;2279.680844681746;2286.4398222435443;2290.931272061841;2291.6218823894037;1828.597708504127;1908.2557802456984;2152.838537109723;2220.400491867195;2231.129859354853;1880.7931127575955;1896.1372575478124;1901.0399748127177;2094.7695753467106;2209.834262430316;2143.057054895841;2147.914083436661;2150.731158605174;2152.117631770974;2153.246363772683;2093.8534302598823;2114.587655407196;2120.840936929721;2121.809037186645;2125.0968338456096;9631.229501639922;9827.459489728062;9830.311878168532;9839.163671087967;9844.606215751433;5456.563474921997;5582.134769110794;5622.662640241599;5639.802606908738;5647.209390685307;3177.3327601203773;3359.9496007559906;3365.7980521168806;3369.275605744777;3428.6228514863597;1019.7042857571296;1035.1046344911672;1048.832186850108;1084.0514549768952;1087.8041952448557;14374.784378234335;14418.567442976622;14440.494582689555;14492.34784434703;14492.927535362256;4605.585497305258;4797.928031079537;4824.758762061883;4841.564259216688;4902.3872015998;10531;10550.103241224428;10565.841512377321;10577.048065674126;10601.73495662599;5494.917576236359;5504.862378440491;5510.972445137749;5512.090505066619;5524.475174858382;4886.975565122151;5022.472640372781;5032.270320803463;5090.160123579568;5132.717700526432;3613.9096522587147;3709.9629003710156;3735.906602334909;3752.7560708553856;3799.259144466858;1023.8566600675912;1027.1679939249232;1041.063043261071;1045.2839804733783;1054.056619325699;688.9827754306183;708.9255628158969;712.2379054411833;729.8284903047779;731.637839269565;5214.895702085937;5234.555062819627;5359.035373632783;5432.049391356497;5461;542.2544001997254;559.5048382181799;559.8432438917109;562.8620987858001;569.8831739493394;3317.270200555874;3372.7639065265685;3579.5167652367118;3642.1623026704005;3713.2573485302505;12450.875491244971;12913.160644558073;13046.34768261602;13084.607461775971;13096.738065238642;12527.498900043896;12934.741305173844;12991.935040324737;12993.740125197632;13015.544455943997;7467.7012919483695;7618.123915749759;7637.69449222036;7662.195469475736;7675.961620191975;5987.670678112746;5991.281046274475;6024.186734790747;6089.147519347206;6169.598976066542;11175.832362514406;11497.712557186138;11580.073594112619;11690.88309116898;11880.821787673365;11590.304581725124;11854.407279636156;12026.699332516757;12037.277763334228;12040.939795300967;8089.959550202211;8119.675212991414;8220.342372610296;8226.383021273308;8237.917620823715;8990.415622984485;9074.137956894085;9076.09239076087;9082.772930676785;9093.40892841963;7848.097468790934;7970.322522585645;8028.759137225892;8160.795980100307;8265.421420500506;7672.961635191788;7720.6139693014;7790.4546681734;7818.726344577913;7879.566623835515;7188.892166617609;7280.599567023864;7304.7078116876855;7310.19587845326;7312.670929808278;5079.339685840817;5226.817061402832;5234.97382513085;5262.97368513155;5437.8368648940595;5140.354369898586;5199.870003249949;5216.026864687092;5315.01672190646;5322.121849894724 03:05:19 INFO - PID 28704 | |4;prototype.html;352.92941411717663;360.9187932715138;382.7741632436862;404.06459047305486;405.533636318234;5147.897042059157;5224.268602395663;5368.516833484986;5369.650972686783;5420.945790542103;5137.974310128454;5257.370215233271;5305.7877684892555;5308.336457942757;5320.228566857803;4096.119334343116;4134.904250373654;4146.129312844307;4160.438340823988;4187.434696315989;3987.700922430815;4062.7156099073077;4093.038136038029;4182.665386769067;4211.136716973028;4138.420621113047;4151.14901445203;4152.937705934413;4164.646005089571;4166.395872598471;4163.437935878648;4179.247735407625;4181.184668989548;4182.330827067654;4195.58044195578;3572.464130380438;3648.2521083177885;3733.626637336272;3794.2221844522082;3834.578196398394;5102.030614183293;5110.207917772751;5112.872178195537;5113.1052065888325;5116.002379535992;4955.628327875424;4961.454240033593;4970.776315065795;4975.651704380694;5043.067032598981;5555.3333599967855;5625.746841392106;5637.915431268534;5683.9715801420725;5723.370429252779;4289.442372491556;4295;4298.161858437606;4315.978420107911;4320.956790432087;5827.558163321297;5835.183074369592;5897.91153132699;5909.763609455659;5948.97025514874;4320.762358070274;4371.30059190528;4386.670999675037;4391.780410979438;4404.515503294635;4204.225211360487;4314.352847072964;4517.909641807146;4526.547345265513;4532.297493888453;4825.710457372569;4937.333459982929;4939.333190019302;4946.159152944008;4998.350544320366;5606.299212598426;5665.206871038058;5690.829275121753;5691.203231547586;5710.114932185518;1529.770534419846;1552.5808031831343;1567.9216039197995;1580.5179420276927;1591.5861875912346;1134.0587312530745;1139.680889350983;1146.656003199037;1170.7307319316606;1177.8468799056068;4849.709017458893;4893.681910675795;4904.092742842586;4911.091448082117;4912.606991440676;5729.627574207663;5757.942420575824;5799.130130480462;5801.419858014249;5827.067669172997;4799.520047995243;4878.780454879539;4905.632077594195;4915.640492563518;4919.458859525449;3068.8925887593828;3075.43104525659;3083.6145481814774;3087.1818967973504;3087.228192951762;5410.296661433988;5412;5413.242146099549;5440;5442.700651464128;5775.94224057754;5882.3529411764675;5893.587448878623;5897.439743224387;5910.852228694317;5362.168863826035;5374.758135883894;5390.595705322038;5392.786623009792;5409.675419474844;5649.971750141223;5756.1941328214925;5771.94228057714;5777.711114444345;5793.217915581511;5689.431056894277;5701.942980570141;5728.54171666274;5729.28383952006;5751.9137212941005;5349.919751203657;5415.729213539228;5448.700321482198;5451.318585176853;5462.781488740406;4180.289350810309;4403.933940990952;4480.081583275486;4538.909221815479;4549.863504094882;5595.720213989202;5729.885402291848;5825.330087040044;5826.475617194473;5839.649621022752;5615.725631119403;5615.831525054255;5654.575906806924;5672.177534257592;5678.0915053591225;5527.861803454945;5570.554355651457;5580.469855363734;5607.45794906404;5636.8162685834795;5557.555395568425;5563.944360556343;5572.888542229214;5593.161025846156;5594.468525490072;5534.142207957773;5620.353659329229;5673.291168330358;5691.288588926384;5702.88793685244;5500;5504.366997795145;5525.392206857323;5527.226188333556;5543.8891222176135 03:05:19 INFO - PID 28704 | |5;yui.html;696.6725638949692;696.7944456385366;717.6124892558018;718.4898721907446;722.692855536397;11881.52473901044;12502.749945001095;12505.062120340988;12507.749845003105;12510.562130325441;14631.853681463183;14884.479043233488;14986.850131498682;15048.172350520717;15073.849261507381;906.6282824042128;920.6087412849546;923.2152670230284;923.3490389275545;924.3252425729222;906.9047749986255;908.5366463103799;908.8273228086642;909.2634965677822;909.8953620333647;909.8271328447607;917.3761841947473;965.9420434773936;971.4074414607084;971.5239532628996;920.8756817829574;921.5530467723149;921.6543796076471;922.2760133295365;926.1248120526105;682.3960794696729;683.0778449093733;683.2245401469319;683.4259222253281;684.3430306905377;13337.266450345227;13391.799123013163;13453.192808431428;13495.66260843477;13556.86443135566;15286.859839622462;15488.148151851643;15538.223088845512;15806.60483487922;15814.525564232976;11918.702032449171;11922.821157682642;12138.575149869712;12154.298398224255;12182;2799.1602519244348;2865.412590418959;2866.65600127986;2867.584200290967;2869.9426011479654;69734;69902.65048674724;70648.64675676641;71923.28076719218;72126.91809622913;12043.397830108635;12121;12224.266544007389;12328;12458.75082498345;22081.372930964037;22470.775292246868;22509.549809004056;22533.549329013327;23034.193803217142;5990.9101363479585;6047.2743270806905;6055.8486037848525;6067.393260673897;6081.239845019372;2916.824990500534;2960.467115919112;2977.851107444619;3015.9547606785914;3027.7880548361404;3423.4180189367867;3509.701675357572;3517.402041652925;3518.225990282134;3519.9824000880344;632.7943418389042;632.8133200705803;635.6091004032487;638.635977492834;640.5260107520495;559.2729451712758;565.4797586220686;568.8350378390303;570.7602806821145;571.6398668838605;9230.676926307682;9518.238540916711;9884.25868059884;10049.547770350351;10515.894841051644;595.2886300870505;602.6805792929754;604.2386592892987;608.1121562518772;625.5121005615628;4381.627561657231;4406.49325327585;4423.712458690175;4430.933535996963;4456.3538286948215;60918.39081609216;62025.37974620196;63044.68477657674;63761.36238637647;64380;56998.7150064247;58171.70914145487;58370.4162958365;58503.41496585065;58702.11946820801;39226.80386598049;48312.27531587029;50020.749896251014;50522;50537.74731126321;9853.556589953612;9963.750906227402;10216.540255688364;10416.791664166523;10433.26967112295;25028.24915252545;25618;25812.741872581784;25932.61101083523;26393.20820375392;30282.54576181315;30979.225519362197;31080.84459577778;31274.843625781727;31589.36821263608;12791.232526048467;13294.468221271427;13461.730765384833;13682.179069255877;13695.383707732977;14791.704165916406;15058.171800550637;15425;15769.605759856095;15826.208689565707;13668.726625467236;14406.207658578878;14408.351624176728;14443.49447769323;14875;13350.197723307228;13728.862711372758;13827.723445530832;13950.09324393911;14769.704605908037;13033.608991730263;13186.670333241746;13316.400761965928;13876.722465550834;14082.929585352007;10368.533415996148;10490.895091048991;10673.146148307962;10779.13766898662;11251;10529.315594486334;11139.16456265767;11167.274127181707;11244.437778110898;11373.715657108638 03:05:19 INFO - PID 28704 | __end_tp_report 03:05:19 INFO - PID 28704 | __start_cc_report 03:05:19 INFO - PID 28704 | _x_x_mozilla_cycle_collect,1284 03:05:19 INFO - PID 28704 | __end_cc_report 03:05:19 INFO - PID 28704 | __startTimestamp1493892319149__endTimestamp 03:05:19 INFO - PID 28704 | 03:05:19 INFO - PID 28704 | ------- Summary: start ------- 03:05:19 INFO - PID 28704 | Number of tests: 6 03:05:19 INFO - PID 28704 | 03:05:19 INFO - PID 28704 | [#0] dojo.html Cycles:165 Average:5096.54 Median:5254.68 stddev:603.10 (11.5%) stddev-sans-first:574.71 03:05:19 INFO - PID 28704 | Values: 2692.6 2708.9 2742.0 2743.1 2751.4 5023.4 5155.4 5173.3 5213.7 5254.7 5090.8 5120.8 5139.6 5158.5 5191.9 4300.2 4520.8 4569.3 4632.9 4650.1 4614.0 4664.0 4664.9 4671.8 4675.2 4500.7 4538.0 4541.9 4561.7 4606.6 4553.4 4558.3 4566.7 4567.5 4569.4 4516.9 4542.1 4542.6 4615.1 4641.4 5063.8 5109.3 5127.0 5139.5 5145.1 5593.5 5598.2 5609.0 5612.7 5621.2 5543.1 5618.2 5648.1 5658.0 5733.7 5182.1 5184.3 5195.0 5198.2 5200.8 5654.1 5723.1 5727.3 5729.7 5737.8 5430.6 5472.9 5527.6 5533.0 5535.0 5579.2 5585.7 5608.2 5610.8 5614.3 5478.4 5516.0 5535.9 5540.1 5612.9 5517.7 5522.5 5583.6 5588.6 5610.3 4658.6 4664.9 4669.9 4673.5 4704.5 3929.2 3965.2 3980.4 4019.8 4028.7 4633.0 4671.3 4687.0 4759.5 4765.0 5641.8 5653.6 5655.0 5655.1 5691.9 4752.4 4758.0 4761.8 4765.7 4801.7 4888.8 4931.0 4963.3 5005.3 5011.4 5183.2 5217.7 5218.6 5228.1 5253.6 5406.5 5481.7 5496.6 5517.1 5618.4 5219.7 5238.6 5258.3 5271.5 5274.5 5427.5 5428.4 5494.5 5500.6 5513.4 5545.4 5597.0 5611.6 5638.2 5672.3 5417.4 5426.7 5432.7 5434.6 5445.4 5259.6 5331.5 5348.8 5432.0 5480.4 5385.8 5388.7 5426.8 5428.2 5437.2 5476.3 5476.3 5479.8 5480.1 5491.2 5167.8 5263.3 5333.1 5336.2 5387.1 03:05:19 INFO - PID 28704 | 03:05:19 INFO - PID 28704 | [#1] ext.html Cycles:180 Average:28944.85 Median:28513.00 stddev:39160.61 (137.3%) stddev-sans-first:39212.77 03:05:19 INFO - PID 28704 | Values: 637.0 691.5 709.4 1009.4 1017.2 25321.4 31720.0 32489.4 32562.7 32623.8 33025.7 33310.8 33382.2 33422.7 33481.2 4994.8 5017.2 6751.5 6875.8 6879.1 6693.9 6825.6 6826.1 6826.5 6827.0 6877.8 6962.9 6963.3 6968.1 6995.1 6848.0 6848.1 6879.1 6913.0 6923.2 6653.6 6723.7 6777.6 6790.1 6795.0 30829.5 30893.5 30975.8 31120.2 31142.0 3067.3 3092.6 3108.7 3109.5 3110.7 23296.1 23404.2 23420.6 23655.4 23656.9 2967.0 2974.3 2977.1 2986.1 2989.5 138336.3 139208.0 139303.0 139311.0 139706.0 40440.4 40634.8 40655.2 40669.2 40737.8 42768.8 42780.0 42922.0 43009.4 43014.8 12420.7 12427.3 12431.2 12440.6 12447.8 8937.6 9124.8 10018.9 10026.2 10044.0 11667.1 11704.3 11743.9 11754.1 11850.3 4882.4 4892.9 4902.1 4903.3 4919.5 901.2 920.5 921.9 934.2 954.9 20082.8 20226.6 20385.7 20815.0 20913.3 1005.4 1011.6 1027.6 1030.3 1036.9 10293.2 10923.2 11043.0 11048.8 11129.1 163761.0 164100.0 164130.0 164795.0 165190.0 37331.0 37358.6 37448.3 37471.4 37524.2 1216.6 1246.8 1247.3 1267.1 1273.6 18986.3 19699.4 20201.4 20326.5 20597.6 28480.1 28545.9 28559.3 28570.7 28590.9 150425.2 150602.0 150951.0 151362.0 151546.2 23717.5 24231.2 24238.3 27772.6 27925.7 28811.6 28968.4 32296.5 32882.2 33589.3 25026.5 25579.1 25989.3 26018.5 26953.9 25053.6 25673.4 25931.6 26297.3 26622.1 28179.0 28252.2 28360.4 28397.0 29141.6 26480.6 26692.3 26833.0 26889.2 27265.0 20568.5 21660.7 21765.3 21888.7 22058.0 03:05:19 INFO - PID 28704 | 03:05:19 INFO - PID 28704 | [#2] jquery.html Cycles:180 Average:23668.83 Median:36036.28 stddev:57211.58 (158.8%) stddev-sans-first:57345.43 03:05:19 INFO - PID 28704 | Values: 412.7 415.8 427.2 430.4 431.1 11087.5 16652.9 17302.5 17437.7 17983.0 14103.9 14178.5 16581.9 17488.9 18246.2 5382.6 5431.2 5568.4 5592.6 5594.9 5523.0 5561.9 5561.9 5562.9 5564.1 5413.7 5419.2 5434.3 5470.8 5501.4 5450.8 5465.1 5489.4 5498.6 5508.8 4942.2 5058.5 5059.9 5060.9 5064.5 20216.2 21370.8 21505.7 21565.8 21702.9 1705.5 1720.9 1732.4 1735.1 1738.2 14190.1 14260.4 14381.1 14429.6 14689.1 1975.7 2052.8 2084.1 2084.6 2092.1 83588.6 86624.6 86754.6 87625.1 88768.6 10759.1 10822.4 10905.2 10907.3 11208.5 15452.3 15458.0 15522.9 15538.8 15543.1 6737.0 7032.1 7378.0 7610.7 7844.8 6799.5 6912.4 7152.4 7159.9 7251.7 6755.3 6831.3 6884.2 6933.4 6964.6 1957.7 2008.9 2013.3 2035.5 2089.3 860.5 891.4 895.9 900.4 924.4 16201.4 16386.9 16507.7 16518.5 17100.2 881.6 890.7 896.6 901.0 924.4 9011.5 9060.8 9265.3 9378.2 9410.2 337634.0 339228.0 344670.0 344870.0 346645.0 75610.6 75812.0 76049.0 76370.6 76787.6 1033.4 1043.9 1078.5 1078.6 1079.9 13849.7 14176.4 14208.6 14268.9 14649.8 35804.8 35957.5 36115.1 36297.5 36489.8 45289.5 45477.5 46037.0 47012.1 47857.5 8082.4 8151.5 8273.3 8357.7 8643.6 12610.1 13074.3 13128.7 13264.8 13378.5 10290.9 10459.3 10506.2 10620.1 10854.7 9931.6 10221.2 10252.2 10497.4 10501.7 11047.0 11079.2 11105.4 11508.4 11739.3 8174.0 8205.8 8338.0 8354.0 8369.5 10585.8 10586.7 10627.8 10669.8 11181.3 03:05:19 INFO - PID 28704 | 03:05:19 INFO - PID 28704 | [#3] mootools.html Cycles:180 Average:6131.15 Median:4811.34 stddev:3928.26 (81.6%) stddev-sans-first:3922.04 03:05:19 INFO - PID 28704 | Values: 1233.1 1280.6 1283.3 1298.0 1300.9 9614.4 9922.2 9946.9 9948.2 9950.8 9958.3 10175.5 10184.7 10191.6 10203.9 2243.4 2279.7 2286.4 2290.9 2291.6 1828.6 1908.3 2152.8 2220.4 2231.1 1880.8 1896.1 1901.0 2094.8 2209.8 2143.1 2147.9 2150.7 2152.1 2153.2 2093.9 2114.6 2120.8 2121.8 2125.1 9631.2 9827.5 9830.3 9839.2 9844.6 5456.6 5582.1 5622.7 5639.8 5647.2 3177.3 3359.9 3365.8 3369.3 3428.6 1019.7 1035.1 1048.8 1084.1 1087.8 14374.8 14418.6 14440.5 14492.3 14492.9 4605.6 4797.9 4824.8 4841.6 4902.4 10531.0 10550.1 10565.8 10577.0 10601.7 5494.9 5504.9 5511.0 5512.1 5524.5 4887.0 5022.5 5032.3 5090.2 5132.7 3613.9 3710.0 3735.9 3752.8 3799.3 1023.9 1027.2 1041.1 1045.3 1054.1 689.0 708.9 712.2 729.8 731.6 5214.9 5234.6 5359.0 5432.0 5461.0 542.3 559.5 559.8 562.9 569.9 3317.3 3372.8 3579.5 3642.2 3713.3 12450.9 12913.2 13046.3 13084.6 13096.7 12527.5 12934.7 12991.9 12993.7 13015.5 7467.7 7618.1 7637.7 7662.2 7676.0 5987.7 5991.3 6024.2 6089.1 6169.6 11175.8 11497.7 11580.1 11690.9 11880.8 11590.3 11854.4 12026.7 12037.3 12040.9 8090.0 8119.7 8220.3 8226.4 8237.9 8990.4 9074.1 9076.1 9082.8 9093.4 7848.1 7970.3 8028.8 8160.8 8265.4 7673.0 7720.6 7790.5 7818.7 7879.6 7188.9 7280.6 7304.7 7310.2 7312.7 5079.3 5226.8 5235.0 5263.0 5437.8 5140.4 5199.9 5216.0 5315.0 5322.1 03:05:19 INFO - PID 28704 | 03:05:19 INFO - PID 28704 | [#4] prototype.html Cycles:180 Average:4713.42 Median:5142.94 stddev:1316.48 (25.6%) stddev-sans-first:1278.84 03:05:19 INFO - PID 28704 | Values: 352.9 360.9 382.8 404.1 405.5 5147.9 5224.3 5368.5 5369.7 5420.9 5138.0 5257.4 5305.8 5308.3 5320.2 4096.1 4134.9 4146.1 4160.4 4187.4 3987.7 4062.7 4093.0 4182.7 4211.1 4138.4 4151.1 4152.9 4164.6 4166.4 4163.4 4179.2 4181.2 4182.3 4195.6 3572.5 3648.3 3733.6 3794.2 3834.6 5102.0 5110.2 5112.9 5113.1 5116.0 4955.6 4961.5 4970.8 4975.7 5043.1 5555.3 5625.7 5637.9 5684.0 5723.4 4289.4 4295.0 4298.2 4316.0 4321.0 5827.6 5835.2 5897.9 5909.8 5949.0 4320.8 4371.3 4386.7 4391.8 4404.5 4204.2 4314.4 4517.9 4526.5 4532.3 4825.7 4937.3 4939.3 4946.2 4998.4 5606.3 5665.2 5690.8 5691.2 5710.1 1529.8 1552.6 1567.9 1580.5 1591.6 1134.1 1139.7 1146.7 1170.7 1177.8 4849.7 4893.7 4904.1 4911.1 4912.6 5729.6 5757.9 5799.1 5801.4 5827.1 4799.5 4878.8 4905.6 4915.6 4919.5 3068.9 3075.4 3083.6 3087.2 3087.2 5410.3 5412.0 5413.2 5440.0 5442.7 5775.9 5882.4 5893.6 5897.4 5910.9 5362.2 5374.8 5390.6 5392.8 5409.7 5650.0 5756.2 5771.9 5777.7 5793.2 5689.4 5701.9 5728.5 5729.3 5751.9 5349.9 5415.7 5448.7 5451.3 5462.8 4180.3 4403.9 4480.1 4538.9 4549.9 5595.7 5729.9 5825.3 5826.5 5839.6 5615.7 5615.8 5654.6 5672.2 5678.1 5527.9 5570.6 5580.5 5607.5 5636.8 5557.6 5563.9 5572.9 5593.2 5594.5 5534.1 5620.4 5673.3 5691.3 5702.9 5500.0 5504.4 5525.4 5527.2 5543.9 03:05:19 INFO - PID 28704 | 03:05:19 INFO - PID 28704 | [#5] yui.html Cycles:180 Average:14960.97 Median:30630.89 stddev:17805.66 (58.1%) stddev-sans-first:17823.39 03:05:19 INFO - PID 28704 | Values: 696.7 696.8 717.6 718.5 722.7 11881.5 12502.7 12505.1 12507.7 12510.6 14631.9 14884.5 14986.9 15048.2 15073.8 906.6 920.6 923.2 923.3 924.3 906.9 908.5 908.8 909.3 909.9 909.8 917.4 965.9 971.4 971.5 920.9 921.6 921.7 922.3 926.1 682.4 683.1 683.2 683.4 684.3 13337.3 13391.8 13453.2 13495.7 13556.9 15286.9 15488.1 15538.2 15806.6 15814.5 11918.7 11922.8 12138.6 12154.3 12182.0 2799.2 2865.4 2866.7 2867.6 2869.9 69734.0 69902.7 70648.6 71923.3 72126.9 12043.4 12121.0 12224.3 12328.0 12458.8 22081.4 22470.8 22509.5 22533.5 23034.2 5990.9 6047.3 6055.8 6067.4 6081.2 2916.8 2960.5 2977.9 3016.0 3027.8 3423.4 3509.7 3517.4 3518.2 3520.0 632.8 632.8 635.6 638.6 640.5 559.3 565.5 568.8 570.8 571.6 9230.7 9518.2 9884.3 10049.5 10515.9 595.3 602.7 604.2 608.1 625.5 4381.6 4406.5 4423.7 4430.9 4456.4 60918.4 62025.4 63044.7 63761.4 64380.0 56998.7 58171.7 58370.4 58503.4 58702.1 39226.8 48312.3 50020.7 50522.0 50537.7 9853.6 9963.8 10216.5 10416.8 10433.3 25028.2 25618.0 25812.7 25932.6 26393.2 30282.5 30979.2 31080.8 31274.8 31589.4 12791.2 13294.5 13461.7 13682.2 13695.4 14791.7 15058.2 15425.0 15769.6 15826.2 13668.7 14406.2 14408.4 14443.5 14875.0 13350.2 13728.9 13827.7 13950.1 14769.7 13033.6 13186.7 13316.4 13876.7 14082.9 10368.5 10490.9 10673.1 10779.1 11251.0 10529.3 11139.2 11167.3 11244.4 11373.7 03:05:19 INFO - PID 28704 | -------- Summary: end -------- 03:05:19 INFO - PID 28704 | 03:05:20 INFO - TEST-INFO | 28704: exit 0 03:05:20 INFO - TEST-OK | dromaeo_css | took 1122291ms 03:05:20 INFO - TEST-START | kraken 03:05:20 INFO - operating with platform_type : linux_ 03:05:20 INFO - Initialising browser for kraken test... 03:05:20 INFO - TEST-INFO | started process 29042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUvH6Ps/profile http://localhost:51117/getInfo.html) 03:05:24 INFO - PID 29042 | __metrics Screen width/height:1600/1200 03:05:24 INFO - PID 29042 | colorDepth:24 03:05:24 INFO - PID 29042 | Browser inner width/height: 1024/695 03:05:24 INFO - PID 29042 | __metrics 03:05:25 INFO - PID 29042 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:05:25 INFO - PID 29042 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:05:26 INFO - TEST-INFO | 29042: exit 0 03:05:26 INFO - Browser initialized. 03:05:26 INFO - Running cycle 1/1 for kraken test... 03:05:26 INFO - TEST-INFO | started process 29146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUvH6Ps/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:38 INFO - PID 29146 | RSS: Main: 169267200 03:05:38 INFO - PID 29146 | 03:05:41 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51117/tests/kraken/driver.html?testName=audio-beat-detection) 03:05:42 INFO - PID 29146 | RSS: Main: 245981184 03:05:42 INFO - PID 29146 | 03:05:45 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51117/tests/kraken/driver.html?testName=audio-dft) 03:05:45 INFO - PID 29146 | RSS: Main: 207577088 03:05:45 INFO - PID 29146 | 03:05:48 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51117/tests/kraken/driver.html?testName=audio-fft) 03:05:49 INFO - PID 29146 | RSS: Main: 290480128 03:05:49 INFO - PID 29146 | 03:05:51 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51117/tests/kraken/driver.html?testName=audio-oscillator) 03:05:52 INFO - PID 29146 | RSS: Main: 201445376 03:05:52 INFO - PID 29146 | 03:05:54 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:05:54 INFO - PID 29146 | RSS: Main: 204693504 03:05:54 INFO - PID 29146 | 03:05:58 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51117/tests/kraken/driver.html?testName=imaging-darkroom) 03:05:58 INFO - PID 29146 | RSS: Main: 263958528 03:05:58 INFO - PID 29146 | 03:06:02 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51117/tests/kraken/driver.html?testName=imaging-desaturate) 03:06:02 INFO - PID 29146 | RSS: Main: 264863744 03:06:02 INFO - PID 29146 | 03:06:05 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51117/tests/kraken/driver.html?testName=json-parse-financial) 03:06:06 INFO - PID 29146 | RSS: Main: 262164480 03:06:06 INFO - PID 29146 | 03:06:08 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:08 INFO - PID 29146 | RSS: Main: 226885632 03:06:08 INFO - PID 29146 | 03:06:10 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:11 INFO - PID 29146 | RSS: Main: 232742912 03:06:11 INFO - PID 29146 | 03:06:13 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:06:13 INFO - PID 29146 | RSS: Main: 240742400 03:06:13 INFO - PID 29146 | 03:06:16 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:17 INFO - PID 29146 | RSS: Main: 248983552 03:06:17 INFO - PID 29146 | 03:06:20 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:21 INFO - PID 29146 | RSS: Main: 247119872 03:06:21 INFO - PID 29146 | 03:06:22 INFO - PID 29146 | Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51117/tests/kraken/driver.html?testName=ai-astar) 03:06:23 INFO - PID 29146 | RSS: Main: 295071744 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | __start_tp_report 03:06:23 INFO - PID 29146 | _x_x_mozilla_page_load 03:06:23 INFO - PID 29146 | _x_x_mozilla_page_load_details 03:06:23 INFO - PID 29146 | |i|pagename|runs| 03:06:23 INFO - PID 29146 | |0;ai-astar;109;112;111;111;110;112;112;111;111;111 03:06:23 INFO - PID 29146 | |1;audio-beat-detection;145;124;123;168;121;122;121;122;144;121 03:06:23 INFO - PID 29146 | |2;audio-dft;162;162;163;163;163;162;162;161;162;163 03:06:23 INFO - PID 29146 | |3;audio-fft;75;74;75;114;75;74;75;75;92;74 03:06:23 INFO - PID 29146 | |4;audio-oscillator;84;84;111;82;82;82;104;82;82;102 03:06:23 INFO - PID 29146 | |5;imaging-gaussian-blur;114;114;114;113;114;114;114;114;115;115 03:06:23 INFO - PID 29146 | |6;imaging-darkroom;148;148;150;150;149;148;149;150;150;148 03:06:23 INFO - PID 29146 | |7;imaging-desaturate;94;94;93;94;93;93;94;93;94;94 03:06:23 INFO - PID 29146 | |8;json-parse-financial;52;52;52;53;54;54;52;53;54;53 03:06:23 INFO - PID 29146 | |9;json-stringify-tinderbox;55;56;54;54;55;54;55;55;55;55 03:06:23 INFO - PID 29146 | |10;stanford-crypto-aes;81;80;79;79;81;79;80;80;82;80 03:06:23 INFO - PID 29146 | |11;stanford-crypto-ccm;129;127;128;128;128;127;126;127;174;128 03:06:23 INFO - PID 29146 | |12;stanford-crypto-pbkdf2;186;191;200;190;189;189;186;190;194;196 03:06:23 INFO - PID 29146 | |13;stanford-crypto-sha256-iterative;75;70;69;73;73;70;72;69;68;69 03:06:23 INFO - PID 29146 | __end_tp_report 03:06:23 INFO - PID 29146 | __start_cc_report 03:06:23 INFO - PID 29146 | _x_x_mozilla_cycle_collect,1983 03:06:23 INFO - PID 29146 | __end_cc_report 03:06:23 INFO - PID 29146 | __startTimestamp1493892383087__endTimestamp 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | ------- Summary: start ------- 03:06:23 INFO - PID 29146 | Number of tests: 14 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.94 (0.8%) stddev-sans-first:0.67 03:06:23 INFO - PID 29146 | Values: 109.0 112.0 111.0 111.0 110.0 112.0 112.0 111.0 111.0 111.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:123.50 stddev:16.02 (13.0%) stddev-sans-first:16.18 03:06:23 INFO - PID 29146 | Values: 145.0 124.0 123.0 168.0 121.0 122.0 121.0 122.0 144.0 121.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 03:06:23 INFO - PID 29146 | Values: 162.0 162.0 163.0 163.0 163.0 162.0 162.0 161.0 162.0 163.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:13.05 (17.4%) stddev-sans-first:13.70 03:06:23 INFO - PID 29146 | Values: 75.0 74.0 75.0 114.0 75.0 74.0 75.0 75.0 92.0 74.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:82.00 stddev:11.40 (13.9%) stddev-sans-first:11.92 03:06:23 INFO - PID 29146 | Values: 84.0 84.0 111.0 82.0 82.0 82.0 104.0 82.0 82.0 102.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:06:23 INFO - PID 29146 | Values: 114.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 115.0 115.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 03:06:23 INFO - PID 29146 | Values: 148.0 148.0 150.0 150.0 149.0 148.0 149.0 150.0 150.0 148.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:06:23 INFO - PID 29146 | Values: 94.0 94.0 93.0 94.0 93.0 93.0 94.0 93.0 94.0 94.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.87 03:06:23 INFO - PID 29146 | Values: 52.0 52.0 52.0 53.0 54.0 54.0 52.0 53.0 54.0 53.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 03:06:23 INFO - PID 29146 | Values: 55.0 56.0 54.0 54.0 55.0 54.0 55.0 55.0 55.0 55.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:0.99 (1.2%) stddev-sans-first:1.00 03:06:23 INFO - PID 29146 | Values: 81.0 80.0 79.0 79.0 81.0 79.0 80.0 80.0 82.0 80.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:128.00 stddev:14.71 (11.5%) stddev-sans-first:15.56 03:06:23 INFO - PID 29146 | Values: 129.0 127.0 128.0 128.0 128.0 127.0 126.0 127.0 174.0 128.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.10 Median:190.50 stddev:4.41 (2.3%) stddev-sans-first:4.27 03:06:23 INFO - PID 29146 | Values: 186.0 191.0 200.0 190.0 189.0 189.0 186.0 190.0 194.0 196.0 03:06:23 INFO - PID 29146 | 03:06:23 INFO - PID 29146 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:2.30 (3.2%) stddev-sans-first:1.87 03:06:23 INFO - PID 29146 | Values: 75.0 70.0 69.0 73.0 73.0 70.0 72.0 69.0 68.0 69.0 03:06:23 INFO - PID 29146 | -------- Summary: end -------- 03:06:23 INFO - PID 29146 | 03:06:24 INFO - TEST-INFO | 29146: exit 0 03:06:24 INFO - TEST-OK | kraken | took 64505ms 03:06:24 INFO - SUITE-END | took 1186s 03:06:24 INFO - Completed test suite (00:19:47) 03:06:24 INFO - javascript benchmark 03:06:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6574.701197493294, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2692.6364940733, 2708.9051883184093, 2742.0402858999355, 2743.0810678422727, 2751.4084471838564, 5023.372078490189, 5155.407128180261, 5173.327467429229, 5213.66111202772, 5254.6847189168675, 5090.821821236257, 5120.769565369558, 5139.640225184238, 5158.458361872005, 5191.896162076756, 4300.161468513641, 4520.819167233307, 4569.337446070318, 4632.907341853161, 4650.0932318197965, 4613.999999999984, 4664.043871006453, 4664.86005419838, 4671.766411679402, 4675.181843177447, 4500.684952053325, 4538.0, 4541.909161816779, 4561.657875659339, 4606.60843828275, 4553.430821147356, 4558.339040839093, 4566.70316429431, 4567.474740404863, 4569.428821397325, 4516.864494065183, 4542.068875880436, 4542.6138778203895, 4615.076984603093, 4641.396618439615, 5063.772130254148, 5109.284700141983, 5126.974365128151, 5139.511746384125, 5145.099607568661, 5593.52455041322, 5598.216249725042, 5609.0, 5612.69130197839, 5621.213030175779, 5543.113101903717, 5618.2415373924405, 5648.124540696199, 5658.009848276576, 5733.655980641175, 5182.093133701587, 5184.274201611777, 5195.0, 5198.16829307309, 5200.791968321225, 5654.123610840326, 5723.141528770718, 5727.341355744059, 5729.742161602738, 5737.77048918047, 5430.56555475561, 5472.945270547243, 5527.613067085346, 5533.0, 5535.003699334158, 5579.218909352694, 5585.748641311151, 5608.186812912105, 5610.775568977195, 5614.29821272341, 5478.369987451414, 5516.007118718589, 5535.916961245584, 5540.113581826889, 5612.943870561242, 5517.668939863621, 5522.502974732293, 5583.637063590853, 5588.580856435784, 5610.298712660918, 4658.557437043475, 4664.86005419838, 4669.929951050737, 4673.462551806586, 4704.482506924235, 3929.233799409145, 3965.18713663704, 3980.44273801668, 4019.8191081401405, 4028.697847661437, 4633.0, 4671.346011558385, 4687.0, 4759.524047595212, 4765.0, 5641.802536911188, 5653.575981801381, 5655.0386434306265, 5655.095184770417, 5691.857703557444, 4752.405949256343, 4757.952420475751, 4761.809527618926, 4765.7140571565815, 4801.663883528119, 4888.828890988798, 4931.0, 4963.305137280783, 5005.324281221989, 5011.4236862761245, 5183.170692689152, 5217.713025783618, 5218.55642270396, 5228.085085110167, 5253.632245742914, 5406.486383793534, 5481.671099734029, 5496.587755918402, 5517.144842549411, 5618.381977982337, 5219.686818790885, 5238.580913526833, 5258.316418865523, 5271.525562699376, 5274.472552744848, 5427.48438898304, 5428.430014848542, 5494.532964698045, 5500.58745594074, 5513.448655134454, 5545.417731138173, 5597.04850175463, 5611.6352437091455, 5638.15427685834, 5672.262605861211, 5417.377001644703, 5426.728663566885, 5432.701201433959, 5434.619576629598, 5445.373782015119, 5259.605529585373, 5331.520163185177, 5348.7593058311695, 5432.0, 5480.424555421623, 5385.8114965976, 5388.676679399248, 5426.755795989111, 5428.185772134211, 5437.157240627709, 5476.288082549243, 5476.315460567429, 5479.835604931858, 5480.068388373907, 5491.176323551499, 5167.793288268427, 5263.315768950012, 5333.06671332523, 5336.199570064521, 5387.138057910715], "value": 5052.922124701376, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.9713362898669, 691.5366704308113, 709.3792931185213, 1009.4195837393501, 1017.242154594826, 25321.36696582584, 31720.0, 32489.350212995727, 32562.67437325626, 32623.836880815594, 33025.66974330256, 33310.83344583274, 33382.165445863866, 33422.66577334232, 33481.16297092574, 4994.825181118662, 5017.19724844025, 6751.493637977159, 6875.7937261882225, 6879.071325371061, 6693.933060669379, 6825.590464572117, 6826.112605361321, 6826.522143449961, 6827.044213810046, 6877.7592784252565, 6962.930370696279, 6963.303669633022, 6968.128983877015, 6995.055667484875, 6847.965760171217, 6848.14398200225, 6879.071325371086, 6913.032175495435, 6923.238443771181, 6653.567518111356, 6723.697433615499, 6777.62723050232, 6790.117284753, 6795.0, 30829.537556936662, 30893.536596951064, 30975.76096956119, 31120.221994450094, 31142.0, 3067.2638566744045, 3092.597962264914, 3108.689131086896, 3109.5335699645007, 3110.673379295164, 23296.06815727369, 23404.18085367004, 23420.64869026966, 23655.408614784767, 23656.881715591484, 2966.970330296691, 2974.3456439583256, 2977.077106097117, 2986.1041687493666, 2989.5067313893182, 138336.30831845876, 139208.0, 139303.0, 139311.0, 139706.0, 40440.39339409911, 40634.79682601568, 40655.18689626191, 40669.18661626751, 40737.79631101825, 42768.78615606964, 42780.0, 42922.0, 43009.35485967713, 43014.78492607517, 12420.689482763004, 12427.31649759254, 12431.191972521758, 12440.626781196579, 12447.75104497905, 8937.553122343857, 9124.771880702903, 10018.899811001942, 10026.197904167795, 10044.045815647502, 11667.124965627612, 11704.297742135499, 11743.88256117428, 11754.106520657044, 11850.288982661068, 4882.389701287339, 4892.944963115428, 4902.131903752649, 4903.280944880327, 4919.4834542373255, 901.2204443156622, 920.5351297594672, 921.9308551858637, 934.2479304160216, 954.88063992001, 20082.799172008094, 20226.595468090556, 20385.694214586794, 20814.985113630104, 20913.26803561868, 1005.3917379985149, 1011.600417834951, 1027.6454623155, 1030.2685093583639, 1036.9222308326905, 10293.16221375952, 10923.235373523936, 11043.0, 11048.779024419628, 11129.109671226282, 163761.0, 164100.0, 164130.0, 164795.0, 165190.0, 37331.0, 37358.62641373552, 37448.251034979694, 37471.43792843109, 37524.24951500955, 1216.635009497165, 1246.8005119181068, 1247.289045244202, 1267.113020885384, 1273.5669872243298, 18986.335478258196, 19699.40901772949, 20201.393958181277, 20326.491837703583, 20597.58804823925, 28480.145595632162, 28545.860850176192, 28559.28601784972, 28570.714292857636, 28590.85704571547, 150425.2478737643, 150602.0, 150951.0, 151362.0, 151546.24226878796, 23717.52564948726, 24231.15190968378, 24238.272851814472, 27772.583411249252, 27925.720742793124, 28811.56782648304, 28968.420631587673, 32296.515552267203, 32882.17794555155, 33589.3282134351, 25026.499470010134, 25579.104731334315, 25989.31069480478, 26018.479630407666, 26953.86523067372, 25053.624195637443, 25673.35816604525, 25931.61102583425, 26297.342566435993, 26622.06822761194, 28179.0, 28252.15243542615, 28360.43279134447, 28397.0, 29141.56287655729, 26480.602790958535, 26692.261667331008, 26833.0, 26889.193324200307, 27265.0, 20568.485787855425, 21660.675089873348, 21765.347039588836, 21888.671669924646, 22058.0], "value": 13942.29283431228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.65543271368404, 415.8211968853392, 427.15636617680076, 430.37165738022486, 431.1205141511317, 11087.50106245219, 16652.916735416322, 17302.48092557222, 17437.738433923485, 17983.0, 14103.92948035261, 14178.515402523963, 16581.91709041456, 17488.912555437204, 18246.17892194851, 5382.6232163748555, 5431.158170483582, 5568.443155684419, 5592.6085174037835, 5594.8601284968, 5523.033469142904, 5561.916571251434, 5561.944380556183, 5562.9443705562835, 5564.10974244121, 5413.702246376448, 5419.214213938996, 5434.2935418395555, 5470.8085217017415, 5501.394846566875, 5450.836474905759, 5465.098258787295, 5489.39616642169, 5498.5876059295715, 5508.7521061552325, 4942.18453955097, 5058.519440653132, 5059.924101138486, 5060.924086138711, 5064.5441910228255, 20216.21675654869, 21370.78629213719, 21505.67741483879, 21565.784342156534, 21702.89148554263, 1705.4883534939593, 1720.8537274331698, 1732.436957988646, 1735.1064201936013, 1738.1917408405152, 14190.148591084464, 14260.429582816674, 14381.065230759967, 14429.639259018504, 14689.118652880754, 1975.7233987241798, 2052.794720527935, 2084.135083940163, 2084.5830833833293, 2092.0899408757086, 83588.58205708994, 86624.56687716521, 86754.5662271691, 87625.12374876233, 88768.55615721944, 10759.085477734323, 10822.350658960488, 10905.236633435741, 10907.345559266469, 11208.49561769706, 15452.304646290944, 15458.0, 15522.922385388227, 15538.844611553966, 15543.145127018122, 6736.966315168393, 7032.12098487689, 7377.9631101845225, 7610.657520411595, 7844.843103137905, 6799.524033317719, 6912.412444942236, 7152.4278057755255, 7159.856802863914, 7251.7099316027825, 6755.2906944771075, 6831.316868313129, 6884.208316043619, 6933.37599616037, 6964.582125072512, 1957.7161311609736, 2008.8694234874686, 2013.3154727392757, 2035.4606029401923, 2089.3418573149715, 860.5353109320897, 891.362675686874, 895.8566629339274, 900.3922352412096, 924.3899026642383, 16201.432949846934, 16386.918065409598, 16507.669846603, 16518.504444866674, 17100.230489627997, 881.6297155194834, 890.6749036601594, 896.5830888636815, 900.9729708108767, 924.4083786376724, 9011.459312441275, 9060.818783624423, 9265.305102117369, 9378.202852757591, 9410.247180225566, 337634.0, 339228.0, 344670.0, 344870.0, 346645.0, 75610.6219468899, 75812.0, 76049.0, 76370.61814691003, 76787.61606191934, 1033.395463653771, 1043.8642976413018, 1078.4607696151925, 1078.6440474643505, 1079.8985035264143, 13849.723005540034, 14176.362063707364, 14208.573742787732, 14268.928655357073, 14649.780253296422, 35804.82097589495, 35957.460638090975, 36115.097122572144, 36297.45553816642, 36489.81755091208, 45289.547104529855, 45477.54522454865, 46037.0, 47012.059758803945, 47857.5214247867, 8082.434229603871, 8151.5109093454585, 8273.296769774637, 8357.707480238163, 8643.615692777996, 12610.117291789487, 13074.28091454979, 13128.671783205496, 13264.801027984395, 13378.531751388655, 10290.897091029294, 10459.326507758722, 10506.212034097625, 10620.09729173029, 10854.67435976922, 9931.602735890483, 10221.23340749432, 10252.179825614083, 10497.370157790558, 10501.737456563647, 11046.98516442049, 11079.16906232052, 11105.37138769982, 11508.36703981289, 11739.295642261492, 8174.0, 8205.79485512867, 8337.95831020841, 8354.039285482004, 8369.455985361175, 10585.788284234119, 10586.656422588328, 10627.840582391116, 10669.786604267716, 11181.32912025281], "value": 8658.266013973374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1233.0936761480311, 1280.609414128691, 1283.3134273163853, 1298.026480139895, 1300.8504022037457, 9614.37506562073, 9922.156616687591, 9946.850797238047, 9948.204143668507, 9950.751231219223, 9958.253131015184, 10175.542100605471, 10184.74538136547, 10191.643292484765, 10203.948980255089, 2243.4054975431523, 2279.680844681746, 2286.4398222435443, 2290.931272061841, 2291.6218823894037, 1828.597708504127, 1908.2557802456984, 2152.838537109723, 2220.400491867195, 2231.129859354853, 1880.7931127575955, 1896.1372575478124, 1901.0399748127177, 2094.7695753467106, 2209.834262430316, 2143.057054895841, 2147.914083436661, 2150.731158605174, 2152.117631770974, 2153.246363772683, 2093.8534302598823, 2114.587655407196, 2120.840936929721, 2121.809037186645, 2125.0968338456096, 9631.229501639922, 9827.459489728062, 9830.311878168532, 9839.163671087967, 9844.606215751433, 5456.563474921997, 5582.134769110794, 5622.662640241599, 5639.802606908738, 5647.209390685307, 3177.3327601203773, 3359.9496007559906, 3365.7980521168806, 3369.275605744777, 3428.6228514863597, 1019.7042857571296, 1035.1046344911672, 1048.832186850108, 1084.0514549768952, 1087.8041952448557, 14374.784378234335, 14418.567442976622, 14440.494582689555, 14492.34784434703, 14492.927535362256, 4605.585497305258, 4797.928031079537, 4824.758762061883, 4841.564259216688, 4902.3872015998, 10531.0, 10550.103241224428, 10565.841512377321, 10577.048065674126, 10601.73495662599, 5494.917576236359, 5504.862378440491, 5510.972445137749, 5512.090505066619, 5524.475174858382, 4886.975565122151, 5022.472640372781, 5032.270320803463, 5090.160123579568, 5132.717700526432, 3613.9096522587147, 3709.9629003710156, 3735.906602334909, 3752.7560708553856, 3799.259144466858, 1023.8566600675912, 1027.1679939249232, 1041.063043261071, 1045.2839804733783, 1054.056619325699, 688.9827754306183, 708.9255628158969, 712.2379054411833, 729.8284903047779, 731.637839269565, 5214.895702085937, 5234.555062819627, 5359.035373632783, 5432.049391356497, 5461.0, 542.2544001997254, 559.5048382181799, 559.8432438917109, 562.8620987858001, 569.8831739493394, 3317.270200555874, 3372.7639065265685, 3579.5167652367118, 3642.1623026704005, 3713.2573485302505, 12450.875491244971, 12913.160644558073, 13046.34768261602, 13084.607461775971, 13096.738065238642, 12527.498900043896, 12934.741305173844, 12991.935040324737, 12993.740125197632, 13015.544455943997, 7467.7012919483695, 7618.123915749759, 7637.69449222036, 7662.195469475736, 7675.961620191975, 5987.670678112746, 5991.281046274475, 6024.186734790747, 6089.147519347206, 6169.598976066542, 11175.832362514406, 11497.712557186138, 11580.073594112619, 11690.88309116898, 11880.821787673365, 11590.304581725124, 11854.407279636156, 12026.699332516757, 12037.277763334228, 12040.939795300967, 8089.959550202211, 8119.675212991414, 8220.342372610296, 8226.383021273308, 8237.917620823715, 8990.415622984485, 9074.137956894085, 9076.09239076087, 9082.772930676785, 9093.40892841963, 7848.097468790934, 7970.322522585645, 8028.759137225892, 8160.795980100307, 8265.421420500506, 7672.961635191788, 7720.6139693014, 7790.4546681734, 7818.726344577913, 7879.566623835515, 7188.892166617609, 7280.599567023864, 7304.7078116876855, 7310.19587845326, 7312.670929808278, 5079.339685840817, 5226.817061402832, 5234.97382513085, 5262.97368513155, 5437.8368648940595, 5140.354369898586, 5199.870003249949, 5216.026864687092, 5315.01672190646, 5322.121849894724], "value": 4579.271422975912, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.92941411717663, 360.9187932715138, 382.7741632436862, 404.06459047305486, 405.533636318234, 5147.897042059157, 5224.268602395663, 5368.516833484986, 5369.650972686783, 5420.945790542103, 5137.974310128454, 5257.370215233271, 5305.7877684892555, 5308.336457942757, 5320.228566857803, 4096.119334343116, 4134.904250373654, 4146.129312844307, 4160.438340823988, 4187.434696315989, 3987.700922430815, 4062.7156099073077, 4093.038136038029, 4182.665386769067, 4211.136716973028, 4138.420621113047, 4151.14901445203, 4152.937705934413, 4164.646005089571, 4166.395872598471, 4163.437935878648, 4179.247735407625, 4181.184668989548, 4182.330827067654, 4195.58044195578, 3572.464130380438, 3648.2521083177885, 3733.626637336272, 3794.2221844522082, 3834.578196398394, 5102.030614183293, 5110.207917772751, 5112.872178195537, 5113.1052065888325, 5116.002379535992, 4955.628327875424, 4961.454240033593, 4970.776315065795, 4975.651704380694, 5043.067032598981, 5555.3333599967855, 5625.746841392106, 5637.915431268534, 5683.9715801420725, 5723.370429252779, 4289.442372491556, 4295.0, 4298.161858437606, 4315.978420107911, 4320.956790432087, 5827.558163321297, 5835.183074369592, 5897.91153132699, 5909.763609455659, 5948.97025514874, 4320.762358070274, 4371.30059190528, 4386.670999675037, 4391.780410979438, 4404.515503294635, 4204.225211360487, 4314.352847072964, 4517.909641807146, 4526.547345265513, 4532.297493888453, 4825.710457372569, 4937.333459982929, 4939.333190019302, 4946.159152944008, 4998.350544320366, 5606.299212598426, 5665.206871038058, 5690.829275121753, 5691.203231547586, 5710.114932185518, 1529.770534419846, 1552.5808031831343, 1567.9216039197995, 1580.5179420276927, 1591.5861875912346, 1134.0587312530745, 1139.680889350983, 1146.656003199037, 1170.7307319316606, 1177.8468799056068, 4849.709017458893, 4893.681910675795, 4904.092742842586, 4911.091448082117, 4912.606991440676, 5729.627574207663, 5757.942420575824, 5799.130130480462, 5801.419858014249, 5827.067669172997, 4799.520047995243, 4878.780454879539, 4905.632077594195, 4915.640492563518, 4919.458859525449, 3068.8925887593828, 3075.43104525659, 3083.6145481814774, 3087.1818967973504, 3087.228192951762, 5410.296661433988, 5412.0, 5413.242146099549, 5440.0, 5442.700651464128, 5775.94224057754, 5882.3529411764675, 5893.587448878623, 5897.439743224387, 5910.852228694317, 5362.168863826035, 5374.758135883894, 5390.595705322038, 5392.786623009792, 5409.675419474844, 5649.971750141223, 5756.1941328214925, 5771.94228057714, 5777.711114444345, 5793.217915581511, 5689.431056894277, 5701.942980570141, 5728.54171666274, 5729.28383952006, 5751.9137212941005, 5349.919751203657, 5415.729213539228, 5448.700321482198, 5451.318585176853, 5462.781488740406, 4180.289350810309, 4403.933940990952, 4480.081583275486, 4538.909221815479, 4549.863504094882, 5595.720213989202, 5729.885402291848, 5825.330087040044, 5826.475617194473, 5839.649621022752, 5615.725631119403, 5615.831525054255, 5654.575906806924, 5672.177534257592, 5678.0915053591225, 5527.861803454945, 5570.554355651457, 5580.469855363734, 5607.45794906404, 5636.8162685834795, 5557.555395568425, 5563.944360556343, 5572.888542229214, 5593.161025846156, 5594.468525490072, 5534.142207957773, 5620.353659329229, 5673.291168330358, 5691.288588926384, 5702.88793685244, 5500.0, 5504.366997795145, 5525.392206857323, 5527.226188333556, 5543.8891222176135], "value": 4320.983194227141, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.6725638949692, 696.7944456385366, 717.6124892558018, 718.4898721907446, 722.692855536397, 11881.52473901044, 12502.749945001095, 12505.062120340988, 12507.749845003105, 12510.562130325441, 14631.853681463183, 14884.479043233488, 14986.850131498682, 15048.172350520717, 15073.849261507381, 906.6282824042128, 920.6087412849546, 923.2152670230284, 923.3490389275545, 924.3252425729222, 906.9047749986255, 908.5366463103799, 908.8273228086642, 909.2634965677822, 909.8953620333647, 909.8271328447607, 917.3761841947473, 965.9420434773936, 971.4074414607084, 971.5239532628996, 920.8756817829574, 921.5530467723149, 921.6543796076471, 922.2760133295365, 926.1248120526105, 682.3960794696729, 683.0778449093733, 683.2245401469319, 683.4259222253281, 684.3430306905377, 13337.266450345227, 13391.799123013163, 13453.192808431428, 13495.66260843477, 13556.86443135566, 15286.859839622462, 15488.148151851643, 15538.223088845512, 15806.60483487922, 15814.525564232976, 11918.702032449171, 11922.821157682642, 12138.575149869712, 12154.298398224255, 12182.0, 2799.1602519244348, 2865.412590418959, 2866.65600127986, 2867.584200290967, 2869.9426011479654, 69734.0, 69902.65048674724, 70648.64675676641, 71923.28076719218, 72126.91809622913, 12043.397830108635, 12121.0, 12224.266544007389, 12328.0, 12458.75082498345, 22081.372930964037, 22470.775292246868, 22509.549809004056, 22533.549329013327, 23034.193803217142, 5990.9101363479585, 6047.2743270806905, 6055.8486037848525, 6067.393260673897, 6081.239845019372, 2916.824990500534, 2960.467115919112, 2977.851107444619, 3015.9547606785914, 3027.7880548361404, 3423.4180189367867, 3509.701675357572, 3517.402041652925, 3518.225990282134, 3519.9824000880344, 632.7943418389042, 632.8133200705803, 635.6091004032487, 638.635977492834, 640.5260107520495, 559.2729451712758, 565.4797586220686, 568.8350378390303, 570.7602806821145, 571.6398668838605, 9230.676926307682, 9518.238540916711, 9884.25868059884, 10049.547770350351, 10515.894841051644, 595.2886300870505, 602.6805792929754, 604.2386592892987, 608.1121562518772, 625.5121005615628, 4381.627561657231, 4406.49325327585, 4423.712458690175, 4430.933535996963, 4456.3538286948215, 60918.39081609216, 62025.37974620196, 63044.68477657674, 63761.36238637647, 64380.0, 56998.7150064247, 58171.70914145487, 58370.4162958365, 58503.41496585065, 58702.11946820801, 39226.80386598049, 48312.27531587029, 50020.749896251014, 50522.0, 50537.74731126321, 9853.556589953612, 9963.750906227402, 10216.540255688364, 10416.791664166523, 10433.26967112295, 25028.24915252545, 25618.0, 25812.741872581784, 25932.61101083523, 26393.20820375392, 30282.54576181315, 30979.225519362197, 31080.84459577778, 31274.843625781727, 31589.36821263608, 12791.232526048467, 13294.468221271427, 13461.730765384833, 13682.179069255877, 13695.383707732977, 14791.704165916406, 15058.171800550637, 15425.0, 15769.605759856095, 15826.208689565707, 13668.726625467236, 14406.207658578878, 14408.351624176728, 14443.49447769323, 14875.0, 13350.197723307228, 13728.862711372758, 13827.723445530832, 13950.09324393911, 14769.704605908037, 13033.608991730263, 13186.670333241746, 13316.400761965928, 13876.722465550834, 14082.929585352007, 10368.533415996148, 10490.895091048991, 10673.146148307962, 10779.13766898662, 11251.0, 10529.315594486334, 11139.16456265767, 11167.274127181707, 11244.437778110898, 11373.715657108638], "value": 6691.72774752515, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 111.0, 111.0, 110.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 123.0, 168.0, 121.0, 122.0, 121.0, 122.0, 144.0, 121.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 163.0, 162.0, 162.0, 161.0, 162.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 114.0, 75.0, 74.0, 75.0, 75.0, 92.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 111.0, 82.0, 82.0, 82.0, 104.0, 82.0, 82.0, 102.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 150.0, 150.0, 149.0, 148.0, 149.0, 150.0, 150.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 93.0, 93.0, 94.0, 93.0, 94.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 54.0, 54.0, 52.0, 53.0, 54.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 79.0, 81.0, 79.0, 80.0, 80.0, 82.0, 80.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 128.0, 128.0, 128.0, 127.0, 126.0, 127.0, 174.0, 128.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 191.0, 200.0, 190.0, 189.0, 189.0, 186.0, 190.0, 194.0, 196.0], "value": 191.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 69.0, 73.0, 73.0, 70.0, 72.0, 69.0, 68.0, 69.0], "value": 70.8, "unit": "score"}]}]} 03:06:24 INFO - Return code: 0 03:06:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:06:24 INFO - # TBPL SUCCESS # 03:06:24 INFO - Running post-action listener: _resource_record_post_action 03:06:24 INFO - [mozharness: 2017-05-04 10:06:24.894208Z] Finished run-tests step (success) 03:06:24 INFO - Running post-run listener: _resource_record_post_run 03:06:24 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 369475584; Read time: 20; Write time: 274520 03:06:24 INFO - TinderboxPrint: CPU usage
12.9% 03:06:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 03:06:24 INFO - TinderboxPrint: I/O write bytes / time
369,475,584 / 274,520 03:06:24 INFO - TinderboxPrint: CPU idle
8,357.8 (87.0%) 03:06:24 INFO - TinderboxPrint: CPU user
1,200.2 (12.5%) 03:06:24 INFO - TinderboxPrint: Swap in / out
0 / 0 03:06:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115703808; Read time: 0; Write time: 122276 03:06:25 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253771776; Read time: 20; Write time: 152244 03:06:25 INFO - Running post-run listener: _upload_blobber_files 03:06:25 INFO - Blob upload gear active. 03:06:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06:25 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:25 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:25 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:25 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:06:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:06:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:26 INFO - (blobuploader) - INFO - Done attempting. 03:06:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:06:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:06:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:29 INFO - (blobuploader) - INFO - Done attempting. 03:06:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:06:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:06:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:30 INFO - (blobuploader) - INFO - Done attempting. 03:06:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:06:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:06:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:31 INFO - (blobuploader) - INFO - Done attempting. 03:06:31 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:31 INFO - Return code: 0 03:06:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0844723fe80b68b739588cf38a7a5a35e32fb85ddfb4a8affb9d889aae4dca47a8671037932cb10af45bce4113c4f4794de1c387b7763697816fae934d8f21d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bb5496d15c42a32a53c93f877b65f26e65f792015e97a938e07a464b4e072682ca3b66d6971c8094e253435baae845a3cfcc7256d5a2aeee6e22dbaf62b0892", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40bb244965588d26b9bd01829ad80f908fe982826451b431aa1bd556a9956ff8f18bbf457d98a4fd9c35d4c8d21c91a035e4fdb53c49af06c5d78eb552ede444", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d708617a8c5d61e8f27b2b64170b651743da445f268785452feb45509fc9e4e35f0178903295260fbd8987f2113f1aa4ee676e243760d883ad78a38b2c0887e5"} 03:06:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:31 INFO - Contents: 03:06:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0844723fe80b68b739588cf38a7a5a35e32fb85ddfb4a8affb9d889aae4dca47a8671037932cb10af45bce4113c4f4794de1c387b7763697816fae934d8f21d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bb5496d15c42a32a53c93f877b65f26e65f792015e97a938e07a464b4e072682ca3b66d6971c8094e253435baae845a3cfcc7256d5a2aeee6e22dbaf62b0892", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40bb244965588d26b9bd01829ad80f908fe982826451b431aa1bd556a9956ff8f18bbf457d98a4fd9c35d4c8d21c91a035e4fdb53c49af06c5d78eb552ede444", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d708617a8c5d61e8f27b2b64170b651743da445f268785452feb45509fc9e4e35f0178903295260fbd8987f2113f1aa4ee676e243760d883ad78a38b2c0887e5"} 03:06:31 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:31 INFO - Copying logs to upload dir... 03:06:31 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.822412 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-04 03:06:30.949396) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 03:06:30.953774) ========= 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=4300f881736b422476174874000001bc-1493890086.329458-1850836592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0844723fe80b68b739588cf38a7a5a35e32fb85ddfb4a8affb9d889aae4dca47a8671037932cb10af45bce4113c4f4794de1c387b7763697816fae934d8f21d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bb5496d15c42a32a53c93f877b65f26e65f792015e97a938e07a464b4e072682ca3b66d6971c8094e253435baae845a3cfcc7256d5a2aeee6e22dbaf62b0892", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40bb244965588d26b9bd01829ad80f908fe982826451b431aa1bd556a9956ff8f18bbf457d98a4fd9c35d4c8d21c91a035e4fdb53c49af06c5d78eb552ede444", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d708617a8c5d61e8f27b2b64170b651743da445f268785452feb45509fc9e4e35f0178903295260fbd8987f2113f1aa4ee676e243760d883ad78a38b2c0887e5"} 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.011399 build_url: 'https://queue.taskcluster.net/v1/task/ItSf58erR_KVtIfo-h7vLA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0844723fe80b68b739588cf38a7a5a35e32fb85ddfb4a8affb9d889aae4dca47a8671037932cb10af45bce4113c4f4794de1c387b7763697816fae934d8f21d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bb5496d15c42a32a53c93f877b65f26e65f792015e97a938e07a464b4e072682ca3b66d6971c8094e253435baae845a3cfcc7256d5a2aeee6e22dbaf62b0892", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40bb244965588d26b9bd01829ad80f908fe982826451b431aa1bd556a9956ff8f18bbf457d98a4fd9c35d4c8d21c91a035e4fdb53c49af06c5d78eb552ede444", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d708617a8c5d61e8f27b2b64170b651743da445f268785452feb45509fc9e4e35f0178903295260fbd8987f2113f1aa4ee676e243760d883ad78a38b2c0887e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 03:06:30.981303) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:06:30.981616) ========= 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=4300f881736b422476174874000001bc-1493890086.329458-1850836592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:06:31.065011) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 03:06:31.065324) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 03:06:31.068633) ========= ========= Total master_lag: 0.61 =========