builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-084 starttime: 1491007585.72 results: success (0) revision: 7fe20a149f135533746ecaa9a1cf99619101eae0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:25.720092) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:25.720528) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:25.720792) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:25.735244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:25.735888) ========= 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=ea65d483da93c827905c2090000001f5-1491007585.593559-902888168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-31 17:46:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2017-03-31 17:46:26 (47.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136064 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:25.901693) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:25.901996) ========= 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=ea65d483da93c827905c2090000001f5-1491007585.593559-902888168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:25.951314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-31 17:46:25.951653) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7fe20a149f135533746ecaa9a1cf99619101eae0 --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 7fe20a149f135533746ecaa9a1cf99619101eae0 --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=ea65d483da93c827905c2090000001f5-1491007585.593559-902888168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-31 17:46:26,456 truncating revision to first 12 chars 2017-03-31 17:46:26,456 Setting DEBUG logging. 2017-03-31 17:46:26,456 attempt 1/10 2017-03-31 17:46:26,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7fe20a149f13?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 17:46:28,106 unpacking tar archive at: mozilla-central-7fe20a149f13/testing/mozharness/ program finished with exit code 0 elapsedTime=2.029141 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-31 17:46:27.996735) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:27.997054) ========= script_repo_revision: 7fe20a149f135533746ecaa9a1cf99619101eae0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:27.997410) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:27.997681) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 17:46:28.008678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-03-31 17:46:28.008960) ========= /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=ea65d483da93c827905c2090000001f5-1491007585.593559-902888168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:46:28 INFO - MultiFileLogger online at 20170331 17:46:28 in /builds/slave/test 17:46:28 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 17:46:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:46:28 INFO - {'append_to_log': False, 17:46:28 INFO - 'base_work_dir': '/builds/slave/test', 17:46:28 INFO - 'blob_upload_branch': 'Firefox', 17:46:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:46:28 INFO - 'branch': 'Firefox', 17:46:28 INFO - 'buildbot_json_path': 'buildprops.json', 17:46:28 INFO - 'config_files': ('talos/linux_config.py',), 17:46:28 INFO - 'default_actions': ('clobber', 17:46:28 INFO - 'read-buildbot-config', 17:46:28 INFO - 'download-and-extract', 17:46:28 INFO - 'populate-webroot', 17:46:28 INFO - 'create-virtualenv', 17:46:28 INFO - 'install', 17:46:28 INFO - 'run-tests'), 17:46:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:46:28 INFO - 'download_minidump_stackwalk': True, 17:46:28 INFO - 'download_symbols': 'ondemand', 17:46:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:46:28 INFO - 'tooltool.py': '/tools/tooltool.py', 17:46:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:46:28 INFO - '/tools/misc-python/virtualenv.py')}, 17:46:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:46:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:46:28 INFO - 'gecko_profile': False, 17:46:28 INFO - 'gecko_profile_interval': 0, 17:46:28 INFO - 'installer_path': 'installer.exe', 17:46:28 INFO - 'log_level': 'info', 17:46:28 INFO - 'log_name': 'talos', 17:46:28 INFO - 'log_to_console': True, 17:46:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:46:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:46:28 INFO - 'opt_config_files': (), 17:46:28 INFO - 'pip_index': False, 17:46:28 INFO - 'suite': 'dromaeojs', 17:46:28 INFO - 'system_bits': '32', 17:46:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:46:28 INFO - 'title': 'talos-linux64-ix-084', 17:46:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:46:28 INFO - 'use_talos_json': True, 17:46:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:46:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:46:28 INFO - 'work_dir': 'build'} 17:46:28 INFO - [mozharness: 2017-04-01 00:46:28.609545Z] Running clobber step. 17:46:28 INFO - Running pre-action listener: _resource_record_pre_action 17:46:28 INFO - Running main action method: clobber 17:46:28 INFO - rmtree: /builds/slave/test/build 17:46:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:46:29 INFO - Running post-action listener: _resource_record_post_action 17:46:29 INFO - [mozharness: 2017-04-01 00:46:29.544423Z] Finished clobber step (success) 17:46:29 INFO - [mozharness: 2017-04-01 00:46:29.544523Z] Running read-buildbot-config step. 17:46:29 INFO - Running pre-action listener: _resource_record_pre_action 17:46:29 INFO - Running main action method: read_buildbot_config 17:46:29 INFO - Using buildbot properties: 17:46:29 INFO - { 17:46:29 INFO - "project": "", 17:46:29 INFO - "product": "firefox", 17:46:29 INFO - "who": "kwierso@gmail.com", 17:46:29 INFO - "installer_path": "public/build/target.tar.bz2", 17:46:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 17:46:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:46:29 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 17:46:29 INFO - "stage_platform": "linux64-stylo", 17:46:29 INFO - "basedir": "/builds/slave/test", 17:46:29 INFO - "buildnumber": 4, 17:46:29 INFO - "platform": "ubuntu64_hw_stylo", 17:46:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:46:29 INFO - "slavebuilddir": "test", 17:46:29 INFO - "taskId": "MH3be-c5QXuYGGPI4aXNXQ", 17:46:29 INFO - "branch": "mozilla-central", 17:46:29 INFO - "script_repo_revision": "production", 17:46:29 INFO - "revision": "7fe20a149f135533746ecaa9a1cf99619101eae0", 17:46:29 INFO - "slavename": "talos-linux64-ix-084", 17:46:29 INFO - "repo_path": "mozilla-central" 17:46:29 INFO - } 17:46:29 INFO - Finding installer, test and symbols from parent task. 17:46:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MH3be-c5QXuYGGPI4aXNXQ'}, attempt #1 17:46:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MH3be-c5QXuYGGPI4aXNXQ'}, attempt #1 17:46:30 INFO - Task dependencies: IwyAVu8RSZ-9rY8PvL0Jyg 17:46:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg'}, attempt #1 17:46:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.tar.bz2 17:46:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/test_packages.json 17:46:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.crashreporter-symbols.zip 17:46:30 INFO - Running post-action listener: _resource_record_post_action 17:46:30 INFO - [mozharness: 2017-04-01 00:46:30.921430Z] Finished read-buildbot-config step (success) 17:46:30 INFO - [mozharness: 2017-04-01 00:46:30.921650Z] Running download-and-extract step. 17:46:30 INFO - Running pre-action listener: _resource_record_pre_action 17:46:30 INFO - Running main action method: download_and_extract 17:46:30 INFO - mkdir: /builds/slave/test/build/tests 17:46:30 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')]} 17:46:30 INFO - trying https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.test_packages.json 17:46:30 INFO - Downloading https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:46:31 INFO - Downloaded 986 bytes. 17:46:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:46:31 INFO - Using the following test package requirements: 17:46:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:46:31 INFO - u'common': [u'target.common.tests.zip'], 17:46:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:46:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:46:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:46:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:46:31 INFO - u'mozbase': [u'target.common.tests.zip'], 17:46:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:46:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:46:31 INFO - u'web-platform': [u'target.common.tests.zip', 17:46:31 INFO - u'target.web-platform.tests.zip'], 17:46:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:46:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:46:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.common.tests.zip 17:46:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:46:31 INFO - Fetch https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.common.tests.zip into memory 17:46:32 INFO - Expected file size: 58232579 17:46:32 INFO - Obtained file size: 58232579 17:46:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:46:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.common.tests.zip 17:46:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:46:42 INFO - Fetch https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.common.tests.zip into memory 17:46:43 INFO - Expected file size: 58232579 17:46:43 INFO - Obtained file size: 58232579 17:46:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.talos.tests.zip 17:46:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:46:54 INFO - Fetch https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.talos.tests.zip into memory 17:46:55 INFO - Expected file size: 14404152 17:46:55 INFO - Obtained file size: 14404152 17:46:55 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')]} 17:46:55 INFO - trying https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.tar.bz2 17:46:55 INFO - Downloading https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:46:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:46:56 INFO - Downloaded 63946166 bytes. 17:46:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.tar.bz2 17:46:56 INFO - mkdir: /builds/slave/test/properties 17:46:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:46:56 INFO - Writing to file /builds/slave/test/properties/build_url 17:46:56 INFO - Contents: 17:46:56 INFO - build_url:https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.tar.bz2 17:46:56 INFO - Running post-action listener: _resource_record_post_action 17:46:56 INFO - Running post-action listener: set_extra_try_arguments 17:46:56 INFO - [mozharness: 2017-04-01 00:46:56.544417Z] Finished download-and-extract step (success) 17:46:56 INFO - [mozharness: 2017-04-01 00:46:56.544514Z] Running populate-webroot step. 17:46:56 INFO - Running pre-action listener: _resource_record_pre_action 17:46:56 INFO - Running main action method: populate_webroot 17:46:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:46:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:46:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:46:56 INFO - '--tppagecycles', 17:46:56 INFO - '7'], 17:46:56 INFO - 'tests': ['tsvgm']}}, 17:46:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:46:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:46:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:46:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:46:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:46:56 INFO - 'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:46:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:46:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:46:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:46:56 INFO - 'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['damp', 'tps']}, 17:46:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:46:56 INFO - 'tests': ['damp', 'tps']}, 17:46:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['dromaeo_dom']}, 17:46:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:46:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['basic_compositor_video']}, 17:46:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:46:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['a11yr', 17:46:56 INFO - 'ts_paint', 17:46:56 INFO - 'tpaint', 17:46:56 INFO - 'sessionrestore', 17:46:56 INFO - 'sessionrestore_no_auto_restore', 17:46:56 INFO - 'tabpaint']}, 17:46:56 INFO - 'other-e10s': {'tests': ['a11yr', 17:46:56 INFO - 'ts_paint', 17:46:56 INFO - 'tpaint', 17:46:56 INFO - 'sessionrestore', 17:46:56 INFO - 'sessionrestore_no_auto_restore', 17:46:56 INFO - 'tabpaint']}, 17:46:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:46:56 INFO - 'ts_paint', 17:46:56 INFO - 'tpaint', 17:46:56 INFO - 'sessionrestore', 17:46:56 INFO - 'sessionrestore_no_auto_restore', 17:46:56 INFO - 'tabpaint']}, 17:46:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:46:56 INFO - 'ts_paint', 17:46:56 INFO - 'tpaint', 17:46:56 INFO - 'sessionrestore', 17:46:56 INFO - 'sessionrestore_no_auto_restore', 17:46:56 INFO - 'tabpaint']}, 17:46:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['a11yr', 17:46:56 INFO - 'ts_paint', 17:46:56 INFO - 'tpaint', 17:46:56 INFO - 'sessionrestore', 17:46:56 INFO - 'sessionrestore_no_auto_restore', 17:46:56 INFO - 'tabpaint']}, 17:46:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['a11yr', 17:46:56 INFO - 'ts_paint', 17:46:56 INFO - 'tpaint', 17:46:56 INFO - 'sessionrestore', 17:46:56 INFO - 'sessionrestore_no_auto_restore', 17:46:56 INFO - 'tabpaint']}, 17:46:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['tsvgx', 17:46:56 INFO - 'tsvgr_opacity', 17:46:56 INFO - 'tart', 17:46:56 INFO - 'tscrollx', 17:46:56 INFO - 'cart', 17:46:56 INFO - 'tsvg_static']}, 17:46:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:46:56 INFO - 'tsvgr_opacity', 17:46:56 INFO - 'tart', 17:46:56 INFO - 'tscrollx', 17:46:56 INFO - 'cart', 17:46:56 INFO - 'tsvg_static']}, 17:46:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:46:56 INFO - 'talos_options': ['--disable-e10s'], 17:46:56 INFO - 'tests': ['tp5o']}, 17:46:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:46:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:46:56 INFO - 'talos_options': ['--disable-e10s', 17:46:56 INFO - '--xperf_path', 17:46:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:46:56 INFO - 'tests': ['tp5n']}, 17:46:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:46:56 INFO - 'talos_options': ['--xperf_path', 17:46:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:46:56 INFO - 'tests': ['tp5n']}}, 17:46:56 INFO - 'talos.zip': {'path': '', 17:46:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:46:56 INFO - Running post-action listener: _resource_record_post_action 17:46:56 INFO - [mozharness: 2017-04-01 00:46:56.562806Z] Finished populate-webroot step (success) 17:46:56 INFO - [mozharness: 2017-04-01 00:46:56.562897Z] Running create-virtualenv step. 17:46:56 INFO - Running pre-action listener: _resource_record_pre_action 17:46:56 INFO - Running main action method: create_virtualenv 17:46:56 INFO - Creating virtualenv /builds/slave/test/build/venv 17:46:56 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 17:46:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:46:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:46:56 INFO - Using real prefix '/usr' 17:46:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:46:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:46:59 INFO - Installing pip.................done. 17:46:59 INFO - Return code: 0 17:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:46:59 INFO - Reading from file tmpfile_stdout 17:46:59 INFO - Output received: 17:46:59 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) 17:46:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x13e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, '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': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', '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 17:46:59 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 17:46:59 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 17:46:59 INFO - Using env: {'DISPLAY': ':0', 17:46:59 INFO - 'HOME': '/home/cltbld', 17:46:59 INFO - 'LANG': 'en_US.UTF-8', 17:46:59 INFO - 'LANGUAGE': 'en_US:en', 17:46:59 INFO - 'LOGNAME': 'cltbld', 17:46:59 INFO - 'MAIL': '/var/mail/cltbld', 17:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:59 INFO - 'MOZ_NO_REMOTE': '1', 17:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:59 INFO - 'NO_EM_RESTART': '1', 17:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:59 INFO - 'PWD': '/builds/slave/test', 17:46:59 INFO - 'SHELL': '/bin/bash', 17:46:59 INFO - 'SHLVL': '1', 17:46:59 INFO - 'TERM': 'linux', 17:46:59 INFO - 'TMOUT': '86400', 17:46:59 INFO - 'USER': 'cltbld', 17:46:59 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:59 INFO - '_': '/tools/buildbot/bin/python'} 17:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:59 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 17:46:59 INFO - Cleaning up... 17:46:59 INFO - Return code: 0 17:46:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x13e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, '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': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', '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 17:46:59 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 17:46:59 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 17:46:59 INFO - Using env: {'DISPLAY': ':0', 17:46:59 INFO - 'HOME': '/home/cltbld', 17:46:59 INFO - 'LANG': 'en_US.UTF-8', 17:46:59 INFO - 'LANGUAGE': 'en_US:en', 17:46:59 INFO - 'LOGNAME': 'cltbld', 17:46:59 INFO - 'MAIL': '/var/mail/cltbld', 17:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:59 INFO - 'MOZ_NO_REMOTE': '1', 17:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:59 INFO - 'NO_EM_RESTART': '1', 17:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:59 INFO - 'PWD': '/builds/slave/test', 17:46:59 INFO - 'SHELL': '/bin/bash', 17:46:59 INFO - 'SHLVL': '1', 17:46:59 INFO - 'TERM': 'linux', 17:46:59 INFO - 'TMOUT': '86400', 17:46:59 INFO - 'USER': 'cltbld', 17:46:59 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:59 INFO - '_': '/tools/buildbot/bin/python'} 17:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:59 INFO - Downloading/unpacking psutil>=3.1.1 17:46:59 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 17:46:59 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 17:46:59 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 17:46:59 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 17:46:59 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 17:46:59 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 17:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:47:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:01 INFO - Installing collected packages: psutil 17:47:01 INFO - Running setup.py install for psutil 17:47:01 INFO - building 'psutil._psutil_linux' extension 17:47:01 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 17:47:02 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 17:47:02 INFO - building 'psutil._psutil_posix' extension 17:47:02 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 17:47:02 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 17:47:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:02 INFO - Successfully installed psutil 17:47:02 INFO - Cleaning up... 17:47:02 INFO - Return code: 0 17:47:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:02 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 0x13e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, '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': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', '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 17:47:02 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 17:47:02 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 17:47:02 INFO - Using env: {'DISPLAY': ':0', 17:47:02 INFO - 'HOME': '/home/cltbld', 17:47:02 INFO - 'LANG': 'en_US.UTF-8', 17:47:02 INFO - 'LANGUAGE': 'en_US:en', 17:47:02 INFO - 'LOGNAME': 'cltbld', 17:47:02 INFO - 'MAIL': '/var/mail/cltbld', 17:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:02 INFO - 'MOZ_NO_REMOTE': '1', 17:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:02 INFO - 'NO_EM_RESTART': '1', 17:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:02 INFO - 'PWD': '/builds/slave/test', 17:47:02 INFO - 'SHELL': '/bin/bash', 17:47:02 INFO - 'SHLVL': '1', 17:47:02 INFO - 'TERM': 'linux', 17:47:02 INFO - 'TMOUT': '86400', 17:47:02 INFO - 'USER': 'cltbld', 17:47:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:02 INFO - '_': '/tools/buildbot/bin/python'} 17:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:47:02 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 17:47:02 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 17:47:02 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 17:47:02 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 17:47:02 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 17:47:02 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 17:47:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:47:04 INFO - Installing collected packages: mozsystemmonitor 17:47:04 INFO - Running setup.py install for mozsystemmonitor 17:47:04 INFO - Successfully installed mozsystemmonitor 17:47:04 INFO - Cleaning up... 17:47:04 INFO - Return code: 0 17:47:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:47:04 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')]} 17:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:04 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')]} 17:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:04 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 0x13e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, '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': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', '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 17:47:04 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 17:47:04 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 17:47:04 INFO - Using env: {'DISPLAY': ':0', 17:47:04 INFO - 'HOME': '/home/cltbld', 17:47:04 INFO - 'LANG': 'en_US.UTF-8', 17:47:04 INFO - 'LANGUAGE': 'en_US:en', 17:47:04 INFO - 'LOGNAME': 'cltbld', 17:47:04 INFO - 'MAIL': '/var/mail/cltbld', 17:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:04 INFO - 'MOZ_NO_REMOTE': '1', 17:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:04 INFO - 'NO_EM_RESTART': '1', 17:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:04 INFO - 'PWD': '/builds/slave/test', 17:47:04 INFO - 'SHELL': '/bin/bash', 17:47:04 INFO - 'SHLVL': '1', 17:47:04 INFO - 'TERM': 'linux', 17:47:04 INFO - 'TMOUT': '86400', 17:47:04 INFO - 'USER': 'cltbld', 17:47:04 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:04 INFO - '_': '/tools/buildbot/bin/python'} 17:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:05 INFO - Downloading/unpacking jsonschema==2.5.1 17:47:05 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 17:47:05 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 17:47:05 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 17:47:05 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 17:47:05 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 17:47:05 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 17:47:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:47:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:47:07 INFO - warning: no files found matching '*.txt' 17:47:07 INFO - no previously-included directories found matching 'build' 17:47:07 INFO - no previously-included directories found matching 'dist' 17:47:07 INFO - no previously-included directories found matching '.git*' 17:47:07 INFO - Installing collected packages: jsonschema, functools32 17:47:07 INFO - Running setup.py install for functools32 17:47:07 INFO - warning: no files found matching '*.txt' 17:47:07 INFO - no previously-included directories found matching 'build' 17:47:07 INFO - no previously-included directories found matching 'dist' 17:47:07 INFO - no previously-included directories found matching '.git*' 17:47:07 INFO - Successfully installed jsonschema functools32 17:47:07 INFO - Cleaning up... 17:47:07 INFO - Return code: 0 17:47:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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', '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 0x13e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, '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': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', '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 17:47: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:47: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 functools32==3.2.3-2 17:47:07 INFO - Using env: {'DISPLAY': ':0', 17:47:07 INFO - 'HOME': '/home/cltbld', 17:47:07 INFO - 'LANG': 'en_US.UTF-8', 17:47:07 INFO - 'LANGUAGE': 'en_US:en', 17:47:07 INFO - 'LOGNAME': 'cltbld', 17:47:07 INFO - 'MAIL': '/var/mail/cltbld', 17:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:07 INFO - 'MOZ_NO_REMOTE': '1', 17:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:07 INFO - 'NO_EM_RESTART': '1', 17:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:07 INFO - 'PWD': '/builds/slave/test', 17:47:07 INFO - 'SHELL': '/bin/bash', 17:47:07 INFO - 'SHLVL': '1', 17:47:07 INFO - 'TERM': 'linux', 17:47:07 INFO - 'TMOUT': '86400', 17:47:07 INFO - 'USER': 'cltbld', 17:47:07 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:07 INFO - '_': '/tools/buildbot/bin/python'} 17:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:47:07 INFO - Cleaning up... 17:47:07 INFO - Return code: 0 17:47:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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', '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 0x13e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, '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': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', '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 17:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:47: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 blobuploader==1.2.4 17:47:07 INFO - Using env: {'DISPLAY': ':0', 17:47:07 INFO - 'HOME': '/home/cltbld', 17:47:07 INFO - 'LANG': 'en_US.UTF-8', 17:47:07 INFO - 'LANGUAGE': 'en_US:en', 17:47:07 INFO - 'LOGNAME': 'cltbld', 17:47:07 INFO - 'MAIL': '/var/mail/cltbld', 17:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:07 INFO - 'MOZ_NO_REMOTE': '1', 17:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:07 INFO - 'NO_EM_RESTART': '1', 17:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:07 INFO - 'PWD': '/builds/slave/test', 17:47:07 INFO - 'SHELL': '/bin/bash', 17:47:07 INFO - 'SHLVL': '1', 17:47:07 INFO - 'TERM': 'linux', 17:47:07 INFO - 'TMOUT': '86400', 17:47:07 INFO - 'USER': 'cltbld', 17:47:07 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:07 INFO - '_': '/tools/buildbot/bin/python'} 17:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:08 INFO - Downloading/unpacking blobuploader==1.2.4 17:47:08 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 17:47:08 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 17:47:08 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 17:47:08 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 17:47:08 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 17:47:08 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 17:47:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:47:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:47:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:10 INFO - Downloading docopt-0.6.1.tar.gz 17:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:47:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:47:10 INFO - Running setup.py install for blobuploader 17:47:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:47:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:47:10 INFO - Running setup.py install for requests 17:47:11 INFO - Running setup.py install for docopt 17:47:11 INFO - Successfully installed blobuploader requests docopt 17:47:11 INFO - Cleaning up... 17:47:11 INFO - Return code: 0 17:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:11 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')]} 17:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:11 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')]} 17:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:11 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 0x13e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, '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': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', '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 17:47:11 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 17:47:11 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 17:47:11 INFO - Using env: {'DISPLAY': ':0', 17:47:11 INFO - 'HOME': '/home/cltbld', 17:47:11 INFO - 'LANG': 'en_US.UTF-8', 17:47:11 INFO - 'LANGUAGE': 'en_US:en', 17:47:11 INFO - 'LOGNAME': 'cltbld', 17:47:11 INFO - 'MAIL': '/var/mail/cltbld', 17:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:11 INFO - 'MOZ_NO_REMOTE': '1', 17:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:11 INFO - 'NO_EM_RESTART': '1', 17:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:11 INFO - 'PWD': '/builds/slave/test', 17:47:11 INFO - 'SHELL': '/bin/bash', 17:47:11 INFO - 'SHLVL': '1', 17:47:11 INFO - 'TERM': 'linux', 17:47:11 INFO - 'TMOUT': '86400', 17:47:11 INFO - 'USER': 'cltbld', 17:47:11 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:11 INFO - '_': '/tools/buildbot/bin/python'} 17:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:11 INFO - Running setup.py (path:/tmp/pip-h2vg4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:11 INFO - Running setup.py (path:/tmp/pip-6VQkJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:11 INFO - Running setup.py (path:/tmp/pip-VYXijH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:11 INFO - Running setup.py (path:/tmp/pip-yFaxzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:11 INFO - Running setup.py (path:/tmp/pip-Xcvx_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:12 INFO - Running setup.py (path:/tmp/pip-c5naly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:12 INFO - Running setup.py (path:/tmp/pip-DJ5Q4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:12 INFO - Running setup.py (path:/tmp/pip-s8LuZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:12 INFO - Running setup.py (path:/tmp/pip-EH8OQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:12 INFO - Running setup.py (path:/tmp/pip-IYh9OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:12 INFO - Running setup.py (path:/tmp/pip-F4WBFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:12 INFO - Running setup.py (path:/tmp/pip-MgrReW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:12 INFO - Running setup.py (path:/tmp/pip-8PlKhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:12 INFO - Running setup.py (path:/tmp/pip-UZm_nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:12 INFO - Running setup.py (path:/tmp/pip-nqIpqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:12 INFO - Running setup.py (path:/tmp/pip-3vpdk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:12 INFO - Running setup.py (path:/tmp/pip-ptTCpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:47:12 INFO - Running setup.py install for manifestparser 17:47:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:47:12 INFO - Running setup.py install for mozcrash 17:47:13 INFO - Running setup.py install for mozdebug 17:47:13 INFO - Running setup.py install for mozdevice 17:47:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:47:13 INFO - Running setup.py install for mozfile 17:47:13 INFO - Running setup.py install for mozhttpd 17:47:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:47:13 INFO - Running setup.py install for mozinfo 17:47:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:47:13 INFO - Running setup.py install for mozInstall 17:47:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:47:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:47:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:47:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:47:13 INFO - Running setup.py install for mozleak 17:47:13 INFO - Running setup.py install for mozlog 17:47:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:47:13 INFO - Running setup.py install for moznetwork 17:47:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:47:13 INFO - Running setup.py install for mozprocess 17:47:14 INFO - Running setup.py install for mozprofile 17:47:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:47:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:47:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:47:14 INFO - Running setup.py install for mozrunner 17:47:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:47:14 INFO - Running setup.py install for mozscreenshot 17:47:14 INFO - Running setup.py install for moztest 17:47:14 INFO - Running setup.py install for mozversion 17:47:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:47:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:47:14 INFO - Cleaning up... 17:47:14 INFO - Return code: 0 17:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:14 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 0x13e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, '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': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', '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 17:47:14 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 17:47:14 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 17:47:14 INFO - Using env: {'DISPLAY': ':0', 17:47:14 INFO - 'HOME': '/home/cltbld', 17:47:14 INFO - 'LANG': 'en_US.UTF-8', 17:47:14 INFO - 'LANGUAGE': 'en_US:en', 17:47:14 INFO - 'LOGNAME': 'cltbld', 17:47:14 INFO - 'MAIL': '/var/mail/cltbld', 17:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:14 INFO - 'MOZ_NO_REMOTE': '1', 17:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:14 INFO - 'NO_EM_RESTART': '1', 17:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:14 INFO - 'PWD': '/builds/slave/test', 17:47:14 INFO - 'SHELL': '/bin/bash', 17:47:14 INFO - 'SHLVL': '1', 17:47:14 INFO - 'TERM': 'linux', 17:47:14 INFO - 'TMOUT': '86400', 17:47:14 INFO - 'USER': 'cltbld', 17:47:14 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:14 INFO - '_': '/tools/buildbot/bin/python'} 17:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:14 INFO - Running setup.py (path:/tmp/pip-LghMNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:14 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)) 17:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:14 INFO - Running setup.py (path:/tmp/pip-dON6aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:15 INFO - Running setup.py (path:/tmp/pip-2KnF46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:15 INFO - Running setup.py (path:/tmp/pip-VjFuYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:15 INFO - Running setup.py (path:/tmp/pip-JdkbLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:15 INFO - Running setup.py (path:/tmp/pip-OvmFJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:15 INFO - Running setup.py (path:/tmp/pip-soiPGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:15 INFO - Running setup.py (path:/tmp/pip-rjV5EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:15 INFO - Running setup.py (path:/tmp/pip-jB0SmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:15 INFO - Running setup.py (path:/tmp/pip-3TjuxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:15 INFO - Running setup.py (path:/tmp/pip-Qdvrux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:15 INFO - Running setup.py (path:/tmp/pip-9Izip6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:15 INFO - Running setup.py (path:/tmp/pip-8YTfFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:15 INFO - Running setup.py (path:/tmp/pip-Jv1nyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:15 INFO - Running setup.py (path:/tmp/pip-KPGtNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:15 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)) 17:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:15 INFO - Running setup.py (path:/tmp/pip-jGmDzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:16 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)) 17:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:16 INFO - Running setup.py (path:/tmp/pip-kRKdv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:16 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)) 17:47:16 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)) 17:47:16 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)) 17:47:16 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)) 17:47:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:47:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:47:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:16 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 17:47:16 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 17:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:18 INFO - Downloading blessings-1.6.tar.gz 17:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:47:18 INFO - Installing collected packages: blessings 17:47:18 INFO - Running setup.py install for blessings 17:47:18 INFO - Successfully installed blessings 17:47:18 INFO - Cleaning up... 17:47:18 INFO - Return code: 0 17:47:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:47:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:18 INFO - Reading from file tmpfile_stdout 17:47:18 INFO - Current package versions: 17:47:18 INFO - argparse == 1.2.1 17:47:18 INFO - blessings == 1.6 17:47:18 INFO - blobuploader == 1.2.4 17:47:18 INFO - docopt == 0.6.1 17:47:18 INFO - functools32 == 3.2.3-2 17:47:18 INFO - jsonschema == 2.5.1 17:47:18 INFO - manifestparser == 1.1 17:47:18 INFO - mozInstall == 1.12 17:47:18 INFO - mozcrash == 1.0 17:47:18 INFO - mozdebug == 0.1 17:47:18 INFO - mozdevice == 0.49 17:47:18 INFO - mozfile == 1.2 17:47:18 INFO - mozhttpd == 0.7 17:47:18 INFO - mozinfo == 0.9 17:47:18 INFO - mozleak == 0.1 17:47:18 INFO - mozlog == 3.4 17:47:18 INFO - moznetwork == 0.27 17:47:18 INFO - mozprocess == 0.25 17:47:18 INFO - mozprofile == 0.28 17:47:18 INFO - mozrunner == 6.13 17:47:18 INFO - mozscreenshot == 0.1 17:47:18 INFO - mozsystemmonitor == 0.3 17:47:18 INFO - moztest == 0.8 17:47:18 INFO - mozversion == 1.4 17:47:18 INFO - psutil == 3.1.1 17:47:18 INFO - requests == 1.2.3 17:47:18 INFO - wsgiref == 0.1.2 17:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:18 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 0x13e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, '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': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', '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 17:47:18 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 17:47:18 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 17:47:18 INFO - Using env: {'DISPLAY': ':0', 17:47:18 INFO - 'HOME': '/home/cltbld', 17:47:18 INFO - 'LANG': 'en_US.UTF-8', 17:47:18 INFO - 'LANGUAGE': 'en_US:en', 17:47:18 INFO - 'LOGNAME': 'cltbld', 17:47:18 INFO - 'MAIL': '/var/mail/cltbld', 17:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:18 INFO - 'MOZ_NO_REMOTE': '1', 17:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:18 INFO - 'NO_EM_RESTART': '1', 17:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:18 INFO - 'PWD': '/builds/slave/test', 17:47:18 INFO - 'SHELL': '/bin/bash', 17:47:18 INFO - 'SHLVL': '1', 17:47:18 INFO - 'TERM': 'linux', 17:47:18 INFO - 'TMOUT': '86400', 17:47:18 INFO - 'USER': 'cltbld', 17:47:18 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:18 INFO - '_': '/tools/buildbot/bin/python'} 17:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:18 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)) 17:47:18 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)) 17:47:18 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)) 17:47:18 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)) 17:47:18 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)) 17:47:18 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)) 17:47:18 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)) 17:47:18 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)) 17:47:18 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)) 17:47:18 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)) 17:47:18 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)) 17:47:18 INFO - Cleaning up... 17:47:18 INFO - Return code: 0 17:47:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x13e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1687310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, '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': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', '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 17:47:18 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 17:47:18 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 17:47:18 INFO - Using env: {'DISPLAY': ':0', 17:47:18 INFO - 'HOME': '/home/cltbld', 17:47:18 INFO - 'LANG': 'en_US.UTF-8', 17:47:18 INFO - 'LANGUAGE': 'en_US:en', 17:47:18 INFO - 'LOGNAME': 'cltbld', 17:47:18 INFO - 'MAIL': '/var/mail/cltbld', 17:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:18 INFO - 'MOZ_NO_REMOTE': '1', 17:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:18 INFO - 'NO_EM_RESTART': '1', 17:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:18 INFO - 'PWD': '/builds/slave/test', 17:47:18 INFO - 'SHELL': '/bin/bash', 17:47:18 INFO - 'SHLVL': '1', 17:47:18 INFO - 'TERM': 'linux', 17:47:18 INFO - 'TMOUT': '86400', 17:47:18 INFO - 'USER': 'cltbld', 17:47:18 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:18 INFO - '_': '/tools/buildbot/bin/python'} 17:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:47:19 INFO - Cleaning up... 17:47:19 INFO - Return code: 0 17:47:19 INFO - Running post-action listener: _resource_record_post_action 17:47:19 INFO - Running post-action listener: _start_resource_monitoring 17:47:19 INFO - Starting resource monitoring. 17:47:19 INFO - [mozharness: 2017-04-01 00:47:19.097955Z] Finished create-virtualenv step (success) 17:47:19 INFO - [mozharness: 2017-04-01 00:47:19.098426Z] Running install step. 17:47:19 INFO - Running pre-action listener: _resource_record_pre_action 17:47:19 INFO - Running main action method: install 17:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:19 INFO - Reading from file tmpfile_stdout 17:47:19 INFO - Detecting whether we're running mozinstall >=1.0... 17:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:47:19 INFO - Reading from file tmpfile_stdout 17:47:19 INFO - Output received: 17:47:19 INFO - Usage: mozinstall [options] installer 17:47:19 INFO - Options: 17:47:19 INFO - -h, --help show this help message and exit 17:47:19 INFO - -d DEST, --destination=DEST 17:47:19 INFO - Directory to install application into. [default: 17:47:19 INFO - "/builds/slave/test"] 17:47:19 INFO - --app=APP Application being installed. [default: firefox] 17:47:19 INFO - mkdir: /builds/slave/test/build/application 17:47:19 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'] 17:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:47:35 INFO - Reading from file tmpfile_stdout 17:47:35 INFO - Output received: 17:47:35 INFO - /builds/slave/test/build/application/firefox/firefox 17:47:35 INFO - Running post-action listener: _resource_record_post_action 17:47:35 INFO - [mozharness: 2017-04-01 00:47:35.425267Z] Finished install step (success) 17:47:35 INFO - [mozharness: 2017-04-01 00:47:35.425559Z] Running run-tests step. 17:47:35 INFO - Running pre-action listener: _resource_record_pre_action 17:47:35 INFO - Running main action method: run_tests 17:47:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:47:35 INFO - Python 2.7.3 17:47:35 INFO - Return code: 0 17:47:35 INFO - grabbing minidump binary from tooltool 17:47:35 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')]} 17:47:35 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 0x1684400>, '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 0x16853b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1685840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:47:35 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 17:47:35 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 17:47:35 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 17:47:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:47:35 INFO - Return code: 0 17:47:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:47:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:47:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:47:35 INFO - ENV: RUST_BACKTRACE is now 1 17:47:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:47:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:47:35 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/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 17:47:35 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/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 17:47:35 INFO - Using env: {'DISPLAY': ':0', 17:47:35 INFO - 'HOME': '/home/cltbld', 17:47:35 INFO - 'LANG': 'en_US.UTF-8', 17:47:35 INFO - 'LANGUAGE': 'en_US:en', 17:47:35 INFO - 'LOGNAME': 'cltbld', 17:47:35 INFO - 'MAIL': '/var/mail/cltbld', 17:47:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:47:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:35 INFO - 'MOZ_NO_REMOTE': '1', 17:47:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:35 INFO - 'NO_EM_RESTART': '1', 17:47:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:35 INFO - 'PWD': '/builds/slave/test', 17:47:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:47:35 INFO - 'RUST_BACKTRACE': '1', 17:47:35 INFO - 'SHELL': '/bin/bash', 17:47:35 INFO - 'SHLVL': '1', 17:47:35 INFO - 'TERM': 'linux', 17:47:35 INFO - 'TMOUT': '86400', 17:47:35 INFO - 'USER': 'cltbld', 17:47:35 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491007585.593559-902888168', 17:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:35 INFO - '_': '/tools/buildbot/bin/python'} 17:47:35 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/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 17:47:35 INFO - mozversion application_buildid: 20170401001238 17:47:35 INFO - mozversion application_changeset: 7fe20a149f135533746ecaa9a1cf99619101eae0 17:47:35 INFO - mozversion application_display_name: Nightly 17:47:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:47:35 INFO - mozversion application_name: Firefox 17:47:35 INFO - mozversion application_remotingname: firefox 17:47:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:47:35 INFO - mozversion application_vendor: Mozilla 17:47:35 INFO - mozversion application_version: 55.0a1 17:47:35 INFO - mozversion platform_buildid: 20170401001238 17:47:35 INFO - mozversion platform_changeset: 7fe20a149f135533746ecaa9a1cf99619101eae0 17:47:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:47:35 INFO - mozversion platform_version: 55.0a1 17:47:35 INFO - using testdate: 1491007655 17:47:35 INFO - actual date: 1491007655 17:47:35 INFO - starting webserver on 'localhost:34662' 17:47:35 INFO - SUITE-START | Running 2 tests 17:47:35 INFO - TEST-START | dromaeo_css 17:47:35 INFO - operating with platform_type : linux_ 17:47:35 INFO - Initialising browser for dromaeo_css test... 17:47:35 INFO - TEST-INFO | started process 2911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqKDeCi/profile http://localhost:34662/getInfo.html) 17:47:39 INFO - PID 2911 | __metrics Screen width/height:1600/1200 17:47:39 INFO - PID 2911 | colorDepth:24 17:47:39 INFO - PID 2911 | Browser inner width/height: 1024/697 17:47:39 INFO - PID 2911 | __metrics 17:47:40 INFO - PID 2911 | 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" 17:47:40 INFO - PID 2911 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:47:42 INFO - TEST-INFO | 2911: exit 0 17:47:42 INFO - Browser initialized. 17:47:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:47:42 INFO - TEST-INFO | started process 3013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqKDeCi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:54 INFO - PID 3013 | RSS: Main: 167088128 17:47:54 INFO - PID 3013 | 17:51:01 INFO - PID 3013 | Cycle 1(1): loaded http://localhost:34662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34662/tests/dromaeo/cssquery-ext.html) 17:51:02 INFO - PID 3013 | RSS: Main: 288743424 17:51:02 INFO - PID 3013 | 17:52:43 INFO - PID 3013 | ************************* 17:52:43 INFO - PID 3013 | A coding exception was thrown and uncaught in a Task. 17:52:43 INFO - PID 3013 | 17:52:43 ERROR - PID 3013 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:52:43 INFO - PID 3013 | Full stack: 17:52:43 INFO - PID 3013 | ************************* 17:52:43 INFO - PID 3013 | ************************* 17:52:43 INFO - PID 3013 | A coding exception was thrown and uncaught in a Task. 17:52:43 INFO - PID 3013 | 17:52:43 ERROR - PID 3013 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:52:43 INFO - PID 3013 | Full stack: 17:52:43 INFO - PID 3013 | ************************* 17:52:43 INFO - PID 3013 | ************************* 17:52:43 INFO - PID 3013 | A coding exception was thrown and uncaught in a Task. 17:52:43 INFO - PID 3013 | 17:52:43 ERROR - PID 3013 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:52:43 INFO - PID 3013 | Full stack: 17:52:43 INFO - PID 3013 | ************************* 17:52:43 INFO - PID 3013 | ************************* 17:52:43 INFO - PID 3013 | A coding exception was thrown and uncaught in a Task. 17:52:43 INFO - PID 3013 | 17:52:43 ERROR - PID 3013 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:52:43 INFO - PID 3013 | Full stack: 17:52:43 INFO - PID 3013 | ************************* 17:54:05 INFO - PID 3013 | Cycle 1(1): loaded http://localhost:34662/tests/dromaeo/cssquery-ext.html (next: http://localhost:34662/tests/dromaeo/cssquery-jquery.html) 17:54:06 INFO - PID 3013 | RSS: Main: 254693376 17:54:06 INFO - PID 3013 | 17:57:08 INFO - PID 3013 | Cycle 1(1): loaded http://localhost:34662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34662/tests/dromaeo/cssquery-mootools.html) 17:57:09 INFO - PID 3013 | RSS: Main: 236707840 17:57:09 INFO - PID 3013 | 18:00:11 INFO - PID 3013 | Cycle 1(1): loaded http://localhost:34662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34662/tests/dromaeo/cssquery-prototype.html) 18:00:12 INFO - PID 3013 | RSS: Main: 205860864 18:00:12 INFO - PID 3013 | 18:03:15 INFO - PID 3013 | Cycle 1(1): loaded http://localhost:34662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34662/tests/dromaeo/cssquery-yui.html) 18:03:16 INFO - PID 3013 | RSS: Main: 210771968 18:03:16 INFO - PID 3013 | 18:06:19 INFO - PID 3013 | Cycle 1(1): loaded http://localhost:34662/tests/dromaeo/cssquery-yui.html (next: http://localhost:34662/tests/dromaeo/cssquery-dojo.html) 18:06:19 INFO - PID 3013 | RSS: Main: 306069504 18:06:19 INFO - PID 3013 | 18:06:19 INFO - PID 3013 | __start_tp_report 18:06:19 INFO - PID 3013 | _x_x_mozilla_page_load 18:06:19 INFO - PID 3013 | _x_x_mozilla_page_load_details 18:06:19 INFO - PID 3013 | |i|pagename|runs| 18:06:19 INFO - PID 3013 | |0;dojo.html;2731.631229783979;2776.7500924916753;2817.816841905276;2818.1968139080354;2823.0966090850925;5198;5216.530512253901;5248.790048398064;5277.604179686525;5287.973560132204;5231.24146998685;5235.685858848472;5270.183121616146;5273.709945952981;5276.7889284428675;4628.514006029361;4642.814287428499;4679.227927391977;4710.74090924999;4742.739149346785;4693.765311734417;4735.763211839411;4747.430308363001;4769.403824521934;4777.450593181794;4741.573258406743;4774.7135171889795;4777.402824646919;4789.401324834395;4796.640251981098;4730.550597693214;4795.256735206049;4801.06379256047;4804.4234691836855;4849.806007759686;4546.249868771649;4659.161350956826;4666.090112428078;4704.741239231841;4756.476787553366;5154.871128221787;5165.018646457161;5173.637845350827;5201.063808514466;5201.765920533585;5639.351474580435;5779.422057794229;5780.3063632363965;5785.942140578582;5797.4782269595935;5607.158926161068;5665.971670141623;5688.658680479184;5721.855628874284;5804.223337503216;5401.567874570025;5409;5414.539764120015;5458.808941687102;5462.481064298885;5886.735096920564;5955.52355811534;5970.044792833126;5973.880522389615;5974.253218347707;5566.2207290979295;5628.971855140698;5676.631018983753;5680.147977803363;5687.1753595729215;5712.600117991784;5758.596898217168;5775.595708300379;5795.623284486495;5814.854628634233;5682.516986056232;5683.175939488751;5684.175794509773;5687.943120568824;5689.032864412977;5568.805091821848;5572.777088916398;5607.80372686954;5608.046632072557;5621.0444224481935;4784.952150478521;4787.3776409066595;4790.904181916342;4797.880052998633;4836.202026665631;4081.20416518776;4100.528439229467;4121.9587804121575;4139.110091330378;4170.457840480779;4928.531789479994;4932.457429682804;4941.752912354368;4962.379702537183;4970.527799859007;5783.132530120515;5818.127280907813;5825.359210486843;5825.359210486843;5826.096954971986;4773.427188737304;4836.177849765549;4913.164761990399;4922.261660750916;4960.131976904027;5103.2855400244;5107.33604631403;5199.636025478256;5212.218167274863;5227.059129356676;5390.865228369322;5396.676199428047;5396.892062158813;5399.163129714901;5405.918911216414;5764.106563482667;5768.50967667753;5775.101806280828;5780.075187969905;5827.883442331215;5278.392984806643;5287.9471205287455;5343.198520221998;5344.35867695879;5359.544438722753;5511.917321240105;5566.276384070207;5568.749406276646;5578.693171875586;5654.06707893193;5805.361410244954;5810.593258471867;5813.563982701399;5856.297244330537;5875.529957603296;5581.274434323512;5595.272614560081;5598.496135347676;5599.1041433370465;5612.242347283064;5464.480874316933;5527.50252477279;5615.129654903497;5621.887562248814;5634.774609015757;5497.835064948058;5513.58648101402;5551.444855514416;5568.49883510486;5577.107662773937;5413.160960051198;5418.539424148834;5419.566434685295;5422.105352616774;5473.452654734495;5325.174597937326;5345;5346.1713434417725;5382.381026181883;5402.621816472809 18:06:19 INFO - PID 3013 | |1;ext.html;677.915260592426;730.4010711216803;745.1282000059931;1094.1848322999367;1101.5869049106584;28357;35283.64716352836;35947.82026089866;35973.100672483204;36114.638853611454;37952;38296.425553616646;38530.61469385305;38541.807290963574;38750.22499550007;5222.216667499867;7078.53989490684;7228.602426866521;7233.602151881644;7314;5447.155690867902;7089.468289878254;7233.674484648177;7242.746503872366;7243.963780181091;7323.194448610649;7388.076490438695;7388.298111679409;7391.0761154855645;7391.741289054884;7296.744613938513;7328.230535793718;7337.229590892933;7354.742584009534;7381.520201186906;7209.170945341248;7274.927250727531;7275.090613673291;7278.854422911512;7284.526505777108;33328.66671333304;33377.49933750996;33498.49752253718;33713.83143084293;33754;2481.5781317175943;2511.3972646564876;2520.1053625962704;2525.1793167220726;2526.5452218600644;22966.885165574065;23187.76812231873;23690.170844020548;23780.40548986272;24013.879930600237;2798.1465652975835;2802.8178168418985;2809.8595070246406;2826.7597254233415;2864.8854045838143;167640;170220;170262;170989;171025;44257.557424425984;44772.10455790931;44793.55206447959;44958.550414496094;44965.10069798586;47760.5223947763;47963.76018119957;47980;48003;48056.27915581269;11747.353895535656;11836.467358968866;11837.171398002058;11928.880711192776;11938.044956403466;7893.250141236574;7981.2018798119725;9339.439633622005;9380.57787399555;9394.248460123174;13146.934265328804;13152;13227.801582976263;13352.599422017354;13380.933095334462;5622.831315060473;5656.632318899258;5662.745176467069;5748.5688573357165;5762.971185144132;875.4134729731095;893.8882639670041;908.2325435007408;915.1306259053792;934.6354921580589;20254.392368228975;21445.14219431205;25135.21477049702;26247.606285905345;26340.473190536082;946.7869729310987;962.9662961796304;964.8225309786205;967.6855022117699;982.0964712464549;11277.661670149744;11392.417705337182;11505.367204803648;11505.654830355103;11526.538938442536;250857;252804;252846;253773;254319;42023;42413.15173696509;42646.78676606597;42673.586113110876;42736.57263427388;1178.452019810792;1229.2317301686446;1233.179935343005;1235.6601934468092;1264.2856785915928;19060.904695476434;19357.225710971405;19448.319308824124;20588.897055514626;20726;31042.379152417278;31089.37821243517;31241.218969525944;31326.060218193492;31326.686733132377;250231;250878;252076;252360;252639;29381.412371752016;30643.846780766846;30997;31002;31141.8442907784;35100.64899351076;35982.8200858994;36427;36880.81559592185;37108;27292.317692057062;27573.586396204475;27744;27863.44273114486;28675.426491469636;27397.31506712348;27517.724822751516;28057;28693.13920582386;28864.278393040342;30501.694983050773;30695.2326191847;31236.843815780776;31321;31420.52869206918;26767.732322676526;26879.328016799736;27026.459470810867;27027.86486067557;27876.581851272655;21196;21911.342659720234;22105.226317078825;22290.331290061324;22373.328800136023 18:06:19 INFO - PID 3013 | |2;jquery.html;382.7856400415766;424.76750961987636;428.0945799633773;439.10203633569347;443.2619688219115;14588.343524541395;18593.349232776854;18647.347342843004;18793.43619691408;18868;17132.657346853088;18187.727184092248;18726.43820685378;18838.811611883877;18943.33698320559;5528.834134975958;5714.628549144313;5715.914261286084;5718.34239062509;5720.056190728525;3476.391631464496;3556.2354093869812;5615.157726341041;5851.122331650266;5886.087656413263;5826.067829147337;5828.038373668361;5831.504322132624;5840.853978650546;5845.006348920694;5465.344158700961;5608.186812912105;5654.886902261973;5661.2923384576925;5671.06427439472;5040.672356296829;5079.771410286546;5121.743912804345;5121.820736274212;5127.9743601282125;22367.888160559254;22630.547389052128;23179.420514487105;23426.531469370686;23564.111921532927;1445.111256577208;1454.8908831837655;1459.4745891479058;1490.6422458609964;1500.3473489032306;14008;14062.226577538231;14243.145411275356;14289.214093224868;14875.702485950329;1850.4263678259783;1927.469945764912;1935.5354714868472;1954.0620502158902;1954.9413517594494;88164;88604.55697721534;88624.55687721584;88793.55603221942;92029.53985230098;9926.404415735078;11106.167037472222;11163.553457861757;11287.435628218556;11397.544098236143;14465;15082.095074295577;15489.457868974758;15619.140947247783;15655.060696358254;7038.190608080136;7143.357097861218;7185.49701520899;7195.517546446467;7196.388306993964;6213.813585592439;6223.657698826608;6309.211348581427;6482.448991835652;6487.935120648733;6898.448124150056;6904.275051119661;6995.621488693869;7119.4660400470175;7161.104861892263;2051.6101940631233;2095.130520833867;2100.3698890333144;2111.7149184860154;2148.473623962108;862.5945805471418;866.5710473315623;874.1782724239195;875.8511053120985;895.0914821456228;16941.745873811902;17061;17507.47477575675;17658.91170544139;17875.642487150446;891.7859713668803;893.1068931068932;894.1282249806387;897.5108565831638;914.2366124286162;9379.437233765995;9446.622135114518;9646.662366817127;9696.127348538665;9878.950605247072;482886;485356;485759;486112;488823;92475;94174;94195;94626;94678.52660736653;1049.8687664041995;1063.7925604507047;1065.3980501016902;1129.6780417581115;1138.4706111658118;17381.82618173853;17623.559411014827;18306.633867322846;18320.908395457936;18627.348042818438;44237.336439952785;44781.55218447774;44834.77582612066;45299.77350113228;45904.31143532917;54302.185467217234;55870.44129558815;56692.43307566871;57257.14114288206;57811.710941445024;8004.319632831274;8115.1479094694205;8454.492730436194;8468.322534197127;8470.407071504935;12771.169873958162;12932.676683082622;12973.870261297643;13021.544245951347;13096.672583185496;10713.892861071601;10748.086412655011;10876.347419154876;11069.335839849635;11284.379359135326;10559.78880422372;10765.084967777826;10766.676999690022;10826.242163048511;10904.727381815517;11450.828237576276;11454.484548195185;11818.704532386415;11851.466683999068;11879.287242765462;8076.353891688768;8088.312493437888;8221.917780822354;8365.832683346422;8369.246767790928;10815.56737730482;10863;10974.725631859268;11074;11306 18:06:19 INFO - PID 3013 | |3;mootools.html;1244.2658831289539;1299.324351337304;1322.0084936297771;1324.046686385802;1325.1717676452217;9432.952835235832;9767.365121267112;9770.609175632984;9775.511224438786;9800.215982721384;9837.409755414663;10156.542955566998;10177.84733229002;10180.541875615616;10205.234607404438;2260.1185537640295;2294.713160854893;2300.217925905192;2300.7124109486313;2307.8846057697133;1875.8405535529496;1950.1711772496633;2176.2927048709153;2181.8472706910525;2277.9202727904526;2249.7862703043184;2278.840481166319;2279.225063478417;2279.8632082075046;2281.577908087001;2095.476130967258;2152.2359562355296;2166.068590506082;2264.513129677111;2281.6919715838317;2212.9778702212934;2215.5125872308067;2219.367480268132;2222.75549689534;2229.1974889039934;9621.855672164924;9858.9507052465;9878.950605246928;9888.851667224997;9894.406335619886;5417.29355253094;5626.634268772557;5629.4652008059165;5630.577706672016;5632.74652640628;3193.4730769423018;3195.456772348683;3266.2324353776844;3268.983655081733;3291.8189499577516;994.9204063674889;998.8501724741275;1006.3760468509498;1032.0814475117152;1032.5921261101898;13960.092593981359;13969.441222351094;14072.71854562903;14076.366563504667;14083.71832563343;4643.698159619614;4760.238361862154;4845.781939812717;4853.490383509751;4939.135651261015;10920.453977301104;10943.507542160622;10947.178961577914;10949;10949.671509854717;5547.278853749068;5548.611597188158;5551.056320425538;5551.139573366135;5554.055810512142;4893.241547560134;5023.09584274834;5094.541491265803;5098.1842905135;5184.507471790174;3807.923841523154;3895.3377925752125;3901.902452438712;3938.133610605662;3995.081131339808;1029.5933106423072;1059.1791361694595;1173.2694275943086;1181.173178774861;1190.2679851891025;667.2893368562466;702.2731472925498;702.6873041496485;708.9078419805495;716.3695947566108;5586.13414920688;5727.713614319267;5764.625299355528;5796.101604251347;5898.498627616701;530.3635637235333;644.8903686373328;813.1461964936793;839.4837175137246;844.5186243840951;3525.94711079334;3563.1448452371765;3583.4803953427127;3650.9817450913106;3736.5889752127246;12791.296478693575;13145.671358216121;13150.27673477968;13290.3354832258;13316.533921312708;12855.035872309427;12894.35528223585;12898.419571119322;13044.54344097952;13052.477900884049;9350;9423.952880235693;9443.575039123256;9539.427634341822;9558.426494410358;5502.147167189092;5508.752106155152;5703.885922281448;5812.82561523155;6085.087236914498;11571.132165087483;11719.88280117222;11775.705607359885;11775.76448471043;11801.763964720829;11686.24039437434;11817.645470635895;11941.701457463632;12021.218620789621;12048.698782530508;8036.397270204641;8264.958675206826;8301;8316.62575184106;8326.70856520019;9053.909460905306;9250.259979201513;9364.250859931326;9367.297452690938;9410;7281.526700764433;7371.668274927749;7390.704371825067;7437.367823734827;7657.846843062996;7550.66022029021;7561.9243807563425;7667.3099421052375;7696.076470823537;7720.806979825549;7029.648517574203;7162.749303774552;7174.713011479483;7180.102487189101;7188.065551478275;4982.252662100714;5127.435982042047;5237.947620523746;5243.580513558983;5265.236540701653;5172.9741351293005;5239.528442440199;5252.185911183773;5322.550310325316;5474.288342515448 18:06:19 INFO - PID 3013 | |4;prototype.html;384.84413812405984;385.1276857916818;385.1526641388945;388.1480151068405;392.32324240684824;5350.705711185883;5357.91963120553;5407.215953686713;5472.972635136829;5474.096774032289;5144.125498665227;5263.552598029172;5319.441458646835;5353.625246232766;5357.892842143155;4149.128682976571;4170.124273902484;4190.329547272437;4196.664266858644;4207.368894665794;4160.251154792136;4171.520275168364;4176.7076304658685;4180.5610410906875;4184;3998.8800335989968;4125.195586860564;4148.502179738421;4149.605787450188;4153.276390298022;4121.845883152707;4125.1131006833375;4131.483564554431;4146.564610715892;4170.812313445887;3701.6298370163036;3706.425504046877;3709.998300458861;3719.497867787841;3720.274546463441;5146.716930568818;5150.562202212816;5165.535101840815;5167.018266529348;5179.766910489037;4778.641601879873;4892.6575139740235;4911.926321105187;4913.828016019458;4924.852254432372;5635.915461268084;5646.011947909099;5657.236273103161;5664.971675141598;5689.829305120853;4157.168566286755;4165.312723400635;4178.78815143608;4181.393697913785;4187.769672668002;5706.172604972297;5783.652980821164;5900.1149827526215;5916.23088998436;5970.253718285171;4341.891452713708;4345.891797591657;4352.825886964486;4355.564443555619;4356.411884395629;4430.740322435517;4440.956375251813;4443.355713421536;4447.888802779957;4451.5103338632725;4679.789409476513;4728.17256980034;4901.264810278487;4967.304577359173;4980.701157930535;5697.857553561112;5721.628094173865;5725.971370143123;5737.3688894221605;5737.5983681141915;1532.4100221414612;1539.2226925402824;1541.4277437014182;1545.3509525999107;1545.6058705030146;1033.421284080917;1088.7713580148259;1094.244970970044;1097.1990446973755;1108.6286094158547;5047.091523525727;5049.444561098277;5055.266986287042;5070.315507406527;5077.8320986173385;5921.792737254175;5932.970335148383;5954.612950158225;5969.641821490724;5981.850453738604;4898.21628539432;5030;5052.444231134572;5062.519060689228;5073.162928116893;3110.1758034120976;3139.450596145711;3143.182772479126;3145.308032232905;3147.8583463744185;5303.416624171338;5486.725663716798;5510.256115424367;5512.0905050667;5529.778808847682;6037.728302226323;6037.788677396358;6044.304904935989;6072.848178795565;6116.318012546585;5513.338399392099;5544.833654990357;5551.72241387929;5558.833235002876;5572.58205634579;5643.294588176478;5904;5925.9407405925385;5933.673647949404;5941.346451890375;5800.59395842287;5810.970945145416;5833.533317334518;5843.415658434123;5867.911981320369;5309.123994540858;5372.838814835562;5444;5516;5548.278723765885;3959.8218080185884;3961.2869683457257;3966.127451960564;3970.861019864291;3975.6223158799867;5718.857028574319;5865.501432378295;5891.3224979126235;5901.5868889177345;5916.822495325147;5616.1014237721765;5616.466435688603;5618.325800903917;5664.518515926027;5738.971305143447;5713.7428815704225;5728.369879313355;5734.648793994442;5736.541076713769;5738.081906894877;5514.228008078952;5600.60795744294;5650.152477128464;5667.518260947865;5692.743826527899;5728.513076388554;5770.884582308414;5783.334916484658;5785.322256545554;5788.450097240755;5621.213030175697;5627.7467513961155;5630.380658127685;5643.689597072201;5651.660900345993 18:06:19 INFO - PID 3013 | |5;yui.html;586.3550094895616;620.1472974659843;640.3148630964868;647.4140902483255;651.9217693876734;11736.706582335446;11771.234869733473;12066.879331206685;12092.879071209285;12114.636560903176;12989.415476303566;13051.41268642911;13063.934680326609;13125.409356578954;13187.802182967263;876.1151237250375;884.8407286688393;899.0919171636629;903.0337538833451;914.7758799094231;905.0135352465811;905.9094090590954;905.9547022648874;907.3376435202306;910.2399496420497;949.9525023748785;950.1828427552299;950.9096635819586;952.471378384996;952.5094576293214;947.7772723409993;947.9052094790535;948.3740731117464;949.5062567464948;953.3755390219418;696.6760456387804;697.3549466743242;697.4943166204512;700.2332445971653;703.2405002597183;12910.22538647684;13262.66843328915;13736.587902362946;13809;13821.239831809247;13338.733225335536;14179.78730319046;14395.496157634432;14706.779398309034;14774.261286935718;9775.266854985834;9842.603661833531;9842.852357214648;9973.90026099737;9985.900140998643;2712.715164907696;2719.170652950849;2727.386338073937;2763.5440152374836;2779.0967935421068;69597;71451;72093.91859122169;72324.27675723228;73065.26934730638;10337;10432.634857779942;10535.57857685684;10618;10852.891471085188;21881.12475500962;22106.33680989573;22238.88880555619;22373.664395034088;22399.21602743896;5538.861528461821;5545.390007099216;5554.6944918029085;5598.692071936001;5665.12190610456;3353.9496907546404;3354.9161270967934;3404.914877128042;3446.8621255150015;3447.9655203447646;3447.620761716209;3491.406460901602;3517.736169787276;3519.384107781128;3520.4543295789194;586.2437455682123;592.1561774471361;610.920580324555;618.0574623698895;620.011082323693;518.556634077858;543.627615083669;553.1702446330504;559.6893723983228;572.9255196824386;7871.921280787234;8096.271335579826;8223.712170074019;8335.791605209797;8482.745517634481;544.9673019618835;575.200471344831;578.0808514462026;578.7106446776612;578.94789468948;3784.810759462016;3790.1093243087853;3873.709471789627;3922.4116382542848;3969.2656858480696;65339;66668.6666566664;67829;68834.65582672054;69613;57840.42159578435;57842.421575784545;57983;58129.128063079086;58218;50775.49224507855;50981;50982.235266471034;51119.488805111476;51504.22743658848;7488.588127653032;7730.149683534919;7907.802304942423;7972.521648701097;9497.477638729937;24080.63879041781;25473.87263063747;26072.739272607032;27678.44643107167;27726.168214953585;44697.55302446934;45802.54197457983;46410.53589464062;47273.52726472829;47546.762266188445;12286.815697764361;12383.257004579755;12414.131010829155;12444.253344799341;12670.113092083466;13391.464341426234;13603.319834008062;13615.863841361459;13659;13807.378667959765;10590.841137382791;10776.730581735519;10781.568737250736;10792.406417647106;11097.944510277397;12599.307038112991;12685;12765.553205637758;12770.808437873253;12898.935505322414;10341.327813692085;10455.372677639367;10486.79026419452;10727.731806704895;10928.672139835817;8805.42764720291;8996.64013439455;9289.581968811555;9343.859842102238;9390.389624674373;9094.849274394663;9210.309226807882;9224.907750922404;9227.44635321883;9413.623455061721 18:06:19 INFO - PID 3013 | __end_tp_report 18:06:19 INFO - PID 3013 | __start_cc_report 18:06:19 INFO - PID 3013 | _x_x_mozilla_cycle_collect,1374 18:06:19 INFO - PID 3013 | __end_cc_report 18:06:19 INFO - PID 3013 | __startTimestamp1491008779621__endTimestamp 18:06:19 INFO - PID 3013 | 18:06:19 INFO - PID 3013 | ------- Summary: start ------- 18:06:19 INFO - PID 3013 | Number of tests: 6 18:06:19 INFO - PID 3013 | 18:06:19 INFO - PID 3013 | [#0] dojo.html Cycles:165 Average:5237.13 Median:5399.16 stddev:612.14 (11.3%) stddev-sans-first:581.61 18:06:19 INFO - PID 3013 | Values: 2731.6 2776.8 2817.8 2818.2 2823.1 5198.0 5216.5 5248.8 5277.6 5288.0 5231.2 5235.7 5270.2 5273.7 5276.8 4628.5 4642.8 4679.2 4710.7 4742.7 4693.8 4735.8 4747.4 4769.4 4777.5 4741.6 4774.7 4777.4 4789.4 4796.6 4730.6 4795.3 4801.1 4804.4 4849.8 4546.2 4659.2 4666.1 4704.7 4756.5 5154.9 5165.0 5173.6 5201.1 5201.8 5639.4 5779.4 5780.3 5785.9 5797.5 5607.2 5666.0 5688.7 5721.9 5804.2 5401.6 5409.0 5414.5 5458.8 5462.5 5886.7 5955.5 5970.0 5973.9 5974.3 5566.2 5629.0 5676.6 5680.1 5687.2 5712.6 5758.6 5775.6 5795.6 5814.9 5682.5 5683.2 5684.2 5687.9 5689.0 5568.8 5572.8 5607.8 5608.0 5621.0 4785.0 4787.4 4790.9 4797.9 4836.2 4081.2 4100.5 4122.0 4139.1 4170.5 4928.5 4932.5 4941.8 4962.4 4970.5 5783.1 5818.1 5825.4 5825.4 5826.1 4773.4 4836.2 4913.2 4922.3 4960.1 5103.3 5107.3 5199.6 5212.2 5227.1 5390.9 5396.7 5396.9 5399.2 5405.9 5764.1 5768.5 5775.1 5780.1 5827.9 5278.4 5287.9 5343.2 5344.4 5359.5 5511.9 5566.3 5568.7 5578.7 5654.1 5805.4 5810.6 5813.6 5856.3 5875.5 5581.3 5595.3 5598.5 5599.1 5612.2 5464.5 5527.5 5615.1 5621.9 5634.8 5497.8 5513.6 5551.4 5568.5 5577.1 5413.2 5418.5 5419.6 5422.1 5473.5 5325.2 5345.0 5346.2 5382.4 5402.6 18:06:19 INFO - PID 3013 | 18:06:19 INFO - PID 3013 | [#1] ext.html Cycles:180 Average:36486.27 Median:31115.61 stddev:59679.69 (191.8%) stddev-sans-first:59786.55 18:06:19 INFO - PID 3013 | Values: 677.9 730.4 745.1 1094.2 1101.6 28357.0 35283.6 35947.8 35973.1 36114.6 37952.0 38296.4 38530.6 38541.8 38750.2 5222.2 7078.5 7228.6 7233.6 7314.0 5447.2 7089.5 7233.7 7242.7 7244.0 7323.2 7388.1 7388.3 7391.1 7391.7 7296.7 7328.2 7337.2 7354.7 7381.5 7209.2 7274.9 7275.1 7278.9 7284.5 33328.7 33377.5 33498.5 33713.8 33754.0 2481.6 2511.4 2520.1 2525.2 2526.5 22966.9 23187.8 23690.2 23780.4 24013.9 2798.1 2802.8 2809.9 2826.8 2864.9 167640.0 170220.0 170262.0 170989.0 171025.0 44257.6 44772.1 44793.6 44958.6 44965.1 47760.5 47963.8 47980.0 48003.0 48056.3 11747.4 11836.5 11837.2 11928.9 11938.0 7893.3 7981.2 9339.4 9380.6 9394.2 13146.9 13152.0 13227.8 13352.6 13380.9 5622.8 5656.6 5662.7 5748.6 5763.0 875.4 893.9 908.2 915.1 934.6 20254.4 21445.1 25135.2 26247.6 26340.5 946.8 963.0 964.8 967.7 982.1 11277.7 11392.4 11505.4 11505.7 11526.5 250857.0 252804.0 252846.0 253773.0 254319.0 42023.0 42413.2 42646.8 42673.6 42736.6 1178.5 1229.2 1233.2 1235.7 1264.3 19060.9 19357.2 19448.3 20588.9 20726.0 31042.4 31089.4 31241.2 31326.1 31326.7 250231.0 250878.0 252076.0 252360.0 252639.0 29381.4 30643.8 30997.0 31002.0 31141.8 35100.6 35982.8 36427.0 36880.8 37108.0 27292.3 27573.6 27744.0 27863.4 28675.4 27397.3 27517.7 28057.0 28693.1 28864.3 30501.7 30695.2 31236.8 31321.0 31420.5 26767.7 26879.3 27026.5 27027.9 27876.6 21196.0 21911.3 22105.2 22290.3 22373.3 18:06:19 INFO - PID 3013 | 18:06:19 INFO - PID 3013 | [#2] jquery.html Cycles:180 Average:29045.60 Median:22340.30 stddev:80364.01 (359.7%) stddev-sans-first:80560.63 18:06:19 INFO - PID 3013 | Values: 382.8 424.8 428.1 439.1 443.3 14588.3 18593.3 18647.3 18793.4 18868.0 17132.7 18187.7 18726.4 18838.8 18943.3 5528.8 5714.6 5715.9 5718.3 5720.1 3476.4 3556.2 5615.2 5851.1 5886.1 5826.1 5828.0 5831.5 5840.9 5845.0 5465.3 5608.2 5654.9 5661.3 5671.1 5040.7 5079.8 5121.7 5121.8 5128.0 22367.9 22630.5 23179.4 23426.5 23564.1 1445.1 1454.9 1459.5 1490.6 1500.3 14008.0 14062.2 14243.1 14289.2 14875.7 1850.4 1927.5 1935.5 1954.1 1954.9 88164.0 88604.6 88624.6 88793.6 92029.5 9926.4 11106.2 11163.6 11287.4 11397.5 14465.0 15082.1 15489.5 15619.1 15655.1 7038.2 7143.4 7185.5 7195.5 7196.4 6213.8 6223.7 6309.2 6482.4 6487.9 6898.4 6904.3 6995.6 7119.5 7161.1 2051.6 2095.1 2100.4 2111.7 2148.5 862.6 866.6 874.2 875.9 895.1 16941.7 17061.0 17507.5 17658.9 17875.6 891.8 893.1 894.1 897.5 914.2 9379.4 9446.6 9646.7 9696.1 9879.0 482886.0 485356.0 485759.0 486112.0 488823.0 92475.0 94174.0 94195.0 94626.0 94678.5 1049.9 1063.8 1065.4 1129.7 1138.5 17381.8 17623.6 18306.6 18320.9 18627.3 44237.3 44781.6 44834.8 45299.8 45904.3 54302.2 55870.4 56692.4 57257.1 57811.7 8004.3 8115.1 8454.5 8468.3 8470.4 12771.2 12932.7 12973.9 13021.5 13096.7 10713.9 10748.1 10876.3 11069.3 11284.4 10559.8 10765.1 10766.7 10826.2 10904.7 11450.8 11454.5 11818.7 11851.5 11879.3 8076.4 8088.3 8221.9 8365.8 8369.2 10815.6 10863.0 10974.7 11074.0 11306.0 18:06:19 INFO - PID 3013 | 18:06:19 INFO - PID 3013 | [#3] mootools.html Cycles:180 Average:6200.43 Median:4873.37 stddev:3933.33 (80.7%) stddev-sans-first:3926.74 18:06:19 INFO - PID 3013 | Values: 1244.3 1299.3 1322.0 1324.0 1325.2 9433.0 9767.4 9770.6 9775.5 9800.2 9837.4 10156.5 10177.8 10180.5 10205.2 2260.1 2294.7 2300.2 2300.7 2307.9 1875.8 1950.2 2176.3 2181.8 2277.9 2249.8 2278.8 2279.2 2279.9 2281.6 2095.5 2152.2 2166.1 2264.5 2281.7 2213.0 2215.5 2219.4 2222.8 2229.2 9621.9 9859.0 9879.0 9888.9 9894.4 5417.3 5626.6 5629.5 5630.6 5632.7 3193.5 3195.5 3266.2 3269.0 3291.8 994.9 998.9 1006.4 1032.1 1032.6 13960.1 13969.4 14072.7 14076.4 14083.7 4643.7 4760.2 4845.8 4853.5 4939.1 10920.5 10943.5 10947.2 10949.0 10949.7 5547.3 5548.6 5551.1 5551.1 5554.1 4893.2 5023.1 5094.5 5098.2 5184.5 3807.9 3895.3 3901.9 3938.1 3995.1 1029.6 1059.2 1173.3 1181.2 1190.3 667.3 702.3 702.7 708.9 716.4 5586.1 5727.7 5764.6 5796.1 5898.5 530.4 644.9 813.1 839.5 844.5 3525.9 3563.1 3583.5 3651.0 3736.6 12791.3 13145.7 13150.3 13290.3 13316.5 12855.0 12894.4 12898.4 13044.5 13052.5 9350.0 9424.0 9443.6 9539.4 9558.4 5502.1 5508.8 5703.9 5812.8 6085.1 11571.1 11719.9 11775.7 11775.8 11801.8 11686.2 11817.6 11941.7 12021.2 12048.7 8036.4 8265.0 8301.0 8316.6 8326.7 9053.9 9250.3 9364.3 9367.3 9410.0 7281.5 7371.7 7390.7 7437.4 7657.8 7550.7 7561.9 7667.3 7696.1 7720.8 7029.6 7162.7 7174.7 7180.1 7188.1 4982.3 5127.4 5237.9 5243.6 5265.2 5173.0 5239.5 5252.2 5322.6 5474.3 18:06:19 INFO - PID 3013 | 18:06:19 INFO - PID 3013 | [#4] prototype.html Cycles:180 Average:4743.54 Median:5221.66 stddev:1358.49 (26.0%) stddev-sans-first:1322.32 18:06:19 INFO - PID 3013 | Values: 384.8 385.1 385.2 388.1 392.3 5350.7 5357.9 5407.2 5473.0 5474.1 5144.1 5263.6 5319.4 5353.6 5357.9 4149.1 4170.1 4190.3 4196.7 4207.4 4160.3 4171.5 4176.7 4180.6 4184.0 3998.9 4125.2 4148.5 4149.6 4153.3 4121.8 4125.1 4131.5 4146.6 4170.8 3701.6 3706.4 3710.0 3719.5 3720.3 5146.7 5150.6 5165.5 5167.0 5179.8 4778.6 4892.7 4911.9 4913.8 4924.9 5635.9 5646.0 5657.2 5665.0 5689.8 4157.2 4165.3 4178.8 4181.4 4187.8 5706.2 5783.7 5900.1 5916.2 5970.3 4341.9 4345.9 4352.8 4355.6 4356.4 4430.7 4441.0 4443.4 4447.9 4451.5 4679.8 4728.2 4901.3 4967.3 4980.7 5697.9 5721.6 5726.0 5737.4 5737.6 1532.4 1539.2 1541.4 1545.4 1545.6 1033.4 1088.8 1094.2 1097.2 1108.6 5047.1 5049.4 5055.3 5070.3 5077.8 5921.8 5933.0 5954.6 5969.6 5981.9 4898.2 5030.0 5052.4 5062.5 5073.2 3110.2 3139.5 3143.2 3145.3 3147.9 5303.4 5486.7 5510.3 5512.1 5529.8 6037.7 6037.8 6044.3 6072.8 6116.3 5513.3 5544.8 5551.7 5558.8 5572.6 5643.3 5904.0 5925.9 5933.7 5941.3 5800.6 5811.0 5833.5 5843.4 5867.9 5309.1 5372.8 5444.0 5516.0 5548.3 3959.8 3961.3 3966.1 3970.9 3975.6 5718.9 5865.5 5891.3 5901.6 5916.8 5616.1 5616.5 5618.3 5664.5 5739.0 5713.7 5728.4 5734.6 5736.5 5738.1 5514.2 5600.6 5650.2 5667.5 5692.7 5728.5 5770.9 5783.3 5785.3 5788.5 5621.2 5627.7 5630.4 5643.7 5651.7 18:06:19 INFO - PID 3013 | 18:06:19 INFO - PID 3013 | [#5] yui.html Cycles:180 Average:14922.79 Median:531.09 stddev:19082.99 (3593.2%) stddev-sans-first:19106.16 18:06:19 INFO - PID 3013 | Values: 586.4 620.1 640.3 647.4 651.9 11736.7 11771.2 12066.9 12092.9 12114.6 12989.4 13051.4 13063.9 13125.4 13187.8 876.1 884.8 899.1 903.0 914.8 905.0 905.9 906.0 907.3 910.2 950.0 950.2 950.9 952.5 952.5 947.8 947.9 948.4 949.5 953.4 696.7 697.4 697.5 700.2 703.2 12910.2 13262.7 13736.6 13809.0 13821.2 13338.7 14179.8 14395.5 14706.8 14774.3 9775.3 9842.6 9842.9 9973.9 9985.9 2712.7 2719.2 2727.4 2763.5 2779.1 69597.0 71451.0 72093.9 72324.3 73065.3 10337.0 10432.6 10535.6 10618.0 10852.9 21881.1 22106.3 22238.9 22373.7 22399.2 5538.9 5545.4 5554.7 5598.7 5665.1 3353.9 3354.9 3404.9 3446.9 3448.0 3447.6 3491.4 3517.7 3519.4 3520.5 586.2 592.2 610.9 618.1 620.0 518.6 543.6 553.2 559.7 572.9 7871.9 8096.3 8223.7 8335.8 8482.7 545.0 575.2 578.1 578.7 578.9 3784.8 3790.1 3873.7 3922.4 3969.3 65339.0 66668.7 67829.0 68834.7 69613.0 57840.4 57842.4 57983.0 58129.1 58218.0 50775.5 50981.0 50982.2 51119.5 51504.2 7488.6 7730.1 7907.8 7972.5 9497.5 24080.6 25473.9 26072.7 27678.4 27726.2 44697.6 45802.5 46410.5 47273.5 47546.8 12286.8 12383.3 12414.1 12444.3 12670.1 13391.5 13603.3 13615.9 13659.0 13807.4 10590.8 10776.7 10781.6 10792.4 11097.9 12599.3 12685.0 12765.6 12770.8 12898.9 10341.3 10455.4 10486.8 10727.7 10928.7 8805.4 8996.6 9289.6 9343.9 9390.4 9094.8 9210.3 9224.9 9227.4 9413.6 18:06:19 INFO - PID 3013 | -------- Summary: end -------- 18:06:19 INFO - PID 3013 | 18:06:20 INFO - TEST-INFO | 3013: exit 0 18:06:20 INFO - TEST-OK | dromaeo_css | took 1124766ms 18:06:20 INFO - TEST-START | kraken 18:06:20 INFO - operating with platform_type : linux_ 18:06:20 INFO - Initialising browser for kraken test... 18:06:20 INFO - TEST-INFO | started process 3344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDdnPV4/profile http://localhost:34662/getInfo.html) 18:06:24 INFO - PID 3344 | __metrics Screen width/height:1600/1200 18:06:24 INFO - PID 3344 | colorDepth:24 18:06:24 INFO - PID 3344 | Browser inner width/height: 1024/697 18:06:24 INFO - PID 3344 | __metrics 18:06:25 INFO - PID 3344 | 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" 18:06:25 INFO - PID 3344 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:06:26 INFO - TEST-INFO | 3344: exit 0 18:06:26 INFO - Browser initialized. 18:06:26 INFO - Running cycle 1/1 for kraken test... 18:06:26 INFO - TEST-INFO | started process 3446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDdnPV4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:39 INFO - PID 3446 | RSS: Main: 166801408 18:06:39 INFO - PID 3446 | 18:06:41 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34662/tests/kraken/driver.html?testName=audio-beat-detection) 18:06:42 INFO - PID 3446 | RSS: Main: 226316288 18:06:42 INFO - PID 3446 | 18:06:45 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34662/tests/kraken/driver.html?testName=audio-dft) 18:06:46 INFO - PID 3446 | RSS: Main: 205373440 18:06:46 INFO - PID 3446 | 18:06:49 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34662/tests/kraken/driver.html?testName=audio-fft) 18:06:49 INFO - PID 3446 | RSS: Main: 290770944 18:06:49 INFO - PID 3446 | 18:06:52 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34662/tests/kraken/driver.html?testName=audio-oscillator) 18:06:52 INFO - PID 3446 | RSS: Main: 200036352 18:06:52 INFO - PID 3446 | 18:06:55 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:06:55 INFO - PID 3446 | RSS: Main: 205021184 18:06:55 INFO - PID 3446 | 18:06:58 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34662/tests/kraken/driver.html?testName=imaging-darkroom) 18:06:59 INFO - PID 3446 | RSS: Main: 242352128 18:06:59 INFO - PID 3446 | 18:07:03 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34662/tests/kraken/driver.html?testName=imaging-desaturate) 18:07:03 INFO - PID 3446 | RSS: Main: 238321664 18:07:03 INFO - PID 3446 | 18:07:06 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34662/tests/kraken/driver.html?testName=json-parse-financial) 18:07:07 INFO - PID 3446 | RSS: Main: 239456256 18:07:07 INFO - PID 3446 | 18:07:09 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:07:09 INFO - PID 3446 | RSS: Main: 203575296 18:07:09 INFO - PID 3446 | 18:07:11 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34662/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:07:12 INFO - PID 3446 | RSS: Main: 211124224 18:07:12 INFO - PID 3446 | 18:07:14 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:07:15 INFO - PID 3446 | RSS: Main: 220463104 18:07:15 INFO - PID 3446 | 18:07:18 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:07:18 INFO - PID 3446 | RSS: Main: 226852864 18:07:18 INFO - PID 3446 | 18:07:22 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:07:22 INFO - PID 3446 | RSS: Main: 226340864 18:07:22 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | Cycle 1(1): loaded http://localhost:34662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34662/tests/kraken/driver.html?testName=ai-astar) 18:07:24 INFO - PID 3446 | RSS: Main: 293421056 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | __start_tp_report 18:07:24 INFO - PID 3446 | _x_x_mozilla_page_load 18:07:24 INFO - PID 3446 | _x_x_mozilla_page_load_details 18:07:24 INFO - PID 3446 | |i|pagename|runs| 18:07:24 INFO - PID 3446 | |0;ai-astar;102;111;110;111;111;114;111;111;110;112 18:07:24 INFO - PID 3446 | |1;audio-beat-detection;149;126;123;171;129;126;123;125;148;123 18:07:24 INFO - PID 3446 | |2;audio-dft;163;163;164;166;165;164;165;163;165;163 18:07:24 INFO - PID 3446 | |3;audio-fft;77;75;76;109;76;75;78;76;94;77 18:07:24 INFO - PID 3446 | |4;audio-oscillator;87;83;103;84;84;84;99;84;84;110 18:07:24 INFO - PID 3446 | |5;imaging-gaussian-blur;114;114;114;114;115;114;115;115;114;114 18:07:24 INFO - PID 3446 | |6;imaging-darkroom;149;151;151;149;149;149;158;163;151;150 18:07:24 INFO - PID 3446 | |7;imaging-desaturate;95;94;94;94;94;94;94;94;94;94 18:07:24 INFO - PID 3446 | |8;json-parse-financial;51;54;53;53;54;53;53;56;54;53 18:07:24 INFO - PID 3446 | |9;json-stringify-tinderbox;55;56;55;55;62;55;56;55;55;56 18:07:24 INFO - PID 3446 | |10;stanford-crypto-aes;80;85;83;84;82;84;83;83;82;83 18:07:24 INFO - PID 3446 | |11;stanford-crypto-ccm;148;141;135;135;146;134;140;140;183;151 18:07:24 INFO - PID 3446 | |12;stanford-crypto-pbkdf2;199;195;202;190;206;192;194;191;189;195 18:07:24 INFO - PID 3446 | |13;stanford-crypto-sha256-iterative;69;72;70;70;70;71;74;74;74;72 18:07:24 INFO - PID 3446 | __end_tp_report 18:07:24 INFO - PID 3446 | __start_cc_report 18:07:24 INFO - PID 3446 | _x_x_mozilla_cycle_collect,2013 18:07:24 INFO - PID 3446 | __end_cc_report 18:07:24 INFO - PID 3446 | __startTimestamp1491008844891__endTimestamp 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | ------- Summary: start ------- 18:07:24 INFO - PID 3446 | Number of tests: 14 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.13 (2.8%) stddev-sans-first:1.20 18:07:24 INFO - PID 3446 | Values: 102.0 111.0 110.0 111.0 111.0 114.0 111.0 111.0 110.0 112.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:127.50 stddev:16.28 (12.8%) stddev-sans-first:16.38 18:07:24 INFO - PID 3446 | Values: 149.0 126.0 123.0 171.0 129.0 126.0 123.0 125.0 148.0 123.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 18:07:24 INFO - PID 3446 | Values: 163.0 163.0 164.0 166.0 165.0 164.0 165.0 163.0 165.0 163.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.50 stddev:11.26 (14.7%) stddev-sans-first:11.83 18:07:24 INFO - PID 3446 | Values: 77.0 75.0 76.0 109.0 76.0 75.0 78.0 76.0 94.0 77.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:84.00 stddev:9.93 (11.8%) stddev-sans-first:10.47 18:07:24 INFO - PID 3446 | Values: 87.0 83.0 103.0 84.0 84.0 84.0 99.0 84.0 84.0 110.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:07:24 INFO - PID 3446 | Values: 114.0 114.0 114.0 114.0 115.0 114.0 115.0 115.0 114.0 114.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:151.00 stddev:4.71 (3.1%) stddev-sans-first:4.87 18:07:24 INFO - PID 3446 | Values: 149.0 151.0 151.0 149.0 149.0 149.0 158.0 163.0 151.0 150.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 18:07:24 INFO - PID 3446 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:1.26 (2.4%) stddev-sans-first:1.00 18:07:24 INFO - PID 3446 | Values: 51.0 54.0 53.0 53.0 54.0 53.0 53.0 56.0 54.0 53.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:55.50 stddev:2.16 (3.9%) stddev-sans-first:2.26 18:07:24 INFO - PID 3446 | Values: 55.0 56.0 55.0 55.0 62.0 55.0 56.0 55.0 55.0 56.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.37 (1.7%) stddev-sans-first:0.97 18:07:24 INFO - PID 3446 | Values: 80.0 85.0 83.0 84.0 82.0 84.0 83.0 83.0 82.0 83.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:143.50 stddev:14.44 (10.1%) stddev-sans-first:15.28 18:07:24 INFO - PID 3446 | Values: 148.0 141.0 135.0 135.0 146.0 134.0 140.0 140.0 183.0 151.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.30 Median:195.00 stddev:5.50 (2.8%) stddev-sans-first:5.67 18:07:24 INFO - PID 3446 | Values: 199.0 195.0 202.0 190.0 206.0 192.0 194.0 191.0 189.0 195.0 18:07:24 INFO - PID 3446 | 18:07:24 INFO - PID 3446 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.90 (2.6%) stddev-sans-first:1.76 18:07:24 INFO - PID 3446 | Values: 69.0 72.0 70.0 70.0 70.0 71.0 74.0 74.0 74.0 72.0 18:07:24 INFO - PID 3446 | -------- Summary: end -------- 18:07:24 INFO - PID 3446 | 18:07:26 INFO - TEST-INFO | 3446: exit 0 18:07:26 INFO - TEST-OK | kraken | took 65603ms 18:07:26 INFO - SUITE-END | took 1190s 18:07:26 INFO - Completed test suite (00:19:50) 18:07:26 INFO - javascript benchmark 18:07:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6704.1544312415335, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2731.631229783979, 2776.7500924916753, 2817.816841905276, 2818.1968139080354, 2823.0966090850925, 5198.0, 5216.530512253901, 5248.790048398064, 5277.604179686525, 5287.973560132204, 5231.24146998685, 5235.685858848472, 5270.183121616146, 5273.709945952981, 5276.7889284428675, 4628.514006029361, 4642.814287428499, 4679.227927391977, 4710.74090924999, 4742.739149346785, 4693.765311734417, 4735.763211839411, 4747.430308363001, 4769.403824521934, 4777.450593181794, 4741.573258406743, 4774.7135171889795, 4777.402824646919, 4789.401324834395, 4796.640251981098, 4730.550597693214, 4795.256735206049, 4801.06379256047, 4804.4234691836855, 4849.806007759686, 4546.249868771649, 4659.161350956826, 4666.090112428078, 4704.741239231841, 4756.476787553366, 5154.871128221787, 5165.018646457161, 5173.637845350827, 5201.063808514466, 5201.765920533585, 5639.351474580435, 5779.422057794229, 5780.3063632363965, 5785.942140578582, 5797.4782269595935, 5607.158926161068, 5665.971670141623, 5688.658680479184, 5721.855628874284, 5804.223337503216, 5401.567874570025, 5409.0, 5414.539764120015, 5458.808941687102, 5462.481064298885, 5886.735096920564, 5955.52355811534, 5970.044792833126, 5973.880522389615, 5974.253218347707, 5566.2207290979295, 5628.971855140698, 5676.631018983753, 5680.147977803363, 5687.1753595729215, 5712.600117991784, 5758.596898217168, 5775.595708300379, 5795.623284486495, 5814.854628634233, 5682.516986056232, 5683.175939488751, 5684.175794509773, 5687.943120568824, 5689.032864412977, 5568.805091821848, 5572.777088916398, 5607.80372686954, 5608.046632072557, 5621.0444224481935, 4784.952150478521, 4787.3776409066595, 4790.904181916342, 4797.880052998633, 4836.202026665631, 4081.20416518776, 4100.528439229467, 4121.9587804121575, 4139.110091330378, 4170.457840480779, 4928.531789479994, 4932.457429682804, 4941.752912354368, 4962.379702537183, 4970.527799859007, 5783.132530120515, 5818.127280907813, 5825.359210486843, 5825.359210486843, 5826.096954971986, 4773.427188737304, 4836.177849765549, 4913.164761990399, 4922.261660750916, 4960.131976904027, 5103.2855400244, 5107.33604631403, 5199.636025478256, 5212.218167274863, 5227.059129356676, 5390.865228369322, 5396.676199428047, 5396.892062158813, 5399.163129714901, 5405.918911216414, 5764.106563482667, 5768.50967667753, 5775.101806280828, 5780.075187969905, 5827.883442331215, 5278.392984806643, 5287.9471205287455, 5343.198520221998, 5344.35867695879, 5359.544438722753, 5511.917321240105, 5566.276384070207, 5568.749406276646, 5578.693171875586, 5654.06707893193, 5805.361410244954, 5810.593258471867, 5813.563982701399, 5856.297244330537, 5875.529957603296, 5581.274434323512, 5595.272614560081, 5598.496135347676, 5599.1041433370465, 5612.242347283064, 5464.480874316933, 5527.50252477279, 5615.129654903497, 5621.887562248814, 5634.774609015757, 5497.835064948058, 5513.58648101402, 5551.444855514416, 5568.49883510486, 5577.107662773937, 5413.160960051198, 5418.539424148834, 5419.566434685295, 5422.105352616774, 5473.452654734495, 5325.174597937326, 5345.0, 5346.1713434417725, 5382.381026181883, 5402.621816472809], "value": 5193.136060865218, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.915260592426, 730.4010711216803, 745.1282000059931, 1094.1848322999367, 1101.5869049106584, 28357.0, 35283.64716352836, 35947.82026089866, 35973.100672483204, 36114.638853611454, 37952.0, 38296.425553616646, 38530.61469385305, 38541.807290963574, 38750.22499550007, 5222.216667499867, 7078.53989490684, 7228.602426866521, 7233.602151881644, 7314.0, 5447.155690867902, 7089.468289878254, 7233.674484648177, 7242.746503872366, 7243.963780181091, 7323.194448610649, 7388.076490438695, 7388.298111679409, 7391.0761154855645, 7391.741289054884, 7296.744613938513, 7328.230535793718, 7337.229590892933, 7354.742584009534, 7381.520201186906, 7209.170945341248, 7274.927250727531, 7275.090613673291, 7278.854422911512, 7284.526505777108, 33328.66671333304, 33377.49933750996, 33498.49752253718, 33713.83143084293, 33754.0, 2481.5781317175943, 2511.3972646564876, 2520.1053625962704, 2525.1793167220726, 2526.5452218600644, 22966.885165574065, 23187.76812231873, 23690.170844020548, 23780.40548986272, 24013.879930600237, 2798.1465652975835, 2802.8178168418985, 2809.8595070246406, 2826.7597254233415, 2864.8854045838143, 167640.0, 170220.0, 170262.0, 170989.0, 171025.0, 44257.557424425984, 44772.10455790931, 44793.55206447959, 44958.550414496094, 44965.10069798586, 47760.5223947763, 47963.76018119957, 47980.0, 48003.0, 48056.27915581269, 11747.353895535656, 11836.467358968866, 11837.171398002058, 11928.880711192776, 11938.044956403466, 7893.250141236574, 7981.2018798119725, 9339.439633622005, 9380.57787399555, 9394.248460123174, 13146.934265328804, 13152.0, 13227.801582976263, 13352.599422017354, 13380.933095334462, 5622.831315060473, 5656.632318899258, 5662.745176467069, 5748.5688573357165, 5762.971185144132, 875.4134729731095, 893.8882639670041, 908.2325435007408, 915.1306259053792, 934.6354921580589, 20254.392368228975, 21445.14219431205, 25135.21477049702, 26247.606285905345, 26340.473190536082, 946.7869729310987, 962.9662961796304, 964.8225309786205, 967.6855022117699, 982.0964712464549, 11277.661670149744, 11392.417705337182, 11505.367204803648, 11505.654830355103, 11526.538938442536, 250857.0, 252804.0, 252846.0, 253773.0, 254319.0, 42023.0, 42413.15173696509, 42646.78676606597, 42673.586113110876, 42736.57263427388, 1178.452019810792, 1229.2317301686446, 1233.179935343005, 1235.6601934468092, 1264.2856785915928, 19060.904695476434, 19357.225710971405, 19448.319308824124, 20588.897055514626, 20726.0, 31042.379152417278, 31089.37821243517, 31241.218969525944, 31326.060218193492, 31326.686733132377, 250231.0, 250878.0, 252076.0, 252360.0, 252639.0, 29381.412371752016, 30643.846780766846, 30997.0, 31002.0, 31141.8442907784, 35100.64899351076, 35982.8200858994, 36427.0, 36880.81559592185, 37108.0, 27292.317692057062, 27573.586396204475, 27744.0, 27863.44273114486, 28675.426491469636, 27397.31506712348, 27517.724822751516, 28057.0, 28693.13920582386, 28864.278393040342, 30501.694983050773, 30695.2326191847, 31236.843815780776, 31321.0, 31420.52869206918, 26767.732322676526, 26879.328016799736, 27026.459470810867, 27027.86486067557, 27876.581851272655, 21196.0, 21911.342659720234, 22105.226317078825, 22290.331290061324, 22373.328800136023], "value": 15085.823631229996, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.7856400415766, 424.76750961987636, 428.0945799633773, 439.10203633569347, 443.2619688219115, 14588.343524541395, 18593.349232776854, 18647.347342843004, 18793.43619691408, 18868.0, 17132.657346853088, 18187.727184092248, 18726.43820685378, 18838.811611883877, 18943.33698320559, 5528.834134975958, 5714.628549144313, 5715.914261286084, 5718.34239062509, 5720.056190728525, 3476.391631464496, 3556.2354093869812, 5615.157726341041, 5851.122331650266, 5886.087656413263, 5826.067829147337, 5828.038373668361, 5831.504322132624, 5840.853978650546, 5845.006348920694, 5465.344158700961, 5608.186812912105, 5654.886902261973, 5661.2923384576925, 5671.06427439472, 5040.672356296829, 5079.771410286546, 5121.743912804345, 5121.820736274212, 5127.9743601282125, 22367.888160559254, 22630.547389052128, 23179.420514487105, 23426.531469370686, 23564.111921532927, 1445.111256577208, 1454.8908831837655, 1459.4745891479058, 1490.6422458609964, 1500.3473489032306, 14008.0, 14062.226577538231, 14243.145411275356, 14289.214093224868, 14875.702485950329, 1850.4263678259783, 1927.469945764912, 1935.5354714868472, 1954.0620502158902, 1954.9413517594494, 88164.0, 88604.55697721534, 88624.55687721584, 88793.55603221942, 92029.53985230098, 9926.404415735078, 11106.167037472222, 11163.553457861757, 11287.435628218556, 11397.544098236143, 14465.0, 15082.095074295577, 15489.457868974758, 15619.140947247783, 15655.060696358254, 7038.190608080136, 7143.357097861218, 7185.49701520899, 7195.517546446467, 7196.388306993964, 6213.813585592439, 6223.657698826608, 6309.211348581427, 6482.448991835652, 6487.935120648733, 6898.448124150056, 6904.275051119661, 6995.621488693869, 7119.4660400470175, 7161.104861892263, 2051.6101940631233, 2095.130520833867, 2100.3698890333144, 2111.7149184860154, 2148.473623962108, 862.5945805471418, 866.5710473315623, 874.1782724239195, 875.8511053120985, 895.0914821456228, 16941.745873811902, 17061.0, 17507.47477575675, 17658.91170544139, 17875.642487150446, 891.7859713668803, 893.1068931068932, 894.1282249806387, 897.5108565831638, 914.2366124286162, 9379.437233765995, 9446.622135114518, 9646.662366817127, 9696.127348538665, 9878.950605247072, 482886.0, 485356.0, 485759.0, 486112.0, 488823.0, 92475.0, 94174.0, 94195.0, 94626.0, 94678.52660736653, 1049.8687664041995, 1063.7925604507047, 1065.3980501016902, 1129.6780417581115, 1138.4706111658118, 17381.82618173853, 17623.559411014827, 18306.633867322846, 18320.908395457936, 18627.348042818438, 44237.336439952785, 44781.55218447774, 44834.77582612066, 45299.77350113228, 45904.31143532917, 54302.185467217234, 55870.44129558815, 56692.43307566871, 57257.14114288206, 57811.710941445024, 8004.319632831274, 8115.1479094694205, 8454.492730436194, 8468.322534197127, 8470.407071504935, 12771.169873958162, 12932.676683082622, 12973.870261297643, 13021.544245951347, 13096.672583185496, 10713.892861071601, 10748.086412655011, 10876.347419154876, 11069.335839849635, 11284.379359135326, 10559.78880422372, 10765.084967777826, 10766.676999690022, 10826.242163048511, 10904.727381815517, 11450.828237576276, 11454.484548195185, 11818.704532386415, 11851.466683999068, 11879.287242765462, 8076.353891688768, 8088.312493437888, 8221.917780822354, 8365.832683346422, 8369.246767790928, 10815.56737730482, 10863.0, 10974.725631859268, 11074.0, 11306.0], "value": 9018.377026769227, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.2658831289539, 1299.324351337304, 1322.0084936297771, 1324.046686385802, 1325.1717676452217, 9432.952835235832, 9767.365121267112, 9770.609175632984, 9775.511224438786, 9800.215982721384, 9837.409755414663, 10156.542955566998, 10177.84733229002, 10180.541875615616, 10205.234607404438, 2260.1185537640295, 2294.713160854893, 2300.217925905192, 2300.7124109486313, 2307.8846057697133, 1875.8405535529496, 1950.1711772496633, 2176.2927048709153, 2181.8472706910525, 2277.9202727904526, 2249.7862703043184, 2278.840481166319, 2279.225063478417, 2279.8632082075046, 2281.577908087001, 2095.476130967258, 2152.2359562355296, 2166.068590506082, 2264.513129677111, 2281.6919715838317, 2212.9778702212934, 2215.5125872308067, 2219.367480268132, 2222.75549689534, 2229.1974889039934, 9621.855672164924, 9858.9507052465, 9878.950605246928, 9888.851667224997, 9894.406335619886, 5417.29355253094, 5626.634268772557, 5629.4652008059165, 5630.577706672016, 5632.74652640628, 3193.4730769423018, 3195.456772348683, 3266.2324353776844, 3268.983655081733, 3291.8189499577516, 994.9204063674889, 998.8501724741275, 1006.3760468509498, 1032.0814475117152, 1032.5921261101898, 13960.092593981359, 13969.441222351094, 14072.71854562903, 14076.366563504667, 14083.71832563343, 4643.698159619614, 4760.238361862154, 4845.781939812717, 4853.490383509751, 4939.135651261015, 10920.453977301104, 10943.507542160622, 10947.178961577914, 10949.0, 10949.671509854717, 5547.278853749068, 5548.611597188158, 5551.056320425538, 5551.139573366135, 5554.055810512142, 4893.241547560134, 5023.09584274834, 5094.541491265803, 5098.1842905135, 5184.507471790174, 3807.923841523154, 3895.3377925752125, 3901.902452438712, 3938.133610605662, 3995.081131339808, 1029.5933106423072, 1059.1791361694595, 1173.2694275943086, 1181.173178774861, 1190.2679851891025, 667.2893368562466, 702.2731472925498, 702.6873041496485, 708.9078419805495, 716.3695947566108, 5586.13414920688, 5727.713614319267, 5764.625299355528, 5796.101604251347, 5898.498627616701, 530.3635637235333, 644.8903686373328, 813.1461964936793, 839.4837175137246, 844.5186243840951, 3525.94711079334, 3563.1448452371765, 3583.4803953427127, 3650.9817450913106, 3736.5889752127246, 12791.296478693575, 13145.671358216121, 13150.27673477968, 13290.3354832258, 13316.533921312708, 12855.035872309427, 12894.35528223585, 12898.419571119322, 13044.54344097952, 13052.477900884049, 9350.0, 9423.952880235693, 9443.575039123256, 9539.427634341822, 9558.426494410358, 5502.147167189092, 5508.752106155152, 5703.885922281448, 5812.82561523155, 6085.087236914498, 11571.132165087483, 11719.88280117222, 11775.705607359885, 11775.76448471043, 11801.763964720829, 11686.24039437434, 11817.645470635895, 11941.701457463632, 12021.218620789621, 12048.698782530508, 8036.397270204641, 8264.958675206826, 8301.0, 8316.62575184106, 8326.70856520019, 9053.909460905306, 9250.259979201513, 9364.250859931326, 9367.297452690938, 9410.0, 7281.526700764433, 7371.668274927749, 7390.704371825067, 7437.367823734827, 7657.846843062996, 7550.66022029021, 7561.9243807563425, 7667.3099421052375, 7696.076470823537, 7720.806979825549, 7029.648517574203, 7162.749303774552, 7174.713011479483, 7180.102487189101, 7188.065551478275, 4982.252662100714, 5127.435982042047, 5237.947620523746, 5243.580513558983, 5265.236540701653, 5172.9741351293005, 5239.528442440199, 5252.185911183773, 5322.550310325316, 5474.288342515448], "value": 4676.662122800811, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.84413812405984, 385.1276857916818, 385.1526641388945, 388.1480151068405, 392.32324240684824, 5350.705711185883, 5357.91963120553, 5407.215953686713, 5472.972635136829, 5474.096774032289, 5144.125498665227, 5263.552598029172, 5319.441458646835, 5353.625246232766, 5357.892842143155, 4149.128682976571, 4170.124273902484, 4190.329547272437, 4196.664266858644, 4207.368894665794, 4160.251154792136, 4171.520275168364, 4176.7076304658685, 4180.5610410906875, 4184.0, 3998.8800335989968, 4125.195586860564, 4148.502179738421, 4149.605787450188, 4153.276390298022, 4121.845883152707, 4125.1131006833375, 4131.483564554431, 4146.564610715892, 4170.812313445887, 3701.6298370163036, 3706.425504046877, 3709.998300458861, 3719.497867787841, 3720.274546463441, 5146.716930568818, 5150.562202212816, 5165.535101840815, 5167.018266529348, 5179.766910489037, 4778.641601879873, 4892.6575139740235, 4911.926321105187, 4913.828016019458, 4924.852254432372, 5635.915461268084, 5646.011947909099, 5657.236273103161, 5664.971675141598, 5689.829305120853, 4157.168566286755, 4165.312723400635, 4178.78815143608, 4181.393697913785, 4187.769672668002, 5706.172604972297, 5783.652980821164, 5900.1149827526215, 5916.23088998436, 5970.253718285171, 4341.891452713708, 4345.891797591657, 4352.825886964486, 4355.564443555619, 4356.411884395629, 4430.740322435517, 4440.956375251813, 4443.355713421536, 4447.888802779957, 4451.5103338632725, 4679.789409476513, 4728.17256980034, 4901.264810278487, 4967.304577359173, 4980.701157930535, 5697.857553561112, 5721.628094173865, 5725.971370143123, 5737.3688894221605, 5737.5983681141915, 1532.4100221414612, 1539.2226925402824, 1541.4277437014182, 1545.3509525999107, 1545.6058705030146, 1033.421284080917, 1088.7713580148259, 1094.244970970044, 1097.1990446973755, 1108.6286094158547, 5047.091523525727, 5049.444561098277, 5055.266986287042, 5070.315507406527, 5077.8320986173385, 5921.792737254175, 5932.970335148383, 5954.612950158225, 5969.641821490724, 5981.850453738604, 4898.21628539432, 5030.0, 5052.444231134572, 5062.519060689228, 5073.162928116893, 3110.1758034120976, 3139.450596145711, 3143.182772479126, 3145.308032232905, 3147.8583463744185, 5303.416624171338, 5486.725663716798, 5510.256115424367, 5512.0905050667, 5529.778808847682, 6037.728302226323, 6037.788677396358, 6044.304904935989, 6072.848178795565, 6116.318012546585, 5513.338399392099, 5544.833654990357, 5551.72241387929, 5558.833235002876, 5572.58205634579, 5643.294588176478, 5904.0, 5925.9407405925385, 5933.673647949404, 5941.346451890375, 5800.59395842287, 5810.970945145416, 5833.533317334518, 5843.415658434123, 5867.911981320369, 5309.123994540858, 5372.838814835562, 5444.0, 5516.0, 5548.278723765885, 3959.8218080185884, 3961.2869683457257, 3966.127451960564, 3970.861019864291, 3975.6223158799867, 5718.857028574319, 5865.501432378295, 5891.3224979126235, 5901.5868889177345, 5916.822495325147, 5616.1014237721765, 5616.466435688603, 5618.325800903917, 5664.518515926027, 5738.971305143447, 5713.7428815704225, 5728.369879313355, 5734.648793994442, 5736.541076713769, 5738.081906894877, 5514.228008078952, 5600.60795744294, 5650.152477128464, 5667.518260947865, 5692.743826527899, 5728.513076388554, 5770.884582308414, 5783.334916484658, 5785.322256545554, 5788.450097240755, 5621.213030175697, 5627.7467513961155, 5630.380658127685, 5643.689597072201, 5651.660900345993], "value": 4335.483408496581, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.3550094895616, 620.1472974659843, 640.3148630964868, 647.4140902483255, 651.9217693876734, 11736.706582335446, 11771.234869733473, 12066.879331206685, 12092.879071209285, 12114.636560903176, 12989.415476303566, 13051.41268642911, 13063.934680326609, 13125.409356578954, 13187.802182967263, 876.1151237250375, 884.8407286688393, 899.0919171636629, 903.0337538833451, 914.7758799094231, 905.0135352465811, 905.9094090590954, 905.9547022648874, 907.3376435202306, 910.2399496420497, 949.9525023748785, 950.1828427552299, 950.9096635819586, 952.471378384996, 952.5094576293214, 947.7772723409993, 947.9052094790535, 948.3740731117464, 949.5062567464948, 953.3755390219418, 696.6760456387804, 697.3549466743242, 697.4943166204512, 700.2332445971653, 703.2405002597183, 12910.22538647684, 13262.66843328915, 13736.587902362946, 13809.0, 13821.239831809247, 13338.733225335536, 14179.78730319046, 14395.496157634432, 14706.779398309034, 14774.261286935718, 9775.266854985834, 9842.603661833531, 9842.852357214648, 9973.90026099737, 9985.900140998643, 2712.715164907696, 2719.170652950849, 2727.386338073937, 2763.5440152374836, 2779.0967935421068, 69597.0, 71451.0, 72093.91859122169, 72324.27675723228, 73065.26934730638, 10337.0, 10432.634857779942, 10535.57857685684, 10618.0, 10852.891471085188, 21881.12475500962, 22106.33680989573, 22238.88880555619, 22373.664395034088, 22399.21602743896, 5538.861528461821, 5545.390007099216, 5554.6944918029085, 5598.692071936001, 5665.12190610456, 3353.9496907546404, 3354.9161270967934, 3404.914877128042, 3446.8621255150015, 3447.9655203447646, 3447.620761716209, 3491.406460901602, 3517.736169787276, 3519.384107781128, 3520.4543295789194, 586.2437455682123, 592.1561774471361, 610.920580324555, 618.0574623698895, 620.011082323693, 518.556634077858, 543.627615083669, 553.1702446330504, 559.6893723983228, 572.9255196824386, 7871.921280787234, 8096.271335579826, 8223.712170074019, 8335.791605209797, 8482.745517634481, 544.9673019618835, 575.200471344831, 578.0808514462026, 578.7106446776612, 578.94789468948, 3784.810759462016, 3790.1093243087853, 3873.709471789627, 3922.4116382542848, 3969.2656858480696, 65339.0, 66668.6666566664, 67829.0, 68834.65582672054, 69613.0, 57840.42159578435, 57842.421575784545, 57983.0, 58129.128063079086, 58218.0, 50775.49224507855, 50981.0, 50982.235266471034, 51119.488805111476, 51504.22743658848, 7488.588127653032, 7730.149683534919, 7907.802304942423, 7972.521648701097, 9497.477638729937, 24080.63879041781, 25473.87263063747, 26072.739272607032, 27678.44643107167, 27726.168214953585, 44697.55302446934, 45802.54197457983, 46410.53589464062, 47273.52726472829, 47546.762266188445, 12286.815697764361, 12383.257004579755, 12414.131010829155, 12444.253344799341, 12670.113092083466, 13391.464341426234, 13603.319834008062, 13615.863841361459, 13659.0, 13807.378667959765, 10590.841137382791, 10776.730581735519, 10781.568737250736, 10792.406417647106, 11097.944510277397, 12599.307038112991, 12685.0, 12765.553205637758, 12770.808437873253, 12898.935505322414, 10341.327813692085, 10455.372677639367, 10486.79026419452, 10727.731806704895, 10928.672139835817, 8805.42764720291, 8996.64013439455, 9289.581968811555, 9343.859842102238, 9390.389624674373, 9094.849274394663, 9210.309226807882, 9224.907750922404, 9227.44635321883, 9413.623455061721], "value": 6337.6751403833805, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 111.0, 111.0, 114.0, 111.0, 111.0, 110.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 123.0, 171.0, 129.0, 126.0, 123.0, 125.0, 148.0, 123.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 166.0, 165.0, 164.0, 165.0, 163.0, 165.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 109.0, 76.0, 75.0, 78.0, 76.0, 94.0, 77.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 103.0, 84.0, 84.0, 84.0, 99.0, 84.0, 84.0, 110.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 151.0, 149.0, 149.0, 149.0, 158.0, 163.0, 151.0, 150.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 53.0, 53.0, 54.0, 53.0, 53.0, 56.0, 54.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 62.0, 55.0, 56.0, 55.0, 55.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 83.0, 84.0, 82.0, 84.0, 83.0, 83.0, 82.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 141.0, 135.0, 135.0, 146.0, 134.0, 140.0, 140.0, 183.0, 151.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 195.0, 202.0, 190.0, 206.0, 192.0, 194.0, 191.0, 189.0, 195.0], "value": 195.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 70.0, 70.0, 70.0, 71.0, 74.0, 74.0, 74.0, 72.0], "value": 71.6, "unit": "score"}]}]} 18:07:26 INFO - Return code: 0 18:07:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:07:26 ERROR - # TBPL SUCCESS # 18:07:26 INFO - Running post-action listener: _resource_record_post_action 18:07:26 INFO - [mozharness: 2017-04-01 01:07:26.671182Z] Finished run-tests step (success) 18:07:26 INFO - Running post-run listener: _resource_record_post_run 18:07:26 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364331008; Read time: 12; Write time: 272752 18:07:26 INFO - TinderboxPrint: CPU usage
13.0% 18:07:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:07:26 INFO - TinderboxPrint: I/O write bytes / time
364,331,008 / 272,752 18:07:26 INFO - TinderboxPrint: CPU idle
8,379.3 (87.0%) 18:07:26 INFO - TinderboxPrint: CPU user
1,206.0 (12.5%) 18:07:26 INFO - TinderboxPrint: Swap in / out
0 / 0 18:07:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107208704; Read time: 0; Write time: 79208 18:07:26 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 257122304; Read time: 0; Write time: 193544 18:07:27 INFO - Running post-run listener: _upload_blobber_files 18:07:27 INFO - Blob upload gear active. 18:07:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:07:27 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 18:07:27 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'] 18:07:27 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 18:07:27 INFO - (blobuploader) - INFO - Open directory for files ... 18:07:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:07:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:07:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:30 INFO - (blobuploader) - INFO - Done attempting. 18:07:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:07:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:07:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:31 INFO - (blobuploader) - INFO - Done attempting. 18:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:07:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:33 INFO - (blobuploader) - INFO - Done attempting. 18:07:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:07:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:07:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:34 INFO - (blobuploader) - INFO - Done attempting. 18:07:34 INFO - (blobuploader) - INFO - Iteration through files over. 18:07:34 INFO - Return code: 0 18:07:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:07:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:07:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e7cb4dff26ce51c77f751849742117f4010baa63b19298f34b5cd9bf3db973cba1fdb82bdc6afa28bbe31699bf5e65e2c659eb17948aeac31f0c5105b55b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af18963eacc8eec279aac3fb19d32ff24fe0c4efac36e776d8bcf1ddbb9d2c14d39832fa0e1531b1debe81aa944b6b1df28366d2798d82d0dd6e04b3af8c55aa", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd1c2214454d6dcc4bcb746104fed2dd951eadfb272dc7b8e64a39608e1ad0142e14edb3b7f083b10b3af78fdb44d263d38a2ddeb05c509b62dcd9f0ab1236d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c8e963525ba1d25c52cc245a293b58540c1328abe6be818b0a04b087d45421d626e3a04f307003a23ba2ff8a00d7f0a85889c09c76f6ba2ae086630072f0c22"} 18:07:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:07:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:07:34 INFO - Contents: 18:07:34 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e7cb4dff26ce51c77f751849742117f4010baa63b19298f34b5cd9bf3db973cba1fdb82bdc6afa28bbe31699bf5e65e2c659eb17948aeac31f0c5105b55b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af18963eacc8eec279aac3fb19d32ff24fe0c4efac36e776d8bcf1ddbb9d2c14d39832fa0e1531b1debe81aa944b6b1df28366d2798d82d0dd6e04b3af8c55aa", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd1c2214454d6dcc4bcb746104fed2dd951eadfb272dc7b8e64a39608e1ad0142e14edb3b7f083b10b3af78fdb44d263d38a2ddeb05c509b62dcd9f0ab1236d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c8e963525ba1d25c52cc245a293b58540c1328abe6be818b0a04b087d45421d626e3a04f307003a23ba2ff8a00d7f0a85889c09c76f6ba2ae086630072f0c22"} 18:07:34 INFO - Running post-run listener: copy_logs_to_upload_dir 18:07:34 INFO - Copying logs to upload dir... 18:07:34 INFO - mkdir: /builds/slave/test/build/upload/logs 18:07:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.729591 ========= master_lag: -0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-03-31 18:07:33.602648) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 18:07:33.606375) ========= 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=ea65d483da93c827905c2090000001f5-1491007585.593559-902888168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e7cb4dff26ce51c77f751849742117f4010baa63b19298f34b5cd9bf3db973cba1fdb82bdc6afa28bbe31699bf5e65e2c659eb17948aeac31f0c5105b55b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af18963eacc8eec279aac3fb19d32ff24fe0c4efac36e776d8bcf1ddbb9d2c14d39832fa0e1531b1debe81aa944b6b1df28366d2798d82d0dd6e04b3af8c55aa", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd1c2214454d6dcc4bcb746104fed2dd951eadfb272dc7b8e64a39608e1ad0142e14edb3b7f083b10b3af78fdb44d263d38a2ddeb05c509b62dcd9f0ab1236d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c8e963525ba1d25c52cc245a293b58540c1328abe6be818b0a04b087d45421d626e3a04f307003a23ba2ff8a00d7f0a85889c09c76f6ba2ae086630072f0c22"} build_url:https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/IwyAVu8RSZ-9rY8PvL0Jyg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7e7cb4dff26ce51c77f751849742117f4010baa63b19298f34b5cd9bf3db973cba1fdb82bdc6afa28bbe31699bf5e65e2c659eb17948aeac31f0c5105b55b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af18963eacc8eec279aac3fb19d32ff24fe0c4efac36e776d8bcf1ddbb9d2c14d39832fa0e1531b1debe81aa944b6b1df28366d2798d82d0dd6e04b3af8c55aa", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd1c2214454d6dcc4bcb746104fed2dd951eadfb272dc7b8e64a39608e1ad0142e14edb3b7f083b10b3af78fdb44d263d38a2ddeb05c509b62dcd9f0ab1236d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c8e963525ba1d25c52cc245a293b58540c1328abe6be818b0a04b087d45421d626e3a04f307003a23ba2ff8a00d7f0a85889c09c76f6ba2ae086630072f0c22"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 18:07:33.640909) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 18:07:33.641258) ========= 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=ea65d483da93c827905c2090000001f5-1491007585.593559-902888168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 18:07:33.730615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 18:07:33.731327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 18:07:33.731849) ========= ========= Total master_lag: 0.05 =========