builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-080 starttime: 1491815939.82 results: success (0) revision: 50cb1ce431d7d2acb0f483bd77395a3b96068d2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 02:18:59.820458) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 02:18:59.820999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 02:18:59.821355) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 02:18:59.836297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:18:59.836621) ========= 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=781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-10 02:19:00-- 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% 102M=0s 2017-04-10 02:19:01 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.965657 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:19:00.816640) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:19:00.817018) ========= 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=781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016784 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:19:00.866992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-10 02:19:00.867358) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 50cb1ce431d7d2acb0f483bd77395a3b96068d2c --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 50cb1ce431d7d2acb0f483bd77395a3b96068d2c --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=781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-10 02:19:01,173 truncating revision to first 12 chars 2017-04-10 02:19:01,173 Setting DEBUG logging. 2017-04-10 02:19:01,173 attempt 1/10 2017-04-10 02:19:01,173 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/50cb1ce431d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 02:19:03,932 unpacking tar archive at: mozilla-central-50cb1ce431d7/testing/mozharness/ program finished with exit code 0 elapsedTime=3.074321 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-10 02:19:03.958244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 02:19:03.958581) ========= script_repo_revision: 50cb1ce431d7d2acb0f483bd77395a3b96068d2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 02:19:03.958955) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 02:19:03.959216) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 02:19:03.969262) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2017-04-10 02:19:03.969596) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:19:04 INFO - MultiFileLogger online at 20170410 02:19:04 in /builds/slave/test 02:19:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:19:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:19:04 INFO - {'append_to_log': False, 02:19:04 INFO - 'base_work_dir': '/builds/slave/test', 02:19:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:19:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:19:04 INFO - 'branch': 'Firefox-Non-PGO', 02:19:04 INFO - 'buildbot_json_path': 'buildprops.json', 02:19:04 INFO - 'config_files': ('talos/linux_config.py',), 02:19:04 INFO - 'default_actions': ('clobber', 02:19:04 INFO - 'read-buildbot-config', 02:19:04 INFO - 'download-and-extract', 02:19:04 INFO - 'populate-webroot', 02:19:04 INFO - 'create-virtualenv', 02:19:04 INFO - 'install', 02:19:04 INFO - 'run-tests'), 02:19:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:19:04 INFO - 'download_minidump_stackwalk': True, 02:19:04 INFO - 'download_symbols': 'ondemand', 02:19:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:19:04 INFO - 'tooltool.py': '/tools/tooltool.py', 02:19:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:19:04 INFO - '/tools/misc-python/virtualenv.py')}, 02:19:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:19:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:19:04 INFO - 'gecko_profile': False, 02:19:04 INFO - 'gecko_profile_interval': 0, 02:19:04 INFO - 'installer_path': 'installer.exe', 02:19:04 INFO - 'log_level': 'info', 02:19:04 INFO - 'log_name': 'talos', 02:19:04 INFO - 'log_to_console': True, 02:19:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:19:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:19:04 INFO - 'opt_config_files': (), 02:19:04 INFO - 'pip_index': False, 02:19:04 INFO - 'suite': 'dromaeojs', 02:19:04 INFO - 'system_bits': '32', 02:19:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:19:04 INFO - 'title': 'talos-linux64-ix-080', 02:19:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:19:04 INFO - 'use_talos_json': True, 02:19:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:19:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:19:04 INFO - 'work_dir': 'build'} 02:19:04 INFO - [mozharness: 2017-04-10 09:19:04.373549Z] Running clobber step. 02:19:04 INFO - Running pre-action listener: _resource_record_pre_action 02:19:04 INFO - Running main action method: clobber 02:19:04 INFO - rmtree: /builds/slave/test/build 02:19:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:19:05 INFO - Running post-action listener: _resource_record_post_action 02:19:05 INFO - [mozharness: 2017-04-10 09:19:05.910770Z] Finished clobber step (success) 02:19:05 INFO - [mozharness: 2017-04-10 09:19:05.910870Z] Running read-buildbot-config step. 02:19:05 INFO - Running pre-action listener: _resource_record_pre_action 02:19:05 INFO - Running main action method: read_buildbot_config 02:19:05 INFO - Using buildbot properties: 02:19:05 INFO - { 02:19:05 INFO - "project": "", 02:19:05 INFO - "product": "firefox", 02:19:05 INFO - "who": "cbook@mozilla.com", 02:19:05 INFO - "installer_path": "public/build/target.tar.bz2", 02:19:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 02:19:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:19:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 02:19:05 INFO - "stage_platform": "linux64", 02:19:05 INFO - "basedir": "/builds/slave/test", 02:19:05 INFO - "buildnumber": 1062, 02:19:05 INFO - "platform": "ubuntu64_hw", 02:19:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:19:05 INFO - "slavebuilddir": "test", 02:19:05 INFO - "taskId": "J0QtQWtPRJK4XzJsMdMC7Q", 02:19:05 INFO - "branch": "mozilla-central", 02:19:05 INFO - "script_repo_revision": "production", 02:19:05 INFO - "revision": "50cb1ce431d7d2acb0f483bd77395a3b96068d2c", 02:19:05 INFO - "slavename": "talos-linux64-ix-080", 02:19:05 INFO - "repo_path": "mozilla-central" 02:19:05 INFO - } 02:19:05 INFO - Finding installer, test and symbols from parent task. 02:19:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J0QtQWtPRJK4XzJsMdMC7Q'}, attempt #1 02:19:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J0QtQWtPRJK4XzJsMdMC7Q'}, attempt #1 02:19:09 INFO - Task dependencies: CYYOD0fJQayyLRuWdaHAEA 02:19:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA'}, attempt #1 02:19:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.tar.bz2 02:19:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/test_packages.json 02:19:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.crashreporter-symbols.zip 02:19:10 INFO - Running post-action listener: _resource_record_post_action 02:19:10 INFO - [mozharness: 2017-04-10 09:19:10.704793Z] Finished read-buildbot-config step (success) 02:19:10 INFO - [mozharness: 2017-04-10 09:19:10.705054Z] Running download-and-extract step. 02:19:10 INFO - Running pre-action listener: _resource_record_pre_action 02:19:10 INFO - Running main action method: download_and_extract 02:19:10 INFO - mkdir: /builds/slave/test/build/tests 02:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:10 INFO - trying https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.test_packages.json 02:19:10 INFO - Downloading https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:19:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:19:13 INFO - Downloaded 986 bytes. 02:19:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:19:13 INFO - Using the following test package requirements: 02:19:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:19:13 INFO - u'common': [u'target.common.tests.zip'], 02:19:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:19:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:19:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:19:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:19:13 INFO - u'mozbase': [u'target.common.tests.zip'], 02:19:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:19:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:19:13 INFO - u'web-platform': [u'target.common.tests.zip', 02:19:13 INFO - u'target.web-platform.tests.zip'], 02:19:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:19:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:19:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.common.tests.zip 02:19:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:19:13 INFO - Fetch https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.common.tests.zip into memory 02:19:18 INFO - Expected file size: 58245639 02:19:18 INFO - Obtained file size: 58245639 02:19:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:19:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.common.tests.zip 02:19:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:19:28 INFO - Fetch https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.common.tests.zip into memory 02:19:31 INFO - Expected file size: 58245639 02:19:31 INFO - Obtained file size: 58245639 02:19:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.talos.tests.zip 02:19:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:19:42 INFO - Fetch https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.talos.tests.zip into memory 02:19:46 INFO - Expected file size: 14405596 02:19:46 INFO - Obtained file size: 14405596 02:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:46 INFO - trying https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.tar.bz2 02:19:46 INFO - Downloading https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:19:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:19:50 INFO - Downloaded 57791012 bytes. 02:19:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.tar.bz2 02:19:50 INFO - mkdir: /builds/slave/test/properties 02:19:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:50 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:50 INFO - Contents: 02:19:50 INFO - build_url:https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.tar.bz2 02:19:50 INFO - Running post-action listener: _resource_record_post_action 02:19:50 INFO - Running post-action listener: set_extra_try_arguments 02:19:50 INFO - [mozharness: 2017-04-10 09:19:50.071250Z] Finished download-and-extract step (success) 02:19:50 INFO - [mozharness: 2017-04-10 09:19:50.071345Z] Running populate-webroot step. 02:19:50 INFO - Running pre-action listener: _resource_record_pre_action 02:19:50 INFO - Running main action method: populate_webroot 02:19:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:19:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:19:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:19:50 INFO - '--tppagecycles', 02:19:50 INFO - '7'], 02:19:50 INFO - 'tests': ['tsvgm']}}, 02:19:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:19:50 INFO - 'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:19:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:19:50 INFO - 'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['damp', 'tps']}, 02:19:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:19:50 INFO - 'tests': ['damp', 'tps']}, 02:19:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['dromaeo_dom']}, 02:19:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['basic_compositor_video']}, 02:19:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:19:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['a11yr', 02:19:50 INFO - 'ts_paint', 02:19:50 INFO - 'tpaint', 02:19:50 INFO - 'sessionrestore', 02:19:50 INFO - 'sessionrestore_no_auto_restore', 02:19:50 INFO - 'tabpaint']}, 02:19:50 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:50 INFO - 'ts_paint', 02:19:50 INFO - 'tpaint', 02:19:50 INFO - 'sessionrestore', 02:19:50 INFO - 'sessionrestore_no_auto_restore', 02:19:50 INFO - 'tabpaint']}, 02:19:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:19:50 INFO - 'ts_paint', 02:19:50 INFO - 'tpaint', 02:19:50 INFO - 'sessionrestore', 02:19:50 INFO - 'sessionrestore_no_auto_restore', 02:19:50 INFO - 'tabpaint']}, 02:19:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:19:50 INFO - 'ts_paint', 02:19:50 INFO - 'tpaint', 02:19:50 INFO - 'sessionrestore', 02:19:50 INFO - 'sessionrestore_no_auto_restore', 02:19:50 INFO - 'tabpaint']}, 02:19:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['a11yr', 02:19:50 INFO - 'ts_paint', 02:19:50 INFO - 'tpaint', 02:19:50 INFO - 'sessionrestore', 02:19:50 INFO - 'sessionrestore_no_auto_restore', 02:19:50 INFO - 'tabpaint']}, 02:19:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['a11yr', 02:19:50 INFO - 'ts_paint', 02:19:50 INFO - 'tpaint', 02:19:50 INFO - 'sessionrestore', 02:19:50 INFO - 'sessionrestore_no_auto_restore', 02:19:50 INFO - 'tabpaint']}, 02:19:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['tsvgx', 02:19:50 INFO - 'tsvgr_opacity', 02:19:50 INFO - 'tart', 02:19:50 INFO - 'tscrollx', 02:19:50 INFO - 'cart', 02:19:50 INFO - 'tsvg_static']}, 02:19:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:50 INFO - 'tsvgr_opacity', 02:19:50 INFO - 'tart', 02:19:50 INFO - 'tscrollx', 02:19:50 INFO - 'cart', 02:19:50 INFO - 'tsvg_static']}, 02:19:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:19:50 INFO - 'talos_options': ['--disable-e10s'], 02:19:50 INFO - 'tests': ['tp5o']}, 02:19:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:19:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:19:50 INFO - 'talos_options': ['--disable-e10s', 02:19:50 INFO - '--xperf_path', 02:19:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:50 INFO - 'tests': ['tp5n']}, 02:19:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:19:50 INFO - 'talos_options': ['--xperf_path', 02:19:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:50 INFO - 'tests': ['tp5n']}}, 02:19:50 INFO - 'talos.zip': {'path': '', 02:19:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:19:50 INFO - Running post-action listener: _resource_record_post_action 02:19:50 INFO - [mozharness: 2017-04-10 09:19:50.084556Z] Finished populate-webroot step (success) 02:19:50 INFO - [mozharness: 2017-04-10 09:19:50.084644Z] Running create-virtualenv step. 02:19:50 INFO - Running pre-action listener: _resource_record_pre_action 02:19:50 INFO - Running main action method: create_virtualenv 02:19:50 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:19:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:19:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:50 INFO - Using real prefix '/usr' 02:19:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:50 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:52 INFO - Installing pip.................done. 02:19:52 INFO - Return code: 0 02:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:19:52 INFO - Reading from file tmpfile_stdout 02:19:52 INFO - Output received: 02:19:52 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:19:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:55 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 0x111b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1213a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, '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': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:19:55 INFO - Using env: {'DISPLAY': ':0', 02:19:55 INFO - 'HOME': '/home/cltbld', 02:19:55 INFO - 'LANG': 'en_US.UTF-8', 02:19:55 INFO - 'LANGUAGE': 'en_US:en', 02:19:55 INFO - 'LOGNAME': 'cltbld', 02:19:55 INFO - 'MAIL': '/var/mail/cltbld', 02:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:55 INFO - 'MOZ_NO_REMOTE': '1', 02:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:55 INFO - 'NO_EM_RESTART': '1', 02:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:55 INFO - 'PWD': '/builds/slave/test', 02:19:55 INFO - 'SHELL': '/bin/bash', 02:19:55 INFO - 'SHLVL': '1', 02:19:55 INFO - 'TERM': 'linux', 02:19:55 INFO - 'TMOUT': '86400', 02:19:55 INFO - 'USER': 'cltbld', 02:19:55 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:55 INFO - '_': '/tools/buildbot/bin/python'} 02:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:19:55 INFO - Cleaning up... 02:19:55 INFO - Return code: 0 02:19:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:00 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 0x111b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1213a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, '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': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:20:00 INFO - Using env: {'DISPLAY': ':0', 02:20:00 INFO - 'HOME': '/home/cltbld', 02:20:00 INFO - 'LANG': 'en_US.UTF-8', 02:20:00 INFO - 'LANGUAGE': 'en_US:en', 02:20:00 INFO - 'LOGNAME': 'cltbld', 02:20:00 INFO - 'MAIL': '/var/mail/cltbld', 02:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:00 INFO - 'MOZ_NO_REMOTE': '1', 02:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:00 INFO - 'NO_EM_RESTART': '1', 02:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:00 INFO - 'PWD': '/builds/slave/test', 02:20:00 INFO - 'SHELL': '/bin/bash', 02:20:00 INFO - 'SHLVL': '1', 02:20:00 INFO - 'TERM': 'linux', 02:20:00 INFO - 'TMOUT': '86400', 02:20:00 INFO - 'USER': 'cltbld', 02:20:00 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:00 INFO - '_': '/tools/buildbot/bin/python'} 02:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:00 INFO - Downloading/unpacking psutil>=3.1.1 02:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:07 INFO - Installing collected packages: psutil 02:20:07 INFO - Running setup.py install for psutil 02:20:07 INFO - building 'psutil._psutil_linux' extension 02:20:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:20:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:20:07 INFO - building 'psutil._psutil_posix' extension 02:20:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:20:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:20:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:07 INFO - Successfully installed psutil 02:20:07 INFO - Cleaning up... 02:20:07 INFO - Return code: 0 02:20:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1213a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, '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': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:20:12 INFO - Using env: {'DISPLAY': ':0', 02:20:12 INFO - 'HOME': '/home/cltbld', 02:20:12 INFO - 'LANG': 'en_US.UTF-8', 02:20:12 INFO - 'LANGUAGE': 'en_US:en', 02:20:12 INFO - 'LOGNAME': 'cltbld', 02:20:12 INFO - 'MAIL': '/var/mail/cltbld', 02:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:12 INFO - 'MOZ_NO_REMOTE': '1', 02:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:12 INFO - 'NO_EM_RESTART': '1', 02:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:12 INFO - 'PWD': '/builds/slave/test', 02:20:12 INFO - 'SHELL': '/bin/bash', 02:20:12 INFO - 'SHLVL': '1', 02:20:12 INFO - 'TERM': 'linux', 02:20:12 INFO - 'TMOUT': '86400', 02:20:12 INFO - 'USER': 'cltbld', 02:20:12 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:12 INFO - '_': '/tools/buildbot/bin/python'} 02:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:20:23 INFO - Installing collected packages: mozsystemmonitor 02:20:23 INFO - Running setup.py install for mozsystemmonitor 02:20:23 INFO - Successfully installed mozsystemmonitor 02:20:23 INFO - Cleaning up... 02:20:23 INFO - Return code: 0 02:20:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:26 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 0x111b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1213a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, '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': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:20:26 INFO - Using env: {'DISPLAY': ':0', 02:20:26 INFO - 'HOME': '/home/cltbld', 02:20:26 INFO - 'LANG': 'en_US.UTF-8', 02:20:26 INFO - 'LANGUAGE': 'en_US:en', 02:20:26 INFO - 'LOGNAME': 'cltbld', 02:20:26 INFO - 'MAIL': '/var/mail/cltbld', 02:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:26 INFO - 'MOZ_NO_REMOTE': '1', 02:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:26 INFO - 'NO_EM_RESTART': '1', 02:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:26 INFO - 'PWD': '/builds/slave/test', 02:20:26 INFO - 'SHELL': '/bin/bash', 02:20:26 INFO - 'SHLVL': '1', 02:20:26 INFO - 'TERM': 'linux', 02:20:26 INFO - 'TMOUT': '86400', 02:20:26 INFO - 'USER': 'cltbld', 02:20:26 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:26 INFO - '_': '/tools/buildbot/bin/python'} 02:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:26 INFO - Downloading/unpacking jsonschema==2.5.1 02:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:33 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:33 INFO - warning: no files found matching '*.txt' 02:20:33 INFO - no previously-included directories found matching 'build' 02:20:33 INFO - no previously-included directories found matching 'dist' 02:20:33 INFO - no previously-included directories found matching '.git*' 02:20:33 INFO - Installing collected packages: jsonschema, functools32 02:20:33 INFO - Running setup.py install for functools32 02:20:33 INFO - warning: no files found matching '*.txt' 02:20:33 INFO - no previously-included directories found matching 'build' 02:20:33 INFO - no previously-included directories found matching 'dist' 02:20:33 INFO - no previously-included directories found matching '.git*' 02:20:33 INFO - Successfully installed jsonschema functools32 02:20:33 INFO - Cleaning up... 02:20:33 INFO - Return code: 0 02:20:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:37 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 0x111b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1213a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, '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': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:20:37 INFO - Using env: {'DISPLAY': ':0', 02:20:37 INFO - 'HOME': '/home/cltbld', 02:20:37 INFO - 'LANG': 'en_US.UTF-8', 02:20:37 INFO - 'LANGUAGE': 'en_US:en', 02:20:37 INFO - 'LOGNAME': 'cltbld', 02:20:37 INFO - 'MAIL': '/var/mail/cltbld', 02:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:37 INFO - 'MOZ_NO_REMOTE': '1', 02:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:37 INFO - 'NO_EM_RESTART': '1', 02:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:37 INFO - 'PWD': '/builds/slave/test', 02:20:37 INFO - 'SHELL': '/bin/bash', 02:20:37 INFO - 'SHLVL': '1', 02:20:37 INFO - 'TERM': 'linux', 02:20:37 INFO - 'TMOUT': '86400', 02:20:37 INFO - 'USER': 'cltbld', 02:20:37 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:37 INFO - '_': '/tools/buildbot/bin/python'} 02:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:20:38 INFO - Cleaning up... 02:20:38 INFO - Return code: 0 02:20:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:40 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 0x111b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1213a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, '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': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:20:40 INFO - Using env: {'DISPLAY': ':0', 02:20:40 INFO - 'HOME': '/home/cltbld', 02:20:40 INFO - 'LANG': 'en_US.UTF-8', 02:20:40 INFO - 'LANGUAGE': 'en_US:en', 02:20:40 INFO - 'LOGNAME': 'cltbld', 02:20:40 INFO - 'MAIL': '/var/mail/cltbld', 02:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:40 INFO - 'MOZ_NO_REMOTE': '1', 02:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:40 INFO - 'NO_EM_RESTART': '1', 02:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:40 INFO - 'PWD': '/builds/slave/test', 02:20:40 INFO - 'SHELL': '/bin/bash', 02:20:40 INFO - 'SHLVL': '1', 02:20:40 INFO - 'TERM': 'linux', 02:20:40 INFO - 'TMOUT': '86400', 02:20:40 INFO - 'USER': 'cltbld', 02:20:40 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:40 INFO - '_': '/tools/buildbot/bin/python'} 02:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:41 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:48 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:49 INFO - Downloading docopt-0.6.1.tar.gz 02:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:49 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:49 INFO - Running setup.py install for blobuploader 02:20:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:49 INFO - Running setup.py install for requests 02:20:50 INFO - Running setup.py install for docopt 02:20:50 INFO - Successfully installed blobuploader requests docopt 02:20:50 INFO - Cleaning up... 02:20:50 INFO - Return code: 0 02:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:52 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 0x111b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1213a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, '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': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:52 INFO - Using env: {'DISPLAY': ':0', 02:20:52 INFO - 'HOME': '/home/cltbld', 02:20:52 INFO - 'LANG': 'en_US.UTF-8', 02:20:52 INFO - 'LANGUAGE': 'en_US:en', 02:20:52 INFO - 'LOGNAME': 'cltbld', 02:20:52 INFO - 'MAIL': '/var/mail/cltbld', 02:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:52 INFO - 'MOZ_NO_REMOTE': '1', 02:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:52 INFO - 'NO_EM_RESTART': '1', 02:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:52 INFO - 'PWD': '/builds/slave/test', 02:20:52 INFO - 'SHELL': '/bin/bash', 02:20:52 INFO - 'SHLVL': '1', 02:20:52 INFO - 'TERM': 'linux', 02:20:52 INFO - 'TMOUT': '86400', 02:20:52 INFO - 'USER': 'cltbld', 02:20:52 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:52 INFO - '_': '/tools/buildbot/bin/python'} 02:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:52 INFO - Running setup.py (path:/tmp/pip-xAMIlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:52 INFO - Running setup.py (path:/tmp/pip-CJhT84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:52 INFO - Running setup.py (path:/tmp/pip-3jZO_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:52 INFO - Running setup.py (path:/tmp/pip-V1rHD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:52 INFO - Running setup.py (path:/tmp/pip-EdzWev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:53 INFO - Running setup.py (path:/tmp/pip-wHDv_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:53 INFO - Running setup.py (path:/tmp/pip-jCLllc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:53 INFO - Running setup.py (path:/tmp/pip-Gc2aoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:53 INFO - Running setup.py (path:/tmp/pip-Hp_k0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:53 INFO - Running setup.py (path:/tmp/pip-SBqa1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:53 INFO - Running setup.py (path:/tmp/pip-Ydz2i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:53 INFO - Running setup.py (path:/tmp/pip-3BWK4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:53 INFO - Running setup.py (path:/tmp/pip-tFZvgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:53 INFO - Running setup.py (path:/tmp/pip-u_LRA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:53 INFO - Running setup.py (path:/tmp/pip-uOArVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:53 INFO - Running setup.py (path:/tmp/pip-cmW694-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:53 INFO - Running setup.py (path:/tmp/pip-GrZK8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:53 INFO - Running setup.py install for manifestparser 02:20:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for mozcrash 02:20:54 INFO - Running setup.py install for mozdebug 02:20:54 INFO - Running setup.py install for mozdevice 02:20:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for mozfile 02:20:54 INFO - Running setup.py install for mozhttpd 02:20:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for mozinfo 02:20:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for mozInstall 02:20:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for mozleak 02:20:54 INFO - Running setup.py install for mozlog 02:20:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for moznetwork 02:20:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:55 INFO - Running setup.py install for mozprocess 02:20:55 INFO - Running setup.py install for mozprofile 02:20:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:55 INFO - Running setup.py install for mozrunner 02:20:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:55 INFO - Running setup.py install for mozscreenshot 02:20:55 INFO - Running setup.py install for moztest 02:20:55 INFO - Running setup.py install for mozversion 02:20:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:55 INFO - Cleaning up... 02:20:55 INFO - Return code: 0 02:20:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:59 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 0x111b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1213a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, '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': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:59 INFO - Using env: {'DISPLAY': ':0', 02:20:59 INFO - 'HOME': '/home/cltbld', 02:20:59 INFO - 'LANG': 'en_US.UTF-8', 02:20:59 INFO - 'LANGUAGE': 'en_US:en', 02:20:59 INFO - 'LOGNAME': 'cltbld', 02:20:59 INFO - 'MAIL': '/var/mail/cltbld', 02:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:59 INFO - 'MOZ_NO_REMOTE': '1', 02:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:59 INFO - 'NO_EM_RESTART': '1', 02:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:59 INFO - 'PWD': '/builds/slave/test', 02:20:59 INFO - 'SHELL': '/bin/bash', 02:20:59 INFO - 'SHLVL': '1', 02:20:59 INFO - 'TERM': 'linux', 02:20:59 INFO - 'TMOUT': '86400', 02:20:59 INFO - 'USER': 'cltbld', 02:20:59 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:59 INFO - '_': '/tools/buildbot/bin/python'} 02:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:00 INFO - Running setup.py (path:/tmp/pip-y0UNws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:00 INFO - Running setup.py (path:/tmp/pip-uW85WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:00 INFO - Running setup.py (path:/tmp/pip-eMTwHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:00 INFO - Running setup.py (path:/tmp/pip-gWY96R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:00 INFO - Running setup.py (path:/tmp/pip-J0tJWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:00 INFO - Running setup.py (path:/tmp/pip-ZfJlQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:00 INFO - Running setup.py (path:/tmp/pip-UoXfAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:00 INFO - Running setup.py (path:/tmp/pip-3J5GLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:00 INFO - Running setup.py (path:/tmp/pip-tpYprs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:00 INFO - Running setup.py (path:/tmp/pip-HSIUqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:00 INFO - Running setup.py (path:/tmp/pip-rGFK0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:00 INFO - Running setup.py (path:/tmp/pip-KpB8O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:00 INFO - Running setup.py (path:/tmp/pip-KSVgB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:01 INFO - Running setup.py (path:/tmp/pip-8gGZ73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:01 INFO - Running setup.py (path:/tmp/pip-hfCuL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:01 INFO - Running setup.py (path:/tmp/pip-9VdfFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:01 INFO - Running setup.py (path:/tmp/pip-_oHSNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:07 INFO - Downloading blessings-1.6.tar.gz 02:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:21:07 INFO - Installing collected packages: blessings 02:21:07 INFO - Running setup.py install for blessings 02:21:07 INFO - Successfully installed blessings 02:21:07 INFO - Cleaning up... 02:21:07 INFO - Return code: 0 02:21:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:08 INFO - Reading from file tmpfile_stdout 02:21:08 INFO - Current package versions: 02:21:08 INFO - argparse == 1.2.1 02:21:08 INFO - blessings == 1.6 02:21:08 INFO - blobuploader == 1.2.4 02:21:08 INFO - docopt == 0.6.1 02:21:08 INFO - functools32 == 3.2.3-2 02:21:08 INFO - jsonschema == 2.5.1 02:21:08 INFO - manifestparser == 1.1 02:21:08 INFO - mozInstall == 1.12 02:21:08 INFO - mozcrash == 1.0 02:21:08 INFO - mozdebug == 0.1 02:21:08 INFO - mozdevice == 0.50 02:21:08 INFO - mozfile == 1.2 02:21:08 INFO - mozhttpd == 0.7 02:21:08 INFO - mozinfo == 0.9 02:21:08 INFO - mozleak == 0.1 02:21:08 INFO - mozlog == 3.4 02:21:08 INFO - moznetwork == 0.27 02:21:08 INFO - mozprocess == 0.25 02:21:08 INFO - mozprofile == 0.28 02:21:08 INFO - mozrunner == 6.13 02:21:08 INFO - mozscreenshot == 0.1 02:21:08 INFO - mozsystemmonitor == 0.3 02:21:08 INFO - moztest == 0.8 02:21:08 INFO - mozversion == 1.4 02:21:08 INFO - psutil == 3.1.1 02:21:08 INFO - requests == 1.2.3 02:21:08 INFO - wsgiref == 0.1.2 02:21:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:12 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 0x111b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1213a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, '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': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:21:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:21:12 INFO - Using env: {'DISPLAY': ':0', 02:21:12 INFO - 'HOME': '/home/cltbld', 02:21:12 INFO - 'LANG': 'en_US.UTF-8', 02:21:12 INFO - 'LANGUAGE': 'en_US:en', 02:21:12 INFO - 'LOGNAME': 'cltbld', 02:21:12 INFO - 'MAIL': '/var/mail/cltbld', 02:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:12 INFO - 'MOZ_NO_REMOTE': '1', 02:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:12 INFO - 'NO_EM_RESTART': '1', 02:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:12 INFO - 'PWD': '/builds/slave/test', 02:21:12 INFO - 'SHELL': '/bin/bash', 02:21:12 INFO - 'SHLVL': '1', 02:21:12 INFO - 'TERM': 'linux', 02:21:12 INFO - 'TMOUT': '86400', 02:21:12 INFO - 'USER': 'cltbld', 02:21:12 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:12 INFO - '_': '/tools/buildbot/bin/python'} 02:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:21:12 INFO - Cleaning up... 02:21:12 INFO - Return code: 0 02:21:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x111b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1213a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, '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': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:21:15 INFO - Using env: {'DISPLAY': ':0', 02:21:15 INFO - 'HOME': '/home/cltbld', 02:21:15 INFO - 'LANG': 'en_US.UTF-8', 02:21:15 INFO - 'LANGUAGE': 'en_US:en', 02:21:15 INFO - 'LOGNAME': 'cltbld', 02:21:15 INFO - 'MAIL': '/var/mail/cltbld', 02:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:15 INFO - 'MOZ_NO_REMOTE': '1', 02:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:15 INFO - 'NO_EM_RESTART': '1', 02:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:15 INFO - 'PWD': '/builds/slave/test', 02:21:15 INFO - 'SHELL': '/bin/bash', 02:21:15 INFO - 'SHLVL': '1', 02:21:15 INFO - 'TERM': 'linux', 02:21:15 INFO - 'TMOUT': '86400', 02:21:15 INFO - 'USER': 'cltbld', 02:21:15 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:15 INFO - '_': '/tools/buildbot/bin/python'} 02:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:21:15 INFO - Cleaning up... 02:21:15 INFO - Return code: 0 02:21:15 INFO - Running post-action listener: _resource_record_post_action 02:21:15 INFO - Running post-action listener: _start_resource_monitoring 02:21:15 INFO - Starting resource monitoring. 02:21:15 INFO - [mozharness: 2017-04-10 09:21:15.710707Z] Finished create-virtualenv step (success) 02:21:15 INFO - [mozharness: 2017-04-10 09:21:15.711216Z] Running install step. 02:21:15 INFO - Running pre-action listener: _resource_record_pre_action 02:21:15 INFO - Running main action method: install 02:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:15 INFO - Reading from file tmpfile_stdout 02:21:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:21:16 INFO - Reading from file tmpfile_stdout 02:21:16 INFO - Output received: 02:21:16 INFO - Usage: mozinstall [options] installer 02:21:16 INFO - Options: 02:21:16 INFO - -h, --help show this help message and exit 02:21:16 INFO - -d DEST, --destination=DEST 02:21:16 INFO - Directory to install application into. [default: 02:21:16 INFO - "/builds/slave/test"] 02:21:16 INFO - --app=APP Application being installed. [default: firefox] 02:21:16 INFO - mkdir: /builds/slave/test/build/application 02:21:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:21:30 INFO - Reading from file tmpfile_stdout 02:21:30 INFO - Output received: 02:21:30 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:30 INFO - Running post-action listener: _resource_record_post_action 02:21:30 INFO - [mozharness: 2017-04-10 09:21:30.728614Z] Finished install step (success) 02:21:30 INFO - [mozharness: 2017-04-10 09:21:30.728756Z] Running run-tests step. 02:21:30 INFO - Running pre-action listener: _resource_record_pre_action 02:21:30 INFO - Running main action method: run_tests 02:21:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:30 INFO - Python 2.7.3 02:21:30 INFO - Return code: 0 02:21:30 INFO - grabbing minidump binary from tooltool 02:21: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')]} 02:21:30 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 0x13b6290>, '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 0x13b6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b7040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:21:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:21:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:21:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:30 INFO - Return code: 0 02:21:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:30 INFO - ENV: RUST_BACKTRACE is now 1 02:21:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:21:30 INFO - Using env: {'DISPLAY': ':0', 02:21:30 INFO - 'HOME': '/home/cltbld', 02:21:30 INFO - 'LANG': 'en_US.UTF-8', 02:21:30 INFO - 'LANGUAGE': 'en_US:en', 02:21:30 INFO - 'LOGNAME': 'cltbld', 02:21:30 INFO - 'MAIL': '/var/mail/cltbld', 02:21:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:30 INFO - 'MOZ_NO_REMOTE': '1', 02:21:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:30 INFO - 'NO_EM_RESTART': '1', 02:21:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:30 INFO - 'PWD': '/builds/slave/test', 02:21:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:30 INFO - 'RUST_BACKTRACE': '1', 02:21:30 INFO - 'SHELL': '/bin/bash', 02:21:30 INFO - 'SHLVL': '1', 02:21:30 INFO - 'TERM': 'linux', 02:21:30 INFO - 'TMOUT': '86400', 02:21:30 INFO - 'USER': 'cltbld', 02:21:30 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426', 02:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:30 INFO - '_': '/tools/buildbot/bin/python'} 02:21:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:21:31 INFO - mozversion application_buildid: 20170410083222 02:21:31 INFO - mozversion application_changeset: 50cb1ce431d7d2acb0f483bd77395a3b96068d2c 02:21:31 INFO - mozversion application_display_name: Nightly 02:21:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:31 INFO - mozversion application_name: Firefox 02:21:31 INFO - mozversion application_remotingname: firefox 02:21:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:21:31 INFO - mozversion application_vendor: Mozilla 02:21:31 INFO - mozversion application_version: 55.0a1 02:21:31 INFO - mozversion platform_buildid: 20170410083222 02:21:31 INFO - mozversion platform_changeset: 50cb1ce431d7d2acb0f483bd77395a3b96068d2c 02:21:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:21:31 INFO - mozversion platform_version: 55.0a1 02:21:31 INFO - using testdate: 1491816091 02:21:31 INFO - actual date: 1491816091 02:21:31 INFO - starting webserver on 'localhost:36182' 02:21:31 INFO - SUITE-START | Running 2 tests 02:21:31 INFO - TEST-START | dromaeo_css 02:21:31 INFO - operating with platform_type : linux_ 02:21:31 INFO - Initialising browser for dromaeo_css test... 02:21:31 INFO - TEST-INFO | started process 3481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKNh4bw/profile http://localhost:36182/getInfo.html) 02:21:35 INFO - PID 3481 | __metrics Screen width/height:1600/1200 02:21:35 INFO - PID 3481 | colorDepth:24 02:21:35 INFO - PID 3481 | Browser inner width/height: 1024/697 02:21:35 INFO - PID 3481 | __metrics 02:21:36 INFO - PID 3481 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:21:36 INFO - PID 3481 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:21:38 INFO - TEST-INFO | 3481: exit 0 02:21:38 INFO - Browser initialized. 02:21:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:38 INFO - TEST-INFO | started process 3570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKNh4bw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:50 INFO - PID 3570 | RSS: Main: 154361856 02:21:50 INFO - PID 3570 | 02:24:57 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:36182/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36182/tests/dromaeo/cssquery-ext.html) 02:24:59 INFO - PID 3570 | RSS: Main: 338010112 02:24:59 INFO - PID 3570 | 02:26:39 INFO - PID 3570 | ************************* 02:26:39 INFO - PID 3570 | A coding exception was thrown and uncaught in a Task. 02:26:39 INFO - PID 3570 | 02:26:39 ERROR - PID 3570 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:26:39 INFO - PID 3570 | Full stack: 02:26:39 INFO - PID 3570 | ************************* 02:26:39 INFO - PID 3570 | ************************* 02:26:39 INFO - PID 3570 | A coding exception was thrown and uncaught in a Task. 02:26:39 INFO - PID 3570 | 02:26:39 ERROR - PID 3570 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:26:39 INFO - PID 3570 | Full stack: 02:26:39 INFO - PID 3570 | ************************* 02:26:39 INFO - PID 3570 | ************************* 02:26:39 INFO - PID 3570 | A coding exception was thrown and uncaught in a Task. 02:26:39 INFO - PID 3570 | 02:26:39 ERROR - PID 3570 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:26:39 INFO - PID 3570 | Full stack: 02:26:39 INFO - PID 3570 | ************************* 02:26:39 INFO - PID 3570 | ************************* 02:26:39 INFO - PID 3570 | A coding exception was thrown and uncaught in a Task. 02:26:39 INFO - PID 3570 | 02:26:39 ERROR - PID 3570 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:26:39 INFO - PID 3570 | Full stack: 02:26:39 INFO - PID 3570 | ************************* 02:28:01 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:36182/tests/dromaeo/cssquery-ext.html (next: http://localhost:36182/tests/dromaeo/cssquery-jquery.html) 02:28:02 INFO - PID 3570 | RSS: Main: 236670976 02:28:02 INFO - PID 3570 | 02:31:04 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:36182/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36182/tests/dromaeo/cssquery-mootools.html) 02:31:05 INFO - PID 3570 | RSS: Main: 178270208 02:31:05 INFO - PID 3570 | 02:34:07 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:36182/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36182/tests/dromaeo/cssquery-prototype.html) 02:34:07 INFO - PID 3570 | RSS: Main: 178434048 02:34:07 INFO - PID 3570 | 02:37:10 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:36182/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36182/tests/dromaeo/cssquery-yui.html) 02:37:11 INFO - PID 3570 | RSS: Main: 185933824 02:37:11 INFO - PID 3570 | 02:40:13 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:36182/tests/dromaeo/cssquery-yui.html (next: http://localhost:36182/tests/dromaeo/cssquery-dojo.html) 02:40:13 INFO - PID 3570 | RSS: Main: 271130624 02:40:13 INFO - PID 3570 | 02:40:13 INFO - PID 3570 | __start_tp_report 02:40:13 INFO - PID 3570 | _x_x_mozilla_page_load 02:40:13 INFO - PID 3570 | _x_x_mozilla_page_load_details 02:40:13 INFO - PID 3570 | |i|pagename|runs| 02:40:13 INFO - PID 3570 | |0;dojo.html;2732.535468970275;2760.475509653167;2797.580362945559;2799.5800629905507;2801.1596521043693;5167.9483205167935;5283.920741188886;5298.284731561238;5307.52232299093;5362.6246162768575;5261.815836445725;5286.735663216843;5313.73431328433;5314.521693047625;5327.334083239595;4685.85942421727;4713.410823647044;4738.289256611519;4745.952540474603;4779.928301075469;4737.620990320784;4764.023375208074;4767.046590681877;4781.3784208053075;4786.880327991793;4762.880927976811;4778.832740854071;4779.402574678165;4785.545373189559;4791.28130780384;4751.857444276678;4766.070616229837;4771.069641419925;4773.522647735216;4775.092732380836;4655.767211639404;4675.7895894684825;4738.976305118453;4753.572178503917;4754.072955773626;5271.103912334912;5307.124324486455;5361.705106219157;5369.382521010095;5375.462453754632;5576.972115139439;5736.2542869427125;5753.683547404891;5768.596198266123;5778.219940308089;5774.7112644368035;5780.017397042513;5801.970990145064;5806.738696758656;5869.8239052828485;5393.217983392426;5394.676319420769;5394.78420863169;5400.054990376669;5436.755346009439;5936.168936348915;5944.019236825961;5952.315483719428;5957.940420595825;5958.225430693982;5542.140968149944;5622.57830662702;5626.85932851682;5659.292588426447;5668.744906479218;5729.226554415184;5771.249737534177;5805.912911306334;5807.82576522705;5823.941760582425;5728.198052272685;5739.62692424991;5744.482996530249;5747.6838773867;5747.971260143672;5543.61194716366;5691.544676425876;5736.483716465538;5748.338941021752;5754.971225143931;4691.249400095969;4734.100520901018;4799.0401919616215;4800.159972004885;4803.03939212159;4044.2518134145275;4074.4499492568125;4080.2451546464;4092.0383709828166;4128.02991297045;4899.387576552931;4904.901901961941;4906.975465122651;4910.680805747615;4947.208446648519;5607.719614019283;5663.122216056518;5708.828735137952;5709.8287051388525;5759.222504961776;4868.464468908488;4869.805207791649;4887.0714564232685;4907.1903135982875;4916.188828843272;5078.289039534468;5081.593472522263;5087.669301495391;5097.566706829887;5137.845864624067;5220.660657057279;5357.571394288526;5357.946420535901;5361.5710743141235;5365.517103460707;5717.857053573527;5767.826965191051;5806.390329015392;5811.94188058114;5815.621984570989;5381.381141168816;5382.757775900172;5388.434214407431;5398.676079435247;5398.78404863801;5424.1321388577635;5653.180288858175;5702.116171993348;5707.828765137053;5746.5402767779315;5680.801171958961;5708.686022268815;5735.684537350319;5736.541076713769;5744.655320680772;5519.862003449946;5530.778768849201;5539.695316757617;5545.500904918576;5546.029444847216;5513.751881165277;5572.359178694502;5626.718664066862;5665.12190610456;5665.943340566541;5535.446455354432;5559.388467268678;5566.415526369673;5571.1086226203615;5573.331200255995;5685.943140568541;5686.2607860977805;5687.317521897398;5694.259746232963;5705.686187259575;5387.86530336729;5472.097103977799;5481.013417584873;5482.698451585201;5565.777368905198 02:40:13 INFO - PID 3570 | |1;ext.html;680.1600023970396;702.673256935525;1075.3655343347423;1092.4756117063814;1092.781443711258;31581.684183158162;33079.66920330796;33135.502967455446;33201.501977470354;33235.33529329412;35341.11647208821;35664.28671426576;35814.462783058276;35827.4625880612;35862.46206306901;5484.314460692413;5614.915776263339;7281.963590182055;7402.925970740277;7416.258374162568;6933.0293758873795;7112.4665650076195;7120.964395178017;7131.8217044573785;7135.108111486064;7202.099737532809;7258.564486130849;7259.6370181490975;7262.346388825004;7264.7457338993145;7159.463040271974;7210.423166146696;7212.783616491513;7217.639118044103;7221.675024623904;7327.7435289765135;7366.226546212678;7369.852602947964;7373.631318434057;7386.261373862624;32491.350172996645;32505.51241731376;32716.672833271838;32778.6722132778;32782;3068.9539656905163;3097.4734295169874;3102.90691279262;3103.2552187474844;3112.9844350778326;24456;24490.14284500052;24525.63211551828;24556;24586;3088.768342374331;3094.659587445379;3124.2033281513295;3124.8593813278458;3137.7176054155007;137508.31245843807;138032;138081;138177.3091134548;138205.3089734545;33842.32315353728;34579.48130778041;39445.80277098596;41730.582694173274;41913.37129943053;41787.582124178974;41843.372349414785;41854.11656475405;41855.7907210462;41873.581264187575;12863.22820630765;12994;12995.935020325027;12998.935005324913;13006.089573729938;10363.067323940732;10444.843327350096;10448.111910487694;10452.216083793746;10471.42407167613;11874.168808183516;11875.821862672066;11880.227785193934;11901.880981190077;12073.637790866289;4921.7785199666105;4941.604671626261;4976.975115124401;5025.673331233458;5064.41759197697;873.3580818098692;895.3329769321897;915.1397686174975;918.7978644698289;922.561783152997;20467.385978420672;20729.89635051845;21476.140954361963;24938;25882.65874860671;967.5355829202023;968.5157421289356;991.7966816802539;995.4326034160459;996.2279233594022;10679.519421626046;11492.712682183012;11525.366104864146;11546.307221566733;11547.307161570332;194420;194646;195157;195427;195918;39308.80345598254;39323.213535729126;39332.606673933464;39347.80326098351;39432;1214.6598952293373;1247.6319485751544;1256.6481385212155;1259.5591542960074;1261.060509920097;18974.620507589494;19500.31748888782;20397.38807835767;20542.897285513478;20854.582908341446;29813.850930746074;29815.85092074526;29840.120784297902;29880.85059574688;29891.252718682208;179713;180110;180291;180322;180327;24355.26934191977;25034.123805666713;25049;27565.17304480869;27679.584806227518;29805.10584682463;29938.550921735754;29946;29960.700392996663;32053;25791.484170316115;26365.736342637094;26750.59874101929;26765.86617066902;26937;26176;26285.34286642849;26417.33956651099;26822.463550729266;27300;28788.568171477025;28964;29182.56226156567;29261.414771704873;29269.85365073161;24938;25187.370315742253;25202.74797252004;25651.35871603225;26081.869590651924;20618.175272988912;20898.1640734375;21059;21101.050452729356;21119.683204752248 02:40:13 INFO - PID 3570 | |2;jquery.html;406.7234280689131;408.63835505577555;414.4115356194204;422.21046642778;437.5515097025548;17872.463826085223;18652.813471865295;18653.81346186538;19428.320008799696;20008.599828003433;19390.22439102434;19674;19714.408567742954;19778.30775922843;19898.403047908585;5336.30628018358;5685.118806584986;5736.368999410061;5742.196092547026;5744.396838331978;5604.747786349624;5698.487136157745;5812.564057695668;5817.040188368914;5823.796167134151;5654.208410822488;5753.050746626802;5760.971195144019;5761.135829625548;5762.74067666956;5528.419515950807;5713.171590119409;5738.311402631669;5751.712414379285;5755.539556835464;5196.636235463519;5211.374635043781;5211.843644690665;5213.452587478336;5216.191490319006;22335.776642233533;22554.43613909649;23018.88490557553;23019.07923683051;23203.767962320497;1652.0913497576405;1674.9832501674948;1696.4062578097692;1699.3712326439172;1701.276957293158;15083;15301.234938253043;15500;15561.533154005398;15635.765463518057;2091.5084955035554;2140.176032227588;2182.7598964114095;2184.388371256051;2198.043850924853;92606.53696731474;94782;95300;95495.52252238763;96971.51514242454;10923.617673381394;11098.944505277583;11257.43712814356;11367.09063274936;11450.141239407078;16076.186667333404;16094.678106437806;16116.35534578627;16123.11322877253;16150.75773863393;7846;7885;8072.596370181467;8192.75421737349;8201.753947381589;7299.379552738077;7364.5581265124265;7419.703211871465;7611.3530349919765;7616.466847320745;7043.823904402431;7095.574265544084;7171.282871712787;7189.281071892873;7253.165885923081;2008.3272103845375;2039.2149022626395;2059.567490826913;2108.768035516092;2146.796054374832;819.8770184472257;867.5228624256633;872.82543491302;881.6517475597103;890.2077151335317;17279.65440691179;17306.740398894028;17565.385211517536;18075.36736214226;20467.59064818725;887.7248053103558;896.6323807239;896.6413434626071;897.1970086772302;915.2769312243387;9432.62269509212;9927.2058235341;9938.354006989523;9953.402795832273;10005.349652272724;509518;523527;536188;549532;564010;74470.62764686142;83485;86440;95407.52296238474;99834.5008274954;1080.6649938519083;1112.9944350278358;1116.5087361560886;1122.6968718445974;1130.496928866663;17780.55548611295;18076.548086297422;18488.260469581066;18673.346432874783;18752.343667971556;42626.93432664084;44190;44657.55342446664;44947.550524494334;45418.54581454143;56330.155047675136;56896;57540;57749;58993.705031474565;7920.762600423924;7967.521948683097;8000.83998320042;8105.148959359182;8274.048484424127;12459.252444852975;12878.67803304925;12949.604323199861;13156.710822294426;13209.471621135432;10139.797204056025;10213.693589192337;10468.895311046792;11026.614068507564;11080.445977700922;10032.046955539212;10126.696199114038;10555.894441055798;10569.524371403459;10755.08581770527;10702.73243168927;10728.302660327054;10846.240763146505;10893.836592451278;11404.48679809394;7924.167962364099;7998;8137.226963438464;8196.42625016243;8280.296174825207;10558.577656893945;10593;10598.364098154136;10714.410707411167;10934.72663183395 02:40:13 INFO - PID 3570 | |3;mootools.html;1269.0989397527756;1350.5678182981444;1352.9458821647129;1358.239385943871;1361.7616917039522;9287.860682089766;9681.370710903786;9683.370580912237;9706.611735530589;9709.320347575673;9363.578638961262;9950.402975821456;10352.275340726152;10371.325863818847;10377;2283.303592404316;2330.580495510816;2334.206369834256;2334.754850740673;2336.5910965581043;1891.1111777464569;2141.6573348264283;2261.276391554703;2263.196565219348;2273.727152741665;1821.9432729017137;2191.4521369657587;2269.251147121446;2272.988635056822;2274;2122.957540849174;2148.5058436559602;2154.9030293636747;2157.1910533549917;2160.3518944316643;2164.1127137873555;2170.9891450542805;2174.3368272676826;2176.5102851858364;2177.412098733349;9845.064718851698;10031.047050530187;10056.94971525145;10059.597616095347;10064.144547713453;5701.657900525982;5965.194698715704;5968.552358573124;5973.1936188614845;5983.371745966654;3360.714339281164;3447.2249838879693;3528.3825330567306;3557.4485954677066;3620.583632882226;1045.5086109528509;1062.3944351719524;1092.8688557373086;1101.862267216598;1119.8432219489277;15113.848861511464;15267.083974961537;15284.541463756104;15285.235738213045;15481.225938703132;4738.099761045391;4820.118756549118;4915.48387419323;4974.129527332775;5051.3433253676785;10758;10758.56965721378;10770.838437423445;10772;10777.730556736144;5560.7219639017885;5644.153376993402;5662.320521537442;5670.432956704297;5672.631278966854;5041.621878359138;5060.165072763027;5091.1854103343285;5126.487351264844;5146.639735218499;3646.726495512847;3731.160488889978;3766.7551609145316;3788.981055094707;3823.636754508317;1163.4589915689246;1168.9590864319707;1175.3359351966112;1188.988110118905;1200.1359021504502;620.3021600699213;626.837022374186;710.6553321639001;714.1501613080418;718.2171433137801;5724.8282551523525;5740.54075673945;5816.854578635568;5885.882282354329;5893.14549390336;811.3225456743567;827.5407149032345;834.1575009240711;836.7782537627534;852.8251708399763;3854.9614503855164;3858.1897801462005;3864.1305706215876;3871.1676989447406;3966.9206615868097;12023.338716370683;12971.610851674464;13037.217766934014;13054.282014489105;13059.08586398962;12697.873021269854;12939.353032348345;12943.158694684815;13089.149205301625;13089.214647121204;9790.902090979283;9810.362326448758;9872.074945385724;9890.109890109925;9999.200063994864;5586.888262234814;5664.660120392789;5709.000924838219;5731.168980497721;5964.5526585505395;12078.577249796215;12155.574554890536;12276.324802135969;12282.447289871798;12286.262824230575;12405.503779848705;12630.3684815757;12651.367431628198;12698.936505317415;12715.80926286088;7623.771286861403;7830.177831327856;7830.725924592612;7831.765047048598;7834.099078606033;9192.54037298119;9305.534723263945;9310.441373517611;9310.81195918945;9407.85888211691;8267.173282671925;8274.875876861732;8300.70947516834;8372.790680233044;8398.286145677686;8030.397720171128;8144.67421303165;8161.387895907949;8180.67277308901;8356.791080223044;7419.109706835215;7432.777016689508;7495.8500829982;7505.286997735207;7509.286617771303;5243.8164664236565;5299.5760339172;5309.946900530946;5403.297571315704;5531.253280807039;5526.309211348582;5551.611387202857;5587.161925711176;5589.105743081088;5706.400827913009 02:40:13 INFO - PID 3570 | |4;prototype.html;367.4763462066554;371.7230663155949;373.441704651546;395.2627903175475;399.49264434168606;5189.844304670856;5196.246544251081;5251.947480525194;5262.289755829362;5273.604479664022;4840.806367745286;5124.538791508763;5126.5642420394215;5151.562117220032;5155.432902380735;3917.6082391760738;3956.1494278730065;3969.027588240885;3973.7019723520707;3981.9203615927663;3966.0877998060464;3973.569514974607;3974.940375894364;3981.781002044901;3986.840526378956;3939.212157568498;3940.034691500586;3941.3299739044432;3965.821538030781;3972.880813575597;3883.98058009711;3913.4129880517867;3922.7057970652313;3953.6639385652256;3975.2447035063246;3473.70473509752;3485;3488.127968007998;3488.9127771805656;3504.6320136385566;4972.682239206613;4974.676646017997;4974.825881094144;4984.177610694231;5014.548690617826;4545.613622842063;4647.419072615923;4655.185342565038;4674.644353137586;4680.485146633868;5411.864703382447;5413.756380962866;5419.078756611386;5431.918521222185;5437.809676661298;3907.5310962684375;3911.5306163260307;3927.175293188434;3942.2903877302074;3944.704147188944;5058.924116138261;5396.43337449566;5696.401877802812;5767.711614419262;5790.160426738142;3894.552126505488;3945.2109578084496;3949.763014219156;3993.560708322082;4005.619466150711;4056.452378928866;4059.2693315203546;4066.4510291110914;4074.9388759168637;4086.8569600063856;4616.976915115403;4617.168909596305;4620.861374158781;4626.444826620827;4641.2109941310055;5267.631265811433;5411.053065713484;5429.728513574384;5456.590755693339;5465.644733092416;1381.7996390523317;1382.4124746982693;1385.3142694366354;1386.8405133409585;1386.9944290389387;923.5751554284969;952.9285303602257;966.8549717542285;970.0638883477478;972.1348000279756;4784.64115191362;4785.612172470014;4799.928001079987;4806.206975849016;4817;5579.860503487445;5624.634398764068;5631.577631677641;5645.491905728504;5654.3497497788285;4591.724496530219;4772;4789.257665061921;4802.351682522884;4805.423349198119;2958.082994271783;2973.241823335036;2974.3159073412803;2992.38656075504;2996.3258266889775;5292.5236728693835;5300.12547929595;5302.144249512717;5318.308619879468;5327.0411325961695;5538.0585300499015;5640.943590564124;5737.340205876294;5786.189933409326;5802.79690210849;5147.40804807452;5202.453742356998;5293.232481290268;5300.2049692546425;5315.468453154808;5670.858228544154;5673.77304907799;5683.886322273449;5696.174054762119;5704.258446401941;5473.28847249855;5532.557395408438;5535.944640553543;5537.612367134262;5547.278853748987;5291.285676433632;5311.123664595299;5316.548093412103;5324.840254792362;5330.200469929387;3935.3900145477496;3949.4470774092224;3954;3956.643902048829;3959.069618639675;5481.051308148275;5649.322081350264;5682;5692.0608099663095;5694.373618902;5444.727763611724;5459.478636279657;5485.561155107502;5490.1764735288425;5494.230807686847;5361.898207713688;5462.972685136708;5466.5900057495055;5505.146702261156;5505.834824955257;5312.468753124811;5324.201369794562;5388.488093631099;5396.217548455374;5405.702686352289;5462.754176062007;5465.590080744039;5489.835304940858;5490.972545137249;5515.448455154453;5170.767315470888;5311.7609707564025;5332.5467335276935;5350.678959262456;5377.08589539787 02:40:13 INFO - PID 3570 | |5;yui.html;645.303072681504;748.7529115391919;761.7486229544247;768.9923100768995;775.402939736403;10590;15368.61578460539;16265.51203463895;16303.59241018975;16322.673546529077;15600.06399616024;15789.684206315895;15791.921040394782;15801.60495987601;15805.446809361674;638.0747915522488;653.2813904704834;897.6813231302875;925.1488630459959;929.4980710416366;892.0945240580816;915.7161280003187;918.3800934369308;921.1479381572052;921.5806807902388;960.875086238788;965.6137544981993;966.8066386722684;966.9951650241738;967.9370840895355;665.424407887179;962.4898803634085;964.9710508684681;965.8261512927635;965.8551217317388;500.3395517916352;679.4632240529976;695.2699665351361;706.0397858911875;706.1385110165589;14105.717885642229;14227.288635568284;14243.216623085726;14275.928620356832;14287.57137285883;14225.715485690229;15303;15386.0768353898;15392.30734616945;15436.459723909722;11815.113866459964;12187.634370968797;12356.938215308955;12358.567450139291;12363;2887.3503461721157;2913.3590610065753;2914.825110493377;2915.300327921305;2919.8540072996266;66401.66799165973;66534.3346566533;66701;67499.66250168766;67760;9993.850092248622;10352.06831385164;10377.9481102594;10394.584216631401;10622;16108.838911610968;16673;17738.645227095385;21383.78616213849;21722.674159887614;7333.559986400833;7340.596267205248;7502.58735769527;7539.886901696479;7551.395888329031;3779.0174554615446;3835.5972622874756;3840.1551658635058;3847.3459511883048;3850.8074596270076;3470.4447288434235;3593.94609080864;3595.424732042861;3598.2623562169692;3611.5846677632408;719.4208662027014;728.2026181331433;729.5075823819008;730.3244498838553;730.747891977267;592.8547505861092;608.7960533221332;609.8018144103185;609.9542534309944;627.1877918095986;9474.478903660365;9838.508074596384;9890.950545247228;9938.304318697767;10086.899131008742;588.0502987674874;594.1622312539386;596.9134475501028;598.9730462129214;614.7233744814852;4536.002079542495;4579.015511665008;4591.79336929839;4617.399738034034;4623.884402889955;65696.6715166421;66383.33616663772;66634.66682666652;66980;68144;53865.1920221197;55077.72461137669;60015.399846001856;61408.38591614116;64059;48046.75976620164;48147;48576.27135592969;49016.75491622519;50727.239091413656;9987.350822196535;10242.560838785776;10600.946995264974;10763.569457221623;10804.135669146292;26362.209133726017;26467.60298595561;26812.463750725266;26907.730922690524;27036.864815675795;41169.58830411657;44090.33864491971;45119;45707.31439028484;46537;12883.162594431333;13131.277779721824;13157.934210328887;13161;13273.402696878471;13232.338383081;13470;13495.59513214605;14222.217778022308;14822.703545929236;12810.487580496676;12927.870721292667;12937.094403391673;14121.858781412055;15044.473443429428;13359;13653.453861845812;13723.313834308045;13800.86199138036;14442.711145777235;13004.050750901297;14098.083624564371;14100.788488172891;14145.434182632991;14240.715185696436;9117.817643647222;9376.156145946898;9531.761705957406;9692.41845489273;9766.07222313879;10504.842427363443;10757.623483178051;11035.11719062457;11080.778384432428;11166.72083197894 02:40:13 INFO - PID 3570 | __end_tp_report 02:40:13 INFO - PID 3570 | __start_cc_report 02:40:13 INFO - PID 3570 | _x_x_mozilla_cycle_collect,1958 02:40:13 INFO - PID 3570 | __end_cc_report 02:40:13 INFO - PID 3570 | __startTimestamp1491817213957__endTimestamp 02:40:13 INFO - PID 3570 | 02:40:13 INFO - PID 3570 | ------- Summary: start ------- 02:40:13 INFO - PID 3570 | Number of tests: 6 02:40:13 INFO - PID 3570 | 02:40:13 INFO - PID 3570 | [#0] dojo.html Cycles:165 Average:5254.06 Median:5398.68 stddev:620.64 (11.5%) stddev-sans-first:590.18 02:40:13 INFO - PID 3570 | Values: 2732.5 2760.5 2797.6 2799.6 2801.2 5167.9 5283.9 5298.3 5307.5 5362.6 5261.8 5286.7 5313.7 5314.5 5327.3 4685.9 4713.4 4738.3 4746.0 4779.9 4737.6 4764.0 4767.0 4781.4 4786.9 4762.9 4778.8 4779.4 4785.5 4791.3 4751.9 4766.1 4771.1 4773.5 4775.1 4655.8 4675.8 4739.0 4753.6 4754.1 5271.1 5307.1 5361.7 5369.4 5375.5 5577.0 5736.3 5753.7 5768.6 5778.2 5774.7 5780.0 5802.0 5806.7 5869.8 5393.2 5394.7 5394.8 5400.1 5436.8 5936.2 5944.0 5952.3 5957.9 5958.2 5542.1 5622.6 5626.9 5659.3 5668.7 5729.2 5771.2 5805.9 5807.8 5823.9 5728.2 5739.6 5744.5 5747.7 5748.0 5543.6 5691.5 5736.5 5748.3 5755.0 4691.2 4734.1 4799.0 4800.2 4803.0 4044.3 4074.4 4080.2 4092.0 4128.0 4899.4 4904.9 4907.0 4910.7 4947.2 5607.7 5663.1 5708.8 5709.8 5759.2 4868.5 4869.8 4887.1 4907.2 4916.2 5078.3 5081.6 5087.7 5097.6 5137.8 5220.7 5357.6 5357.9 5361.6 5365.5 5717.9 5767.8 5806.4 5811.9 5815.6 5381.4 5382.8 5388.4 5398.7 5398.8 5424.1 5653.2 5702.1 5707.8 5746.5 5680.8 5708.7 5735.7 5736.5 5744.7 5519.9 5530.8 5539.7 5545.5 5546.0 5513.8 5572.4 5626.7 5665.1 5665.9 5535.4 5559.4 5566.4 5571.1 5573.3 5685.9 5686.3 5687.3 5694.3 5705.7 5387.9 5472.1 5481.0 5482.7 5565.8 02:40:13 INFO - PID 3570 | 02:40:13 INFO - PID 3570 | [#1] ext.html Cycles:180 Average:30929.11 Median:29827.99 stddev:44700.87 (149.9%) stddev-sans-first:44768.57 02:40:13 INFO - PID 3570 | Values: 680.2 702.7 1075.4 1092.5 1092.8 31581.7 33079.7 33135.5 33201.5 33235.3 35341.1 35664.3 35814.5 35827.5 35862.5 5484.3 5614.9 7282.0 7402.9 7416.3 6933.0 7112.5 7121.0 7131.8 7135.1 7202.1 7258.6 7259.6 7262.3 7264.7 7159.5 7210.4 7212.8 7217.6 7221.7 7327.7 7366.2 7369.9 7373.6 7386.3 32491.4 32505.5 32716.7 32778.7 32782.0 3069.0 3097.5 3102.9 3103.3 3113.0 24456.0 24490.1 24525.6 24556.0 24586.0 3088.8 3094.7 3124.2 3124.9 3137.7 137508.3 138032.0 138081.0 138177.3 138205.3 33842.3 34579.5 39445.8 41730.6 41913.4 41787.6 41843.4 41854.1 41855.8 41873.6 12863.2 12994.0 12995.9 12998.9 13006.1 10363.1 10444.8 10448.1 10452.2 10471.4 11874.2 11875.8 11880.2 11901.9 12073.6 4921.8 4941.6 4977.0 5025.7 5064.4 873.4 895.3 915.1 918.8 922.6 20467.4 20729.9 21476.1 24938.0 25882.7 967.5 968.5 991.8 995.4 996.2 10679.5 11492.7 11525.4 11546.3 11547.3 194420.0 194646.0 195157.0 195427.0 195918.0 39308.8 39323.2 39332.6 39347.8 39432.0 1214.7 1247.6 1256.6 1259.6 1261.1 18974.6 19500.3 20397.4 20542.9 20854.6 29813.9 29815.9 29840.1 29880.9 29891.3 179713.0 180110.0 180291.0 180322.0 180327.0 24355.3 25034.1 25049.0 27565.2 27679.6 29805.1 29938.6 29946.0 29960.7 32053.0 25791.5 26365.7 26750.6 26765.9 26937.0 26176.0 26285.3 26417.3 26822.5 27300.0 28788.6 28964.0 29182.6 29261.4 29269.9 24938.0 25187.4 25202.7 25651.4 26081.9 20618.2 20898.2 21059.0 21101.1 21119.7 02:40:13 INFO - PID 3570 | 02:40:13 INFO - PID 3570 | [#2] jquery.html Cycles:180 Average:30653.00 Median:21532.24 stddev:88485.40 (410.9%) stddev-sans-first:88704.48 02:40:13 INFO - PID 3570 | Values: 406.7 408.6 414.4 422.2 437.6 17872.5 18652.8 18653.8 19428.3 20008.6 19390.2 19674.0 19714.4 19778.3 19898.4 5336.3 5685.1 5736.4 5742.2 5744.4 5604.7 5698.5 5812.6 5817.0 5823.8 5654.2 5753.1 5761.0 5761.1 5762.7 5528.4 5713.2 5738.3 5751.7 5755.5 5196.6 5211.4 5211.8 5213.5 5216.2 22335.8 22554.4 23018.9 23019.1 23203.8 1652.1 1675.0 1696.4 1699.4 1701.3 15083.0 15301.2 15500.0 15561.5 15635.8 2091.5 2140.2 2182.8 2184.4 2198.0 92606.5 94782.0 95300.0 95495.5 96971.5 10923.6 11098.9 11257.4 11367.1 11450.1 16076.2 16094.7 16116.4 16123.1 16150.8 7846.0 7885.0 8072.6 8192.8 8201.8 7299.4 7364.6 7419.7 7611.4 7616.5 7043.8 7095.6 7171.3 7189.3 7253.2 2008.3 2039.2 2059.6 2108.8 2146.8 819.9 867.5 872.8 881.7 890.2 17279.7 17306.7 17565.4 18075.4 20467.6 887.7 896.6 896.6 897.2 915.3 9432.6 9927.2 9938.4 9953.4 10005.3 509518.0 523527.0 536188.0 549532.0 564010.0 74470.6 83485.0 86440.0 95407.5 99834.5 1080.7 1113.0 1116.5 1122.7 1130.5 17780.6 18076.5 18488.3 18673.3 18752.3 42626.9 44190.0 44657.6 44947.6 45418.5 56330.2 56896.0 57540.0 57749.0 58993.7 7920.8 7967.5 8000.8 8105.1 8274.0 12459.3 12878.7 12949.6 13156.7 13209.5 10139.8 10213.7 10468.9 11026.6 11080.4 10032.0 10126.7 10555.9 10569.5 10755.1 10702.7 10728.3 10846.2 10893.8 11404.5 7924.2 7998.0 8137.2 8196.4 8280.3 10558.6 10593.0 10598.4 10714.4 10934.7 02:40:13 INFO - PID 3570 | 02:40:13 INFO - PID 3570 | [#3] mootools.html Cycles:180 Average:6349.76 Median:3919.04 stddev:4042.30 (103.1%) stddev-sans-first:4035.61 02:40:13 INFO - PID 3570 | Values: 1269.1 1350.6 1352.9 1358.2 1361.8 9287.9 9681.4 9683.4 9706.6 9709.3 9363.6 9950.4 10352.3 10371.3 10377.0 2283.3 2330.6 2334.2 2334.8 2336.6 1891.1 2141.7 2261.3 2263.2 2273.7 1821.9 2191.5 2269.3 2273.0 2274.0 2123.0 2148.5 2154.9 2157.2 2160.4 2164.1 2171.0 2174.3 2176.5 2177.4 9845.1 10031.0 10056.9 10059.6 10064.1 5701.7 5965.2 5968.6 5973.2 5983.4 3360.7 3447.2 3528.4 3557.4 3620.6 1045.5 1062.4 1092.9 1101.9 1119.8 15113.8 15267.1 15284.5 15285.2 15481.2 4738.1 4820.1 4915.5 4974.1 5051.3 10758.0 10758.6 10770.8 10772.0 10777.7 5560.7 5644.2 5662.3 5670.4 5672.6 5041.6 5060.2 5091.2 5126.5 5146.6 3646.7 3731.2 3766.8 3789.0 3823.6 1163.5 1169.0 1175.3 1189.0 1200.1 620.3 626.8 710.7 714.2 718.2 5724.8 5740.5 5816.9 5885.9 5893.1 811.3 827.5 834.2 836.8 852.8 3855.0 3858.2 3864.1 3871.2 3966.9 12023.3 12971.6 13037.2 13054.3 13059.1 12697.9 12939.4 12943.2 13089.1 13089.2 9790.9 9810.4 9872.1 9890.1 9999.2 5586.9 5664.7 5709.0 5731.2 5964.6 12078.6 12155.6 12276.3 12282.4 12286.3 12405.5 12630.4 12651.4 12698.9 12715.8 7623.8 7830.2 7830.7 7831.8 7834.1 9192.5 9305.5 9310.4 9310.8 9407.9 8267.2 8274.9 8300.7 8372.8 8398.3 8030.4 8144.7 8161.4 8180.7 8356.8 7419.1 7432.8 7495.9 7505.3 7509.3 5243.8 5299.6 5309.9 5403.3 5531.3 5526.3 5551.6 5587.2 5589.1 5706.4 02:40:13 INFO - PID 3570 | 02:40:13 INFO - PID 3570 | [#4] prototype.html Cycles:180 Average:4515.17 Median:5153.50 stddev:1312.28 (25.5%) stddev-sans-first:1278.51 02:40:13 INFO - PID 3570 | Values: 367.5 371.7 373.4 395.3 399.5 5189.8 5196.2 5251.9 5262.3 5273.6 4840.8 5124.5 5126.6 5151.6 5155.4 3917.6 3956.1 3969.0 3973.7 3981.9 3966.1 3973.6 3974.9 3981.8 3986.8 3939.2 3940.0 3941.3 3965.8 3972.9 3884.0 3913.4 3922.7 3953.7 3975.2 3473.7 3485.0 3488.1 3488.9 3504.6 4972.7 4974.7 4974.8 4984.2 5014.5 4545.6 4647.4 4655.2 4674.6 4680.5 5411.9 5413.8 5419.1 5431.9 5437.8 3907.5 3911.5 3927.2 3942.3 3944.7 5058.9 5396.4 5696.4 5767.7 5790.2 3894.6 3945.2 3949.8 3993.6 4005.6 4056.5 4059.3 4066.5 4074.9 4086.9 4617.0 4617.2 4620.9 4626.4 4641.2 5267.6 5411.1 5429.7 5456.6 5465.6 1381.8 1382.4 1385.3 1386.8 1387.0 923.6 952.9 966.9 970.1 972.1 4784.6 4785.6 4799.9 4806.2 4817.0 5579.9 5624.6 5631.6 5645.5 5654.3 4591.7 4772.0 4789.3 4802.4 4805.4 2958.1 2973.2 2974.3 2992.4 2996.3 5292.5 5300.1 5302.1 5318.3 5327.0 5538.1 5640.9 5737.3 5786.2 5802.8 5147.4 5202.5 5293.2 5300.2 5315.5 5670.9 5673.8 5683.9 5696.2 5704.3 5473.3 5532.6 5535.9 5537.6 5547.3 5291.3 5311.1 5316.5 5324.8 5330.2 3935.4 3949.4 3954.0 3956.6 3959.1 5481.1 5649.3 5682.0 5692.1 5694.4 5444.7 5459.5 5485.6 5490.2 5494.2 5361.9 5463.0 5466.6 5505.1 5505.8 5312.5 5324.2 5388.5 5396.2 5405.7 5462.8 5465.6 5489.8 5491.0 5515.4 5170.8 5311.8 5332.5 5350.7 5377.1 02:40:13 INFO - PID 3570 | 02:40:13 INFO - PID 3570 | [#5] yui.html Cycles:180 Average:15345.53 Median:44604.67 stddev:18332.84 (41.1%) stddev-sans-first:18351.03 02:40:13 INFO - PID 3570 | Values: 645.3 748.8 761.7 769.0 775.4 10590.0 15368.6 16265.5 16303.6 16322.7 15600.1 15789.7 15791.9 15801.6 15805.4 638.1 653.3 897.7 925.1 929.5 892.1 915.7 918.4 921.1 921.6 960.9 965.6 966.8 967.0 967.9 665.4 962.5 965.0 965.8 965.9 500.3 679.5 695.3 706.0 706.1 14105.7 14227.3 14243.2 14275.9 14287.6 14225.7 15303.0 15386.1 15392.3 15436.5 11815.1 12187.6 12356.9 12358.6 12363.0 2887.4 2913.4 2914.8 2915.3 2919.9 66401.7 66534.3 66701.0 67499.7 67760.0 9993.9 10352.1 10377.9 10394.6 10622.0 16108.8 16673.0 17738.6 21383.8 21722.7 7333.6 7340.6 7502.6 7539.9 7551.4 3779.0 3835.6 3840.2 3847.3 3850.8 3470.4 3593.9 3595.4 3598.3 3611.6 719.4 728.2 729.5 730.3 730.7 592.9 608.8 609.8 610.0 627.2 9474.5 9838.5 9891.0 9938.3 10086.9 588.1 594.2 596.9 599.0 614.7 4536.0 4579.0 4591.8 4617.4 4623.9 65696.7 66383.3 66634.7 66980.0 68144.0 53865.2 55077.7 60015.4 61408.4 64059.0 48046.8 48147.0 48576.3 49016.8 50727.2 9987.4 10242.6 10600.9 10763.6 10804.1 26362.2 26467.6 26812.5 26907.7 27036.9 41169.6 44090.3 45119.0 45707.3 46537.0 12883.2 13131.3 13157.9 13161.0 13273.4 13232.3 13470.0 13495.6 14222.2 14822.7 12810.5 12927.9 12937.1 14121.9 15044.5 13359.0 13653.5 13723.3 13800.9 14442.7 13004.1 14098.1 14100.8 14145.4 14240.7 9117.8 9376.2 9531.8 9692.4 9766.1 10504.8 10757.6 11035.1 11080.8 11166.7 02:40:13 INFO - PID 3570 | -------- Summary: end -------- 02:40:13 INFO - PID 3570 | 02:40:14 INFO - TEST-INFO | 3570: exit 0 02:40:14 INFO - TEST-OK | dromaeo_css | took 1123805ms 02:40:14 INFO - TEST-START | kraken 02:40:14 INFO - operating with platform_type : linux_ 02:40:14 INFO - Initialising browser for kraken test... 02:40:14 INFO - TEST-INFO | started process 3893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHaYGIV/profile http://localhost:36182/getInfo.html) 02:40:19 INFO - PID 3893 | __metrics Screen width/height:1600/1200 02:40:19 INFO - PID 3893 | colorDepth:24 02:40:19 INFO - PID 3893 | Browser inner width/height: 1024/697 02:40:19 INFO - PID 3893 | __metrics 02:40:20 INFO - PID 3893 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:40:20 INFO - PID 3893 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:40:21 INFO - TEST-INFO | 3893: exit 0 02:40:21 INFO - Browser initialized. 02:40:21 INFO - Running cycle 1/1 for kraken test... 02:40:21 INFO - TEST-INFO | started process 3986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHaYGIV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:34 INFO - PID 3986 | RSS: Main: 153620480 02:40:34 INFO - PID 3986 | 02:40:36 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36182/tests/kraken/driver.html?testName=audio-beat-detection) 02:40:37 INFO - PID 3986 | RSS: Main: 209149952 02:40:37 INFO - PID 3986 | 02:40:40 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36182/tests/kraken/driver.html?testName=audio-dft) 02:40:41 INFO - PID 3986 | RSS: Main: 188059648 02:40:41 INFO - PID 3986 | 02:40:44 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36182/tests/kraken/driver.html?testName=audio-fft) 02:40:44 INFO - PID 3986 | RSS: Main: 270946304 02:40:44 INFO - PID 3986 | 02:40:47 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36182/tests/kraken/driver.html?testName=audio-oscillator) 02:40:47 INFO - PID 3986 | RSS: Main: 181276672 02:40:47 INFO - PID 3986 | 02:40:49 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36182/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:50 INFO - PID 3986 | RSS: Main: 184729600 02:40:50 INFO - PID 3986 | 02:40:53 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36182/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:54 INFO - PID 3986 | RSS: Main: 224219136 02:40:54 INFO - PID 3986 | 02:40:57 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36182/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:58 INFO - PID 3986 | RSS: Main: 218796032 02:40:58 INFO - PID 3986 | 02:41:01 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36182/tests/kraken/driver.html?testName=json-parse-financial) 02:41:02 INFO - PID 3986 | RSS: Main: 221147136 02:41:02 INFO - PID 3986 | 02:41:03 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36182/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:41:04 INFO - PID 3986 | RSS: Main: 184717312 02:41:04 INFO - PID 3986 | 02:41:06 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36182/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:41:06 INFO - PID 3986 | RSS: Main: 191397888 02:41:06 INFO - PID 3986 | 02:41:08 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36182/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:41:09 INFO - PID 3986 | RSS: Main: 200552448 02:41:09 INFO - PID 3986 | 02:41:12 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:41:13 INFO - PID 3986 | RSS: Main: 209739776 02:41:13 INFO - PID 3986 | 02:41:16 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:41:17 INFO - PID 3986 | RSS: Main: 206610432 02:41:17 INFO - PID 3986 | 02:41:18 INFO - PID 3986 | Cycle 1(1): loaded http://localhost:36182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36182/tests/kraken/driver.html?testName=ai-astar) 02:41:19 INFO - PID 3986 | RSS: Main: 275050496 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | __start_tp_report 02:41:19 INFO - PID 3986 | _x_x_mozilla_page_load 02:41:19 INFO - PID 3986 | _x_x_mozilla_page_load_details 02:41:19 INFO - PID 3986 | |i|pagename|runs| 02:41:19 INFO - PID 3986 | |0;ai-astar;104;111;113;113;112;113;112;113;112;112 02:41:19 INFO - PID 3986 | |1;audio-beat-detection;151;125;128;174;130;126;131;129;154;126 02:41:19 INFO - PID 3986 | |2;audio-dft;165;164;164;166;165;165;166;166;165;164 02:41:19 INFO - PID 3986 | |3;audio-fft;75;76;76;116;77;76;75;80;91;82 02:41:19 INFO - PID 3986 | |4;audio-oscillator;85;85;114;85;85;85;104;84;84;112 02:41:19 INFO - PID 3986 | |5;imaging-gaussian-blur;114;114;114;114;115;114;114;113;114;114 02:41:19 INFO - PID 3986 | |6;imaging-darkroom;152;152;150;151;150;152;151;152;150;150 02:41:19 INFO - PID 3986 | |7;imaging-desaturate;94;94;95;95;95;95;95;94;95;94 02:41:19 INFO - PID 3986 | |8;json-parse-financial;55;54;54;53;55;57;55;55;55;55 02:41:19 INFO - PID 3986 | |9;json-stringify-tinderbox;56;56;56;56;57;56;57;57;56;57 02:41:19 INFO - PID 3986 | |10;stanford-crypto-aes;86;85;87;87;87;85;89;85;89;85 02:41:19 INFO - PID 3986 | |11;stanford-crypto-ccm;139;138;146;145;156;134;143;135;183;138 02:41:19 INFO - PID 3986 | |12;stanford-crypto-pbkdf2;198;197;195;194;194;194;194;196;192;192 02:41:19 INFO - PID 3986 | |13;stanford-crypto-sha256-iterative;72;70;72;72;69;71;70;74;72;70 02:41:19 INFO - PID 3986 | __end_tp_report 02:41:19 INFO - PID 3986 | __start_cc_report 02:41:19 INFO - PID 3986 | _x_x_mozilla_cycle_collect,1971 02:41:19 INFO - PID 3986 | __end_cc_report 02:41:19 INFO - PID 3986 | __startTimestamp1491817279029__endTimestamp 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | ------- Summary: start ------- 02:41:19 INFO - PID 3986 | Number of tests: 14 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:2.72 (2.4%) stddev-sans-first:0.71 02:41:19 INFO - PID 3986 | Values: 104.0 111.0 113.0 113.0 112.0 113.0 112.0 113.0 112.0 112.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:130.50 stddev:16.56 (12.7%) stddev-sans-first:16.82 02:41:19 INFO - PID 3986 | Values: 151.0 125.0 128.0 174.0 130.0 126.0 131.0 129.0 154.0 126.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 02:41:19 INFO - PID 3986 | Values: 165.0 164.0 164.0 166.0 165.0 165.0 166.0 166.0 165.0 164.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:12.78 (16.7%) stddev-sans-first:13.27 02:41:19 INFO - PID 3986 | Values: 75.0 76.0 76.0 116.0 77.0 76.0 75.0 80.0 91.0 82.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:85.00 stddev:12.47 (14.7%) stddev-sans-first:12.95 02:41:19 INFO - PID 3986 | Values: 85.0 85.0 114.0 85.0 85.0 85.0 104.0 84.0 84.0 112.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 02:41:19 INFO - PID 3986 | Values: 114.0 114.0 114.0 114.0 115.0 114.0 114.0 113.0 114.0 114.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 02:41:19 INFO - PID 3986 | Values: 152.0 152.0 150.0 151.0 150.0 152.0 151.0 152.0 150.0 150.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:41:19 INFO - PID 3986 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:1.09 02:41:19 INFO - PID 3986 | Values: 55.0 54.0 54.0 53.0 55.0 57.0 55.0 55.0 55.0 55.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 02:41:19 INFO - PID 3986 | Values: 56.0 56.0 56.0 56.0 57.0 56.0 57.0 57.0 56.0 57.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:1.58 (1.8%) stddev-sans-first:1.67 02:41:19 INFO - PID 3986 | Values: 86.0 85.0 87.0 87.0 87.0 85.0 89.0 85.0 89.0 85.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:144.00 stddev:14.61 (10.1%) stddev-sans-first:15.29 02:41:19 INFO - PID 3986 | Values: 139.0 138.0 146.0 145.0 156.0 134.0 143.0 135.0 183.0 138.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.60 Median:194.50 stddev:1.96 (1.0%) stddev-sans-first:1.64 02:41:19 INFO - PID 3986 | Values: 198.0 197.0 195.0 194.0 194.0 194.0 194.0 196.0 192.0 192.0 02:41:19 INFO - PID 3986 | 02:41:19 INFO - PID 3986 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:72.00 stddev:1.48 (2.0%) stddev-sans-first:1.54 02:41:19 INFO - PID 3986 | Values: 72.0 70.0 72.0 72.0 69.0 71.0 70.0 74.0 72.0 70.0 02:41:19 INFO - PID 3986 | -------- Summary: end -------- 02:41:19 INFO - PID 3986 | 02:41:20 INFO - TEST-INFO | 3986: exit 0 02:41:20 INFO - TEST-OK | kraken | took 65626ms 02:41:20 INFO - SUITE-END | took 1189s 02:41:20 INFO - Completed test suite (00:19:49) 02:41:20 INFO - javascript benchmark 02:41:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6740.343609500856, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2732.535468970275, 2760.475509653167, 2797.580362945559, 2799.5800629905507, 2801.1596521043693, 5167.9483205167935, 5283.920741188886, 5298.284731561238, 5307.52232299093, 5362.6246162768575, 5261.815836445725, 5286.735663216843, 5313.73431328433, 5314.521693047625, 5327.334083239595, 4685.85942421727, 4713.410823647044, 4738.289256611519, 4745.952540474603, 4779.928301075469, 4737.620990320784, 4764.023375208074, 4767.046590681877, 4781.3784208053075, 4786.880327991793, 4762.880927976811, 4778.832740854071, 4779.402574678165, 4785.545373189559, 4791.28130780384, 4751.857444276678, 4766.070616229837, 4771.069641419925, 4773.522647735216, 4775.092732380836, 4655.767211639404, 4675.7895894684825, 4738.976305118453, 4753.572178503917, 4754.072955773626, 5271.103912334912, 5307.124324486455, 5361.705106219157, 5369.382521010095, 5375.462453754632, 5576.972115139439, 5736.2542869427125, 5753.683547404891, 5768.596198266123, 5778.219940308089, 5774.7112644368035, 5780.017397042513, 5801.970990145064, 5806.738696758656, 5869.8239052828485, 5393.217983392426, 5394.676319420769, 5394.78420863169, 5400.054990376669, 5436.755346009439, 5936.168936348915, 5944.019236825961, 5952.315483719428, 5957.940420595825, 5958.225430693982, 5542.140968149944, 5622.57830662702, 5626.85932851682, 5659.292588426447, 5668.744906479218, 5729.226554415184, 5771.249737534177, 5805.912911306334, 5807.82576522705, 5823.941760582425, 5728.198052272685, 5739.62692424991, 5744.482996530249, 5747.6838773867, 5747.971260143672, 5543.61194716366, 5691.544676425876, 5736.483716465538, 5748.338941021752, 5754.971225143931, 4691.249400095969, 4734.100520901018, 4799.0401919616215, 4800.159972004885, 4803.03939212159, 4044.2518134145275, 4074.4499492568125, 4080.2451546464, 4092.0383709828166, 4128.02991297045, 4899.387576552931, 4904.901901961941, 4906.975465122651, 4910.680805747615, 4947.208446648519, 5607.719614019283, 5663.122216056518, 5708.828735137952, 5709.8287051388525, 5759.222504961776, 4868.464468908488, 4869.805207791649, 4887.0714564232685, 4907.1903135982875, 4916.188828843272, 5078.289039534468, 5081.593472522263, 5087.669301495391, 5097.566706829887, 5137.845864624067, 5220.660657057279, 5357.571394288526, 5357.946420535901, 5361.5710743141235, 5365.517103460707, 5717.857053573527, 5767.826965191051, 5806.390329015392, 5811.94188058114, 5815.621984570989, 5381.381141168816, 5382.757775900172, 5388.434214407431, 5398.676079435247, 5398.78404863801, 5424.1321388577635, 5653.180288858175, 5702.116171993348, 5707.828765137053, 5746.5402767779315, 5680.801171958961, 5708.686022268815, 5735.684537350319, 5736.541076713769, 5744.655320680772, 5519.862003449946, 5530.778768849201, 5539.695316757617, 5545.500904918576, 5546.029444847216, 5513.751881165277, 5572.359178694502, 5626.718664066862, 5665.12190610456, 5665.943340566541, 5535.446455354432, 5559.388467268678, 5566.415526369673, 5571.1086226203615, 5573.331200255995, 5685.943140568541, 5686.2607860977805, 5687.317521897398, 5694.259746232963, 5705.686187259575, 5387.86530336729, 5472.097103977799, 5481.013417584873, 5482.698451585201, 5565.777368905198], "value": 5208.7665826168, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.1600023970396, 702.673256935525, 1075.3655343347423, 1092.4756117063814, 1092.781443711258, 31581.684183158162, 33079.66920330796, 33135.502967455446, 33201.501977470354, 33235.33529329412, 35341.11647208821, 35664.28671426576, 35814.462783058276, 35827.4625880612, 35862.46206306901, 5484.314460692413, 5614.915776263339, 7281.963590182055, 7402.925970740277, 7416.258374162568, 6933.0293758873795, 7112.4665650076195, 7120.964395178017, 7131.8217044573785, 7135.108111486064, 7202.099737532809, 7258.564486130849, 7259.6370181490975, 7262.346388825004, 7264.7457338993145, 7159.463040271974, 7210.423166146696, 7212.783616491513, 7217.639118044103, 7221.675024623904, 7327.7435289765135, 7366.226546212678, 7369.852602947964, 7373.631318434057, 7386.261373862624, 32491.350172996645, 32505.51241731376, 32716.672833271838, 32778.6722132778, 32782.0, 3068.9539656905163, 3097.4734295169874, 3102.90691279262, 3103.2552187474844, 3112.9844350778326, 24456.0, 24490.14284500052, 24525.63211551828, 24556.0, 24586.0, 3088.768342374331, 3094.659587445379, 3124.2033281513295, 3124.8593813278458, 3137.7176054155007, 137508.31245843807, 138032.0, 138081.0, 138177.3091134548, 138205.3089734545, 33842.32315353728, 34579.48130778041, 39445.80277098596, 41730.582694173274, 41913.37129943053, 41787.582124178974, 41843.372349414785, 41854.11656475405, 41855.7907210462, 41873.581264187575, 12863.22820630765, 12994.0, 12995.935020325027, 12998.935005324913, 13006.089573729938, 10363.067323940732, 10444.843327350096, 10448.111910487694, 10452.216083793746, 10471.42407167613, 11874.168808183516, 11875.821862672066, 11880.227785193934, 11901.880981190077, 12073.637790866289, 4921.7785199666105, 4941.604671626261, 4976.975115124401, 5025.673331233458, 5064.41759197697, 873.3580818098692, 895.3329769321897, 915.1397686174975, 918.7978644698289, 922.561783152997, 20467.385978420672, 20729.89635051845, 21476.140954361963, 24938.0, 25882.65874860671, 967.5355829202023, 968.5157421289356, 991.7966816802539, 995.4326034160459, 996.2279233594022, 10679.519421626046, 11492.712682183012, 11525.366104864146, 11546.307221566733, 11547.307161570332, 194420.0, 194646.0, 195157.0, 195427.0, 195918.0, 39308.80345598254, 39323.213535729126, 39332.606673933464, 39347.80326098351, 39432.0, 1214.6598952293373, 1247.6319485751544, 1256.6481385212155, 1259.5591542960074, 1261.060509920097, 18974.620507589494, 19500.31748888782, 20397.38807835767, 20542.897285513478, 20854.582908341446, 29813.850930746074, 29815.85092074526, 29840.120784297902, 29880.85059574688, 29891.252718682208, 179713.0, 180110.0, 180291.0, 180322.0, 180327.0, 24355.26934191977, 25034.123805666713, 25049.0, 27565.17304480869, 27679.584806227518, 29805.10584682463, 29938.550921735754, 29946.0, 29960.700392996663, 32053.0, 25791.484170316115, 26365.736342637094, 26750.59874101929, 26765.86617066902, 26937.0, 26176.0, 26285.34286642849, 26417.33956651099, 26822.463550729266, 27300.0, 28788.568171477025, 28964.0, 29182.56226156567, 29261.414771704873, 29269.85365073161, 24938.0, 25187.370315742253, 25202.74797252004, 25651.35871603225, 26081.869590651924, 20618.175272988912, 20898.1640734375, 21059.0, 21101.050452729356, 21119.683204752248], "value": 14439.93716007485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.7234280689131, 408.63835505577555, 414.4115356194204, 422.21046642778, 437.5515097025548, 17872.463826085223, 18652.813471865295, 18653.81346186538, 19428.320008799696, 20008.599828003433, 19390.22439102434, 19674.0, 19714.408567742954, 19778.30775922843, 19898.403047908585, 5336.30628018358, 5685.118806584986, 5736.368999410061, 5742.196092547026, 5744.396838331978, 5604.747786349624, 5698.487136157745, 5812.564057695668, 5817.040188368914, 5823.796167134151, 5654.208410822488, 5753.050746626802, 5760.971195144019, 5761.135829625548, 5762.74067666956, 5528.419515950807, 5713.171590119409, 5738.311402631669, 5751.712414379285, 5755.539556835464, 5196.636235463519, 5211.374635043781, 5211.843644690665, 5213.452587478336, 5216.191490319006, 22335.776642233533, 22554.43613909649, 23018.88490557553, 23019.07923683051, 23203.767962320497, 1652.0913497576405, 1674.9832501674948, 1696.4062578097692, 1699.3712326439172, 1701.276957293158, 15083.0, 15301.234938253043, 15500.0, 15561.533154005398, 15635.765463518057, 2091.5084955035554, 2140.176032227588, 2182.7598964114095, 2184.388371256051, 2198.043850924853, 92606.53696731474, 94782.0, 95300.0, 95495.52252238763, 96971.51514242454, 10923.617673381394, 11098.944505277583, 11257.43712814356, 11367.09063274936, 11450.141239407078, 16076.186667333404, 16094.678106437806, 16116.35534578627, 16123.11322877253, 16150.75773863393, 7846.0, 7885.0, 8072.596370181467, 8192.75421737349, 8201.753947381589, 7299.379552738077, 7364.5581265124265, 7419.703211871465, 7611.3530349919765, 7616.466847320745, 7043.823904402431, 7095.574265544084, 7171.282871712787, 7189.281071892873, 7253.165885923081, 2008.3272103845375, 2039.2149022626395, 2059.567490826913, 2108.768035516092, 2146.796054374832, 819.8770184472257, 867.5228624256633, 872.82543491302, 881.6517475597103, 890.2077151335317, 17279.65440691179, 17306.740398894028, 17565.385211517536, 18075.36736214226, 20467.59064818725, 887.7248053103558, 896.6323807239, 896.6413434626071, 897.1970086772302, 915.2769312243387, 9432.62269509212, 9927.2058235341, 9938.354006989523, 9953.402795832273, 10005.349652272724, 509518.0, 523527.0, 536188.0, 549532.0, 564010.0, 74470.62764686142, 83485.0, 86440.0, 95407.52296238474, 99834.5008274954, 1080.6649938519083, 1112.9944350278358, 1116.5087361560886, 1122.6968718445974, 1130.496928866663, 17780.55548611295, 18076.548086297422, 18488.260469581066, 18673.346432874783, 18752.343667971556, 42626.93432664084, 44190.0, 44657.55342446664, 44947.550524494334, 45418.54581454143, 56330.155047675136, 56896.0, 57540.0, 57749.0, 58993.705031474565, 7920.762600423924, 7967.521948683097, 8000.83998320042, 8105.148959359182, 8274.048484424127, 12459.252444852975, 12878.67803304925, 12949.604323199861, 13156.710822294426, 13209.471621135432, 10139.797204056025, 10213.693589192337, 10468.895311046792, 11026.614068507564, 11080.445977700922, 10032.046955539212, 10126.696199114038, 10555.894441055798, 10569.524371403459, 10755.08581770527, 10702.73243168927, 10728.302660327054, 10846.240763146505, 10893.836592451278, 11404.48679809394, 7924.167962364099, 7998.0, 8137.226963438464, 8196.42625016243, 8280.296174825207, 10558.577656893945, 10593.0, 10598.364098154136, 10714.410707411167, 10934.72663183395], "value": 9260.220857400998, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.0989397527756, 1350.5678182981444, 1352.9458821647129, 1358.239385943871, 1361.7616917039522, 9287.860682089766, 9681.370710903786, 9683.370580912237, 9706.611735530589, 9709.320347575673, 9363.578638961262, 9950.402975821456, 10352.275340726152, 10371.325863818847, 10377.0, 2283.303592404316, 2330.580495510816, 2334.206369834256, 2334.754850740673, 2336.5910965581043, 1891.1111777464569, 2141.6573348264283, 2261.276391554703, 2263.196565219348, 2273.727152741665, 1821.9432729017137, 2191.4521369657587, 2269.251147121446, 2272.988635056822, 2274.0, 2122.957540849174, 2148.5058436559602, 2154.9030293636747, 2157.1910533549917, 2160.3518944316643, 2164.1127137873555, 2170.9891450542805, 2174.3368272676826, 2176.5102851858364, 2177.412098733349, 9845.064718851698, 10031.047050530187, 10056.94971525145, 10059.597616095347, 10064.144547713453, 5701.657900525982, 5965.194698715704, 5968.552358573124, 5973.1936188614845, 5983.371745966654, 3360.714339281164, 3447.2249838879693, 3528.3825330567306, 3557.4485954677066, 3620.583632882226, 1045.5086109528509, 1062.3944351719524, 1092.8688557373086, 1101.862267216598, 1119.8432219489277, 15113.848861511464, 15267.083974961537, 15284.541463756104, 15285.235738213045, 15481.225938703132, 4738.099761045391, 4820.118756549118, 4915.48387419323, 4974.129527332775, 5051.3433253676785, 10758.0, 10758.56965721378, 10770.838437423445, 10772.0, 10777.730556736144, 5560.7219639017885, 5644.153376993402, 5662.320521537442, 5670.432956704297, 5672.631278966854, 5041.621878359138, 5060.165072763027, 5091.1854103343285, 5126.487351264844, 5146.639735218499, 3646.726495512847, 3731.160488889978, 3766.7551609145316, 3788.981055094707, 3823.636754508317, 1163.4589915689246, 1168.9590864319707, 1175.3359351966112, 1188.988110118905, 1200.1359021504502, 620.3021600699213, 626.837022374186, 710.6553321639001, 714.1501613080418, 718.2171433137801, 5724.8282551523525, 5740.54075673945, 5816.854578635568, 5885.882282354329, 5893.14549390336, 811.3225456743567, 827.5407149032345, 834.1575009240711, 836.7782537627534, 852.8251708399763, 3854.9614503855164, 3858.1897801462005, 3864.1305706215876, 3871.1676989447406, 3966.9206615868097, 12023.338716370683, 12971.610851674464, 13037.217766934014, 13054.282014489105, 13059.08586398962, 12697.873021269854, 12939.353032348345, 12943.158694684815, 13089.149205301625, 13089.214647121204, 9790.902090979283, 9810.362326448758, 9872.074945385724, 9890.109890109925, 9999.200063994864, 5586.888262234814, 5664.660120392789, 5709.000924838219, 5731.168980497721, 5964.5526585505395, 12078.577249796215, 12155.574554890536, 12276.324802135969, 12282.447289871798, 12286.262824230575, 12405.503779848705, 12630.3684815757, 12651.367431628198, 12698.936505317415, 12715.80926286088, 7623.771286861403, 7830.177831327856, 7830.725924592612, 7831.765047048598, 7834.099078606033, 9192.54037298119, 9305.534723263945, 9310.441373517611, 9310.81195918945, 9407.85888211691, 8267.173282671925, 8274.875876861732, 8300.70947516834, 8372.790680233044, 8398.286145677686, 8030.397720171128, 8144.67421303165, 8161.387895907949, 8180.67277308901, 8356.791080223044, 7419.109706835215, 7432.777016689508, 7495.8500829982, 7505.286997735207, 7509.286617771303, 5243.8164664236565, 5299.5760339172, 5309.946900530946, 5403.297571315704, 5531.253280807039, 5526.309211348582, 5551.611387202857, 5587.161925711176, 5589.105743081088, 5706.400827913009], "value": 4790.615215351258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.4763462066554, 371.7230663155949, 373.441704651546, 395.2627903175475, 399.49264434168606, 5189.844304670856, 5196.246544251081, 5251.947480525194, 5262.289755829362, 5273.604479664022, 4840.806367745286, 5124.538791508763, 5126.5642420394215, 5151.562117220032, 5155.432902380735, 3917.6082391760738, 3956.1494278730065, 3969.027588240885, 3973.7019723520707, 3981.9203615927663, 3966.0877998060464, 3973.569514974607, 3974.940375894364, 3981.781002044901, 3986.840526378956, 3939.212157568498, 3940.034691500586, 3941.3299739044432, 3965.821538030781, 3972.880813575597, 3883.98058009711, 3913.4129880517867, 3922.7057970652313, 3953.6639385652256, 3975.2447035063246, 3473.70473509752, 3485.0, 3488.127968007998, 3488.9127771805656, 3504.6320136385566, 4972.682239206613, 4974.676646017997, 4974.825881094144, 4984.177610694231, 5014.548690617826, 4545.613622842063, 4647.419072615923, 4655.185342565038, 4674.644353137586, 4680.485146633868, 5411.864703382447, 5413.756380962866, 5419.078756611386, 5431.918521222185, 5437.809676661298, 3907.5310962684375, 3911.5306163260307, 3927.175293188434, 3942.2903877302074, 3944.704147188944, 5058.924116138261, 5396.43337449566, 5696.401877802812, 5767.711614419262, 5790.160426738142, 3894.552126505488, 3945.2109578084496, 3949.763014219156, 3993.560708322082, 4005.619466150711, 4056.452378928866, 4059.2693315203546, 4066.4510291110914, 4074.9388759168637, 4086.8569600063856, 4616.976915115403, 4617.168909596305, 4620.861374158781, 4626.444826620827, 4641.2109941310055, 5267.631265811433, 5411.053065713484, 5429.728513574384, 5456.590755693339, 5465.644733092416, 1381.7996390523317, 1382.4124746982693, 1385.3142694366354, 1386.8405133409585, 1386.9944290389387, 923.5751554284969, 952.9285303602257, 966.8549717542285, 970.0638883477478, 972.1348000279756, 4784.64115191362, 4785.612172470014, 4799.928001079987, 4806.206975849016, 4817.0, 5579.860503487445, 5624.634398764068, 5631.577631677641, 5645.491905728504, 5654.3497497788285, 4591.724496530219, 4772.0, 4789.257665061921, 4802.351682522884, 4805.423349198119, 2958.082994271783, 2973.241823335036, 2974.3159073412803, 2992.38656075504, 2996.3258266889775, 5292.5236728693835, 5300.12547929595, 5302.144249512717, 5318.308619879468, 5327.0411325961695, 5538.0585300499015, 5640.943590564124, 5737.340205876294, 5786.189933409326, 5802.79690210849, 5147.40804807452, 5202.453742356998, 5293.232481290268, 5300.2049692546425, 5315.468453154808, 5670.858228544154, 5673.77304907799, 5683.886322273449, 5696.174054762119, 5704.258446401941, 5473.28847249855, 5532.557395408438, 5535.944640553543, 5537.612367134262, 5547.278853748987, 5291.285676433632, 5311.123664595299, 5316.548093412103, 5324.840254792362, 5330.200469929387, 3935.3900145477496, 3949.4470774092224, 3954.0, 3956.643902048829, 3959.069618639675, 5481.051308148275, 5649.322081350264, 5682.0, 5692.0608099663095, 5694.373618902, 5444.727763611724, 5459.478636279657, 5485.561155107502, 5490.1764735288425, 5494.230807686847, 5361.898207713688, 5462.972685136708, 5466.5900057495055, 5505.146702261156, 5505.834824955257, 5312.468753124811, 5324.201369794562, 5388.488093631099, 5396.217548455374, 5405.702686352289, 5462.754176062007, 5465.590080744039, 5489.835304940858, 5490.972545137249, 5515.448455154453, 5170.767315470888, 5311.7609707564025, 5332.5467335276935, 5350.678959262456, 5377.08589539787], "value": 4117.038999287816, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.303072681504, 748.7529115391919, 761.7486229544247, 768.9923100768995, 775.402939736403, 10590.0, 15368.61578460539, 16265.51203463895, 16303.59241018975, 16322.673546529077, 15600.06399616024, 15789.684206315895, 15791.921040394782, 15801.60495987601, 15805.446809361674, 638.0747915522488, 653.2813904704834, 897.6813231302875, 925.1488630459959, 929.4980710416366, 892.0945240580816, 915.7161280003187, 918.3800934369308, 921.1479381572052, 921.5806807902388, 960.875086238788, 965.6137544981993, 966.8066386722684, 966.9951650241738, 967.9370840895355, 665.424407887179, 962.4898803634085, 964.9710508684681, 965.8261512927635, 965.8551217317388, 500.3395517916352, 679.4632240529976, 695.2699665351361, 706.0397858911875, 706.1385110165589, 14105.717885642229, 14227.288635568284, 14243.216623085726, 14275.928620356832, 14287.57137285883, 14225.715485690229, 15303.0, 15386.0768353898, 15392.30734616945, 15436.459723909722, 11815.113866459964, 12187.634370968797, 12356.938215308955, 12358.567450139291, 12363.0, 2887.3503461721157, 2913.3590610065753, 2914.825110493377, 2915.300327921305, 2919.8540072996266, 66401.66799165973, 66534.3346566533, 66701.0, 67499.66250168766, 67760.0, 9993.850092248622, 10352.06831385164, 10377.9481102594, 10394.584216631401, 10622.0, 16108.838911610968, 16673.0, 17738.645227095385, 21383.78616213849, 21722.674159887614, 7333.559986400833, 7340.596267205248, 7502.58735769527, 7539.886901696479, 7551.395888329031, 3779.0174554615446, 3835.5972622874756, 3840.1551658635058, 3847.3459511883048, 3850.8074596270076, 3470.4447288434235, 3593.94609080864, 3595.424732042861, 3598.2623562169692, 3611.5846677632408, 719.4208662027014, 728.2026181331433, 729.5075823819008, 730.3244498838553, 730.747891977267, 592.8547505861092, 608.7960533221332, 609.8018144103185, 609.9542534309944, 627.1877918095986, 9474.478903660365, 9838.508074596384, 9890.950545247228, 9938.304318697767, 10086.899131008742, 588.0502987674874, 594.1622312539386, 596.9134475501028, 598.9730462129214, 614.7233744814852, 4536.002079542495, 4579.015511665008, 4591.79336929839, 4617.399738034034, 4623.884402889955, 65696.6715166421, 66383.33616663772, 66634.66682666652, 66980.0, 68144.0, 53865.1920221197, 55077.72461137669, 60015.399846001856, 61408.38591614116, 64059.0, 48046.75976620164, 48147.0, 48576.27135592969, 49016.75491622519, 50727.239091413656, 9987.350822196535, 10242.560838785776, 10600.946995264974, 10763.569457221623, 10804.135669146292, 26362.209133726017, 26467.60298595561, 26812.463750725266, 26907.730922690524, 27036.864815675795, 41169.58830411657, 44090.33864491971, 45119.0, 45707.31439028484, 46537.0, 12883.162594431333, 13131.277779721824, 13157.934210328887, 13161.0, 13273.402696878471, 13232.338383081, 13470.0, 13495.59513214605, 14222.217778022308, 14822.703545929236, 12810.487580496676, 12927.870721292667, 12937.094403391673, 14121.858781412055, 15044.473443429428, 13359.0, 13653.453861845812, 13723.313834308045, 13800.86199138036, 14442.711145777235, 13004.050750901297, 14098.083624564371, 14100.788488172891, 14145.434182632991, 14240.715185696436, 9117.817643647222, 9376.156145946898, 9531.761705957406, 9692.41845489273, 9766.07222313879, 10504.842427363443, 10757.623483178051, 11035.11719062457, 11080.778384432428, 11166.72083197894], "value": 6825.915192334546, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 128.0, 174.0, 130.0, 126.0, 131.0, 129.0, 154.0, 126.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 166.0, 165.0, 165.0, 166.0, 166.0, 165.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 116.0, 77.0, 76.0, 75.0, 80.0, 91.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 114.0, 85.0, 85.0, 85.0, 104.0, 84.0, 84.0, 112.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 150.0, 151.0, 150.0, 152.0, 151.0, 152.0, 150.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 55.0, 57.0, 55.0, 55.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 57.0, 57.0, 56.0, 57.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 87.0, 87.0, 85.0, 89.0, 85.0, 89.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 146.0, 145.0, 156.0, 134.0, 143.0, 135.0, 183.0, 138.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 197.0, 195.0, 194.0, 194.0, 194.0, 194.0, 196.0, 192.0, 192.0], "value": 194.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 72.0, 72.0, 69.0, 71.0, 70.0, 74.0, 72.0, 70.0], "value": 71.2, "unit": "score"}]}]} 02:41:20 INFO - Return code: 0 02:41:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:41:20 ERROR - # TBPL SUCCESS # 02:41:20 INFO - Running post-action listener: _resource_record_post_action 02:41:20 INFO - [mozharness: 2017-04-10 09:41:20.836764Z] Finished run-tests step (success) 02:41:20 INFO - Running post-run listener: _resource_record_post_run 02:41:20 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 251990016; Read time: 24; Write time: 183308 02:41:20 INFO - TinderboxPrint: CPU usage
13.0% 02:41:20 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 02:41:20 INFO - TinderboxPrint: I/O write bytes / time
251,990,016 / 183,308 02:41:20 INFO - TinderboxPrint: CPU idle
8,365.6 (87.0%) 02:41:20 INFO - TinderboxPrint: CPU user
1,203.9 (12.5%) 02:41:20 INFO - TinderboxPrint: Swap in / out
0 / 0 02:41:20 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5255168; Read time: 0; Write time: 1348 02:41:20 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 246734848; Read time: 16; Write time: 181960 02:41:21 INFO - Running post-run listener: _upload_blobber_files 02:41:21 INFO - Blob upload gear active. 02:41:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:41:21 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 02:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:41:21 INFO - (blobuploader) - INFO - Open directory for files ... 02:41:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:41:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:41:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:22 INFO - (blobuploader) - INFO - Done attempting. 02:41:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:41:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:41:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:23 INFO - (blobuploader) - INFO - Done attempting. 02:41:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:41:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:41:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:24 INFO - (blobuploader) - INFO - Done attempting. 02:41:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:41:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:41:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:28 INFO - (blobuploader) - INFO - Done attempting. 02:41:28 INFO - (blobuploader) - INFO - Iteration through files over. 02:41:28 INFO - Return code: 0 02:41:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:41:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:41:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32fa5ead1824a3549298d4242aed92507a3cb57daf6ebb018d582fb8f292251b8f58e696a94de50eb6468d81da69e191f5e72705ccb8f46bec736cc7b058c439", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d4a72159ecd019cb9e6fa16855c2b89ee21c9681db90b94ca6fdf2aff9e3d7390b92373b32c54727333cc339f42ba27e371eb99386abcfa7e44bd93d931daeca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4051a1bcd8dd313f1abf2cbe957636fa0fd1ad1afc20210234d57293218be9156fb8b904695cabf435656461d435b810020e44b4670401f399b16457154a42dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5801e24dda91f7665cf66e022c9b29d46ae15898e4aee9f45f381aff2615a39c620717c51c84cdbe7636e4fd928b03915bc16105a6928bc0c5825611f7cc0b43"} 02:41:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:41:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:41:28 INFO - Contents: 02:41:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32fa5ead1824a3549298d4242aed92507a3cb57daf6ebb018d582fb8f292251b8f58e696a94de50eb6468d81da69e191f5e72705ccb8f46bec736cc7b058c439", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d4a72159ecd019cb9e6fa16855c2b89ee21c9681db90b94ca6fdf2aff9e3d7390b92373b32c54727333cc339f42ba27e371eb99386abcfa7e44bd93d931daeca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4051a1bcd8dd313f1abf2cbe957636fa0fd1ad1afc20210234d57293218be9156fb8b904695cabf435656461d435b810020e44b4670401f399b16457154a42dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5801e24dda91f7665cf66e022c9b29d46ae15898e4aee9f45f381aff2615a39c620717c51c84cdbe7636e4fd928b03915bc16105a6928bc0c5825611f7cc0b43"} 02:41:28 INFO - Running post-run listener: copy_logs_to_upload_dir 02:41:28 INFO - Copying logs to upload dir... 02:41:28 INFO - mkdir: /builds/slave/test/build/upload/logs 02:41:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1344.438183 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2017-04-10 02:41:28.404494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 02:41:28.407874) ========= 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=781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32fa5ead1824a3549298d4242aed92507a3cb57daf6ebb018d582fb8f292251b8f58e696a94de50eb6468d81da69e191f5e72705ccb8f46bec736cc7b058c439", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d4a72159ecd019cb9e6fa16855c2b89ee21c9681db90b94ca6fdf2aff9e3d7390b92373b32c54727333cc339f42ba27e371eb99386abcfa7e44bd93d931daeca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4051a1bcd8dd313f1abf2cbe957636fa0fd1ad1afc20210234d57293218be9156fb8b904695cabf435656461d435b810020e44b4670401f399b16457154a42dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5801e24dda91f7665cf66e022c9b29d46ae15898e4aee9f45f381aff2615a39c620717c51c84cdbe7636e4fd928b03915bc16105a6928bc0c5825611f7cc0b43"} build_url:https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/CYYOD0fJQayyLRuWdaHAEA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32fa5ead1824a3549298d4242aed92507a3cb57daf6ebb018d582fb8f292251b8f58e696a94de50eb6468d81da69e191f5e72705ccb8f46bec736cc7b058c439", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d4a72159ecd019cb9e6fa16855c2b89ee21c9681db90b94ca6fdf2aff9e3d7390b92373b32c54727333cc339f42ba27e371eb99386abcfa7e44bd93d931daeca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4051a1bcd8dd313f1abf2cbe957636fa0fd1ad1afc20210234d57293218be9156fb8b904695cabf435656461d435b810020e44b4670401f399b16457154a42dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5801e24dda91f7665cf66e022c9b29d46ae15898e4aee9f45f381aff2615a39c620717c51c84cdbe7636e4fd928b03915bc16105a6928bc0c5825611f7cc0b43"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 02:41:28.436359) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:41:28.436651) ========= 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=781b77c4c33858b1f599d705000001c1-1491815930.589410-985477426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004686 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:41:28.520168) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 02:41:28.520461) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 02:41:28.520744) ========= ========= Total master_lag: 0.16 =========