builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-080 starttime: 1494257598.26 results: success (0) revision: 38f862749aed4e9a874182a9019e0671289088b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:18.256292) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:18.256731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:18.257039) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:18.405075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:18.405449) ========= 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-1494257148.633881-878491815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-08 08:33:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-05-08 08:33:19 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.350308 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:18.770847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:18.771151) ========= 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-1494257148.633881-878491815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020845 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:18.820893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:18.821287) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 38f862749aed4e9a874182a9019e0671289088b0 --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 38f862749aed4e9a874182a9019e0671289088b0 --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-1494257148.633881-878491815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-08 08:33:19,797 truncating revision to first 12 chars 2017-05-08 08:33:19,797 Setting DEBUG logging. 2017-05-08 08:33:19,797 attempt 1/10 2017-05-08 08:33:19,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/38f862749aed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 08:33:20,094 unpacking tar archive at: mozilla-central-38f862749aed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620241 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:19.455056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:19.455360) ========= script_repo_revision: 38f862749aed4e9a874182a9019e0671289088b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:19.455737) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:19.455996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 08:33:19.464811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-08 08:33:19.465142) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:33:20 INFO - MultiFileLogger online at 20170508 08:33:20 in /builds/slave/test 08:33:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:33:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:33:20 INFO - {'append_to_log': False, 08:33:20 INFO - 'base_work_dir': '/builds/slave/test', 08:33:20 INFO - 'blob_upload_branch': 'Firefox', 08:33:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:33:20 INFO - 'branch': 'Firefox', 08:33:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:33:20 INFO - 'config_files': ('talos/linux_config.py',), 08:33:20 INFO - 'default_actions': ('clobber', 08:33:20 INFO - 'read-buildbot-config', 08:33:20 INFO - 'download-and-extract', 08:33:20 INFO - 'populate-webroot', 08:33:20 INFO - 'create-virtualenv', 08:33:20 INFO - 'install', 08:33:20 INFO - 'run-tests'), 08:33:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:33:20 INFO - 'download_minidump_stackwalk': True, 08:33:20 INFO - 'download_symbols': 'ondemand', 08:33:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:33:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:33:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:33:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:33:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:33:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:33:20 INFO - 'gecko_profile': False, 08:33:20 INFO - 'gecko_profile_interval': 0, 08:33:20 INFO - 'installer_path': 'installer.exe', 08:33:20 INFO - 'log_level': 'info', 08:33:20 INFO - 'log_name': 'talos', 08:33:20 INFO - 'log_to_console': True, 08:33:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:33:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:33:20 INFO - 'opt_config_files': (), 08:33:20 INFO - 'pip_index': False, 08:33:20 INFO - 'suite': 'dromaeojs', 08:33:20 INFO - 'system_bits': '32', 08:33:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:33:20 INFO - 'title': 'talos-linux64-ix-080', 08:33:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:33:20 INFO - 'use_talos_json': True, 08:33:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:33:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:33:20 INFO - 'work_dir': 'build'} 08:33:20 INFO - [mozharness: 2017-05-08 15:33:20.540233Z] Running clobber step. 08:33:20 INFO - Running pre-action listener: _resource_record_pre_action 08:33:20 INFO - Running main action method: clobber 08:33:20 INFO - rmtree: /builds/slave/test/build 08:33:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:33:22 INFO - Running post-action listener: _resource_record_post_action 08:33:22 INFO - [mozharness: 2017-05-08 15:33:22.002400Z] Finished clobber step (success) 08:33:22 INFO - [mozharness: 2017-05-08 15:33:22.003100Z] Running read-buildbot-config step. 08:33:22 INFO - Running pre-action listener: _resource_record_pre_action 08:33:22 INFO - Running main action method: read_buildbot_config 08:33:22 INFO - Using buildbot properties: 08:33:22 INFO - { 08:33:22 INFO - "project": "", 08:33:22 INFO - "product": "firefox", 08:33:22 INFO - "who": "ffxbld@noreply.mozilla.org", 08:33:22 INFO - "installer_path": "public/build/target.tar.bz2", 08:33:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 08:33:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:33:22 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 08:33:22 INFO - "stage_platform": "linux64-stylo", 08:33:22 INFO - "basedir": "/builds/slave/test", 08:33:22 INFO - "buildnumber": 71, 08:33:22 INFO - "platform": "ubuntu64_hw_stylo", 08:33:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:33:22 INFO - "slavebuilddir": "test", 08:33:22 INFO - "taskId": "TQxb2bfgQb2k3oqdwCaLrQ", 08:33:22 INFO - "branch": "mozilla-central", 08:33:22 INFO - "script_repo_revision": "production", 08:33:22 INFO - "revision": "38f862749aed4e9a874182a9019e0671289088b0", 08:33:22 INFO - "slavename": "talos-linux64-ix-080", 08:33:22 INFO - "repo_path": "mozilla-central" 08:33:22 INFO - } 08:33:22 INFO - Finding installer, test and symbols from parent task. 08:33:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQxb2bfgQb2k3oqdwCaLrQ'}, attempt #1 08:33:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQxb2bfgQb2k3oqdwCaLrQ'}, attempt #1 08:33:22 INFO - Task dependencies: AOxXR9PGQPOUhYXOPwFZiQ 08:33:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ'}, attempt #1 08:33:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.tar.bz2 08:33:23 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/test_packages.json 08:33:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.crashreporter-symbols.zip 08:33:23 INFO - Running post-action listener: _resource_record_post_action 08:33:23 INFO - [mozharness: 2017-05-08 15:33:23.391621Z] Finished read-buildbot-config step (success) 08:33:23 INFO - [mozharness: 2017-05-08 15:33:23.391836Z] Running download-and-extract step. 08:33:23 INFO - Running pre-action listener: _resource_record_pre_action 08:33:23 INFO - Running main action method: download_and_extract 08:33:23 INFO - mkdir: /builds/slave/test/build/tests 08:33: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')]} 08:33:23 INFO - trying https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.test_packages.json 08:33:23 INFO - Downloading https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:33:23 INFO - Downloaded 986 bytes. 08:33:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:33:23 INFO - Using the following test package requirements: 08:33:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:33:23 INFO - u'common': [u'target.common.tests.zip'], 08:33:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:33:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:33:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:33:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:33:23 INFO - u'mozbase': [u'target.common.tests.zip'], 08:33:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:33:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:33:23 INFO - u'web-platform': [u'target.common.tests.zip', 08:33:23 INFO - u'target.web-platform.tests.zip'], 08:33:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:33:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:33:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.common.tests.zip 08:33:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:33:23 INFO - Fetch https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.common.tests.zip into memory 08:33:25 INFO - Content-Length response header: 58446212 08:33:25 INFO - Bytes received: 58446212 08:33:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:33:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.common.tests.zip 08:33:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:33:34 INFO - Fetch https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.common.tests.zip into memory 08:33:36 INFO - Content-Length response header: 58446212 08:33:36 INFO - Bytes received: 58446212 08:33:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.talos.tests.zip 08:33:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:33:46 INFO - Fetch https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.talos.tests.zip into memory 08:33:47 INFO - Content-Length response header: 14409362 08:33:47 INFO - Bytes received: 14409362 08:33:47 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')]} 08:33:47 INFO - trying https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.tar.bz2 08:33:47 INFO - Downloading https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:33:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:33:49 INFO - Downloaded 59997384 bytes. 08:33:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.tar.bz2 08:33:49 INFO - mkdir: /builds/slave/test/properties 08:33:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:33:49 INFO - Writing to file /builds/slave/test/properties/build_url 08:33:49 INFO - Contents: 08:33:49 INFO - build_url:https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.tar.bz2 08:33:49 INFO - Running post-action listener: _resource_record_post_action 08:33:49 INFO - Running post-action listener: set_extra_try_arguments 08:33:49 INFO - [mozharness: 2017-05-08 15:33:49.600118Z] Finished download-and-extract step (success) 08:33:49 INFO - [mozharness: 2017-05-08 15:33:49.600215Z] Running populate-webroot step. 08:33:49 INFO - Running pre-action listener: _resource_record_pre_action 08:33:49 INFO - Running main action method: populate_webroot 08:33:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:33:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:33:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:33:49 INFO - '--tppagecycles', 08:33:49 INFO - '7'], 08:33:49 INFO - 'tests': ['tsvgm']}}, 08:33:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:33:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:33:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:33:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:33:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:33:49 INFO - 'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:33:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:33:49 INFO - 'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['damp', 'tps']}, 08:33:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:33:49 INFO - 'tests': ['damp', 'tps']}, 08:33:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['dromaeo_dom']}, 08:33:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:33:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:33:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:33:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['a11yr', 08:33:49 INFO - 'ts_paint', 08:33:49 INFO - 'tpaint', 08:33:49 INFO - 'sessionrestore', 08:33:49 INFO - 'sessionrestore_no_auto_restore', 08:33:49 INFO - 'tabpaint']}, 08:33:49 INFO - 'other-e10s': {'tests': ['a11yr', 08:33:49 INFO - 'ts_paint', 08:33:49 INFO - 'tpaint', 08:33:49 INFO - 'sessionrestore', 08:33:49 INFO - 'sessionrestore_no_auto_restore', 08:33:49 INFO - 'tabpaint']}, 08:33:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:33:49 INFO - 'ts_paint', 08:33:49 INFO - 'tpaint', 08:33:49 INFO - 'sessionrestore', 08:33:49 INFO - 'sessionrestore_no_auto_restore', 08:33:49 INFO - 'tabpaint']}, 08:33:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:33:49 INFO - 'ts_paint', 08:33:49 INFO - 'tpaint', 08:33:49 INFO - 'sessionrestore', 08:33:49 INFO - 'sessionrestore_no_auto_restore', 08:33:49 INFO - 'tabpaint']}, 08:33:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['a11yr', 08:33:49 INFO - 'ts_paint', 08:33:49 INFO - 'tpaint', 08:33:49 INFO - 'sessionrestore', 08:33:49 INFO - 'sessionrestore_no_auto_restore', 08:33:49 INFO - 'tabpaint']}, 08:33:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['a11yr', 08:33:49 INFO - 'ts_paint', 08:33:49 INFO - 'tpaint', 08:33:49 INFO - 'sessionrestore', 08:33:49 INFO - 'sessionrestore_no_auto_restore', 08:33:49 INFO - 'tabpaint']}, 08:33:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:33:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:33:49 INFO - 'bloom_basic_ref']}, 08:33:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['tsvgx', 08:33:49 INFO - 'tsvgr_opacity', 08:33:49 INFO - 'tart', 08:33:49 INFO - 'tscrollx', 08:33:49 INFO - 'cart', 08:33:49 INFO - 'tsvg_static']}, 08:33:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:33:49 INFO - 'tsvgr_opacity', 08:33:49 INFO - 'tart', 08:33:49 INFO - 'tscrollx', 08:33:49 INFO - 'cart', 08:33:49 INFO - 'tsvg_static']}, 08:33:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:33:49 INFO - 'talos_options': ['--disable-e10s'], 08:33:49 INFO - 'tests': ['tp5o']}, 08:33:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:33:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:33:49 INFO - 'talos_options': ['--disable-e10s', 08:33:49 INFO - '--xperf_path', 08:33:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:49 INFO - 'tests': ['tp5n']}, 08:33:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:33:49 INFO - 'talos_options': ['--xperf_path', 08:33:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:49 INFO - 'tests': ['tp5n']}}, 08:33:49 INFO - 'talos.zip': {'path': '', 08:33:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:33:49 INFO - Running post-action listener: _resource_record_post_action 08:33:49 INFO - [mozharness: 2017-05-08 15:33:49.613794Z] Finished populate-webroot step (success) 08:33:49 INFO - [mozharness: 2017-05-08 15:33:49.613881Z] Running create-virtualenv step. 08:33:49 INFO - Running pre-action listener: _resource_record_pre_action 08:33:49 INFO - Running main action method: create_virtualenv 08:33:49 INFO - Creating virtualenv /builds/slave/test/build/venv 08:33:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:33:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:33:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:33:49 INFO - Using real prefix '/usr' 08:33:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:33:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:33:52 INFO - Installing pip.................done. 08:33:52 INFO - Return code: 0 08:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:33:52 INFO - Reading from file tmpfile_stdout 08:33:52 INFO - Output received: 08:33: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) 08:33:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:52 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 0xef91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, '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-1494257148.633881-878491815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:52 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 08:33:52 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 08:33:52 INFO - Using env: {'DISPLAY': ':0', 08:33:52 INFO - 'HOME': '/home/cltbld', 08:33:52 INFO - 'LANG': 'en_US.UTF-8', 08:33:52 INFO - 'LANGUAGE': 'en_US:en', 08:33:52 INFO - 'LOGNAME': 'cltbld', 08:33:52 INFO - 'MAIL': '/var/mail/cltbld', 08:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:52 INFO - 'MOZ_NO_REMOTE': '1', 08:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:52 INFO - 'NO_EM_RESTART': '1', 08:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:52 INFO - 'PWD': '/builds/slave/test', 08:33:52 INFO - 'SHELL': '/bin/bash', 08:33:52 INFO - 'SHLVL': '1', 08:33:52 INFO - 'TERM': 'linux', 08:33:52 INFO - 'TMOUT': '86400', 08:33:52 INFO - 'USER': 'cltbld', 08:33:52 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:52 INFO - '_': '/tools/buildbot/bin/python'} 08:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:33:52 INFO - Cleaning up... 08:33:52 INFO - Return code: 0 08:33:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:52 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 0xef91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, '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-1494257148.633881-878491815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:52 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 08:33:52 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 08:33:52 INFO - Using env: {'DISPLAY': ':0', 08:33:52 INFO - 'HOME': '/home/cltbld', 08:33:52 INFO - 'LANG': 'en_US.UTF-8', 08:33:52 INFO - 'LANGUAGE': 'en_US:en', 08:33:52 INFO - 'LOGNAME': 'cltbld', 08:33:52 INFO - 'MAIL': '/var/mail/cltbld', 08:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:52 INFO - 'MOZ_NO_REMOTE': '1', 08:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:52 INFO - 'NO_EM_RESTART': '1', 08:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:52 INFO - 'PWD': '/builds/slave/test', 08:33:52 INFO - 'SHELL': '/bin/bash', 08:33:52 INFO - 'SHLVL': '1', 08:33:52 INFO - 'TERM': 'linux', 08:33:52 INFO - 'TMOUT': '86400', 08:33:52 INFO - 'USER': 'cltbld', 08:33:52 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:52 INFO - '_': '/tools/buildbot/bin/python'} 08:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:52 INFO - Downloading/unpacking psutil>=3.1.1 08:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:52 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 08:33:52 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 08:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:33:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:54 INFO - Installing collected packages: psutil 08:33:54 INFO - Running setup.py install for psutil 08:33:54 INFO - building 'psutil._psutil_linux' extension 08:33:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:33:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:33:54 INFO - building 'psutil._psutil_posix' extension 08:33:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:33:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:33:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:54 INFO - Successfully installed psutil 08:33:54 INFO - Cleaning up... 08:33:54 INFO - Return code: 0 08:33:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, '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-1494257148.633881-878491815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:33:54 INFO - Using env: {'DISPLAY': ':0', 08:33:54 INFO - 'HOME': '/home/cltbld', 08:33:54 INFO - 'LANG': 'en_US.UTF-8', 08:33:54 INFO - 'LANGUAGE': 'en_US:en', 08:33:54 INFO - 'LOGNAME': 'cltbld', 08:33:54 INFO - 'MAIL': '/var/mail/cltbld', 08:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:54 INFO - 'MOZ_NO_REMOTE': '1', 08:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:54 INFO - 'NO_EM_RESTART': '1', 08:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:54 INFO - 'PWD': '/builds/slave/test', 08:33:54 INFO - 'SHELL': '/bin/bash', 08:33:54 INFO - 'SHLVL': '1', 08:33:54 INFO - 'TERM': 'linux', 08:33:54 INFO - 'TMOUT': '86400', 08:33:54 INFO - 'USER': 'cltbld', 08:33:54 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:54 INFO - '_': '/tools/buildbot/bin/python'} 08:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:54 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 08:33:54 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 08:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:33:55 INFO - Installing collected packages: mozsystemmonitor 08:33:55 INFO - Running setup.py install for mozsystemmonitor 08:33:56 INFO - Successfully installed mozsystemmonitor 08:33:56 INFO - Cleaning up... 08:33:56 INFO - Return code: 0 08:33:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xef91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, '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-1494257148.633881-878491815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:33:56 INFO - Using env: {'DISPLAY': ':0', 08:33:56 INFO - 'HOME': '/home/cltbld', 08:33:56 INFO - 'LANG': 'en_US.UTF-8', 08:33:56 INFO - 'LANGUAGE': 'en_US:en', 08:33:56 INFO - 'LOGNAME': 'cltbld', 08:33:56 INFO - 'MAIL': '/var/mail/cltbld', 08:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:56 INFO - 'MOZ_NO_REMOTE': '1', 08:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:56 INFO - 'NO_EM_RESTART': '1', 08:33:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:56 INFO - 'PWD': '/builds/slave/test', 08:33:56 INFO - 'SHELL': '/bin/bash', 08:33:56 INFO - 'SHLVL': '1', 08:33:56 INFO - 'TERM': 'linux', 08:33:56 INFO - 'TMOUT': '86400', 08:33:56 INFO - 'USER': 'cltbld', 08:33:56 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:56 INFO - '_': '/tools/buildbot/bin/python'} 08:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:56 INFO - Downloading/unpacking jsonschema==2.5.1 08:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:57 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:57 INFO - warning: no files found matching '*.txt' 08:33:57 INFO - no previously-included directories found matching 'build' 08:33:57 INFO - no previously-included directories found matching 'dist' 08:33:57 INFO - no previously-included directories found matching '.git*' 08:33:57 INFO - Installing collected packages: jsonschema, functools32 08:33:57 INFO - Running setup.py install for functools32 08:33:57 INFO - warning: no files found matching '*.txt' 08:33:57 INFO - no previously-included directories found matching 'build' 08:33:57 INFO - no previously-included directories found matching 'dist' 08:33:57 INFO - no previously-included directories found matching '.git*' 08:33:57 INFO - Successfully installed jsonschema functools32 08:33:57 INFO - Cleaning up... 08:33:57 INFO - Return code: 0 08:33:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:33:57 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')]} 08:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:57 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')]} 08:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:57 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 0xef91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, '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-1494257148.633881-878491815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:57 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 08:33:57 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 08:33:57 INFO - Using env: {'DISPLAY': ':0', 08:33:57 INFO - 'HOME': '/home/cltbld', 08:33:57 INFO - 'LANG': 'en_US.UTF-8', 08:33:57 INFO - 'LANGUAGE': 'en_US:en', 08:33:57 INFO - 'LOGNAME': 'cltbld', 08:33:57 INFO - 'MAIL': '/var/mail/cltbld', 08:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:57 INFO - 'MOZ_NO_REMOTE': '1', 08:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:57 INFO - 'NO_EM_RESTART': '1', 08:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:57 INFO - 'PWD': '/builds/slave/test', 08:33:57 INFO - 'SHELL': '/bin/bash', 08:33:57 INFO - 'SHLVL': '1', 08:33:57 INFO - 'TERM': 'linux', 08:33:57 INFO - 'TMOUT': '86400', 08:33:57 INFO - 'USER': 'cltbld', 08:33:57 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:57 INFO - '_': '/tools/buildbot/bin/python'} 08:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:33:58 INFO - Cleaning up... 08:33:58 INFO - Return code: 0 08:33:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:33:58 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')]} 08:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:58 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')]} 08:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:58 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 0xef91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, '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-1494257148.633881-878491815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:58 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 08:33:58 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 08:33:58 INFO - Using env: {'DISPLAY': ':0', 08:33:58 INFO - 'HOME': '/home/cltbld', 08:33:58 INFO - 'LANG': 'en_US.UTF-8', 08:33:58 INFO - 'LANGUAGE': 'en_US:en', 08:33:58 INFO - 'LOGNAME': 'cltbld', 08:33:58 INFO - 'MAIL': '/var/mail/cltbld', 08:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:58 INFO - 'MOZ_NO_REMOTE': '1', 08:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:58 INFO - 'NO_EM_RESTART': '1', 08:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:58 INFO - 'PWD': '/builds/slave/test', 08:33:58 INFO - 'SHELL': '/bin/bash', 08:33:58 INFO - 'SHLVL': '1', 08:33:58 INFO - 'TERM': 'linux', 08:33:58 INFO - 'TMOUT': '86400', 08:33:58 INFO - 'USER': 'cltbld', 08:33:58 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:58 INFO - '_': '/tools/buildbot/bin/python'} 08:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:58 INFO - Downloading/unpacking blobuploader==1.2.4 08:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:33:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:33:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:59 INFO - Downloading docopt-0.6.1.tar.gz 08:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:34:00 INFO - Installing collected packages: blobuploader, requests, docopt 08:34:00 INFO - Running setup.py install for blobuploader 08:34:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:34:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:34:00 INFO - Running setup.py install for requests 08:34:00 INFO - Running setup.py install for docopt 08:34:00 INFO - Successfully installed blobuploader requests docopt 08:34:00 INFO - Cleaning up... 08:34:00 INFO - Return code: 0 08:34:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:00 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')]} 08:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:00 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')]} 08:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:00 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 0xef91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, '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-1494257148.633881-878491815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:00 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 08:34:00 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 08:34:00 INFO - Using env: {'DISPLAY': ':0', 08:34:00 INFO - 'HOME': '/home/cltbld', 08:34:00 INFO - 'LANG': 'en_US.UTF-8', 08:34:00 INFO - 'LANGUAGE': 'en_US:en', 08:34:00 INFO - 'LOGNAME': 'cltbld', 08:34:00 INFO - 'MAIL': '/var/mail/cltbld', 08:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:00 INFO - 'MOZ_NO_REMOTE': '1', 08:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:00 INFO - 'NO_EM_RESTART': '1', 08:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:00 INFO - 'PWD': '/builds/slave/test', 08:34:00 INFO - 'SHELL': '/bin/bash', 08:34:00 INFO - 'SHLVL': '1', 08:34:00 INFO - 'TERM': 'linux', 08:34:00 INFO - 'TMOUT': '86400', 08:34:00 INFO - 'USER': 'cltbld', 08:34:00 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:00 INFO - '_': '/tools/buildbot/bin/python'} 08:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:00 INFO - Running setup.py (path:/tmp/pip-NzfDvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:00 INFO - Running setup.py (path:/tmp/pip-UIuzic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:00 INFO - Running setup.py (path:/tmp/pip-6rkSET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:01 INFO - Running setup.py (path:/tmp/pip-KXyGGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:01 INFO - Running setup.py (path:/tmp/pip-_AvCmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:01 INFO - Running setup.py (path:/tmp/pip-f4CGUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:01 INFO - Running setup.py (path:/tmp/pip-8l2Zd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:01 INFO - Running setup.py (path:/tmp/pip-HSoZpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:01 INFO - Running setup.py (path:/tmp/pip-XzBomr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:01 INFO - Running setup.py (path:/tmp/pip-vpqvq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:01 INFO - Running setup.py (path:/tmp/pip-lDCkkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:01 INFO - Running setup.py (path:/tmp/pip-e87bbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:01 INFO - Running setup.py (path:/tmp/pip-lBgc7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:01 INFO - Running setup.py (path:/tmp/pip-It9I2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:01 INFO - Running setup.py (path:/tmp/pip-DFAihi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:01 INFO - Running setup.py (path:/tmp/pip-H3NhVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:01 INFO - Running setup.py (path:/tmp/pip-sWiG9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:34:02 INFO - Running setup.py install for manifestparser 08:34:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:34:02 INFO - Running setup.py install for mozcrash 08:34:02 INFO - Running setup.py install for mozdebug 08:34:02 INFO - Running setup.py install for mozdevice 08:34:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:34:02 INFO - Running setup.py install for mozfile 08:34:02 INFO - Running setup.py install for mozhttpd 08:34:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:34:02 INFO - Running setup.py install for mozinfo 08:34:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:34:02 INFO - Running setup.py install for mozInstall 08:34:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:34:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:34:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:34:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:34:02 INFO - Running setup.py install for mozleak 08:34:02 INFO - Running setup.py install for mozlog 08:34:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:34:03 INFO - Running setup.py install for moznetwork 08:34:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:34:03 INFO - Running setup.py install for mozprocess 08:34:03 INFO - Running setup.py install for mozprofile 08:34:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:34:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:34:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:34:03 INFO - Running setup.py install for mozrunner 08:34:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:34:03 INFO - Running setup.py install for mozscreenshot 08:34:03 INFO - Running setup.py install for moztest 08:34:03 INFO - Running setup.py install for mozversion 08:34:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:34:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:34:03 INFO - Cleaning up... 08:34:03 INFO - Return code: 0 08:34:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:03 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 0xef91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, '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-1494257148.633881-878491815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:03 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 08:34:03 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 08:34:03 INFO - Using env: {'DISPLAY': ':0', 08:34:03 INFO - 'HOME': '/home/cltbld', 08:34:03 INFO - 'LANG': 'en_US.UTF-8', 08:34:03 INFO - 'LANGUAGE': 'en_US:en', 08:34:03 INFO - 'LOGNAME': 'cltbld', 08:34:03 INFO - 'MAIL': '/var/mail/cltbld', 08:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:03 INFO - 'MOZ_NO_REMOTE': '1', 08:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:03 INFO - 'NO_EM_RESTART': '1', 08:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:03 INFO - 'PWD': '/builds/slave/test', 08:34:03 INFO - 'SHELL': '/bin/bash', 08:34:03 INFO - 'SHLVL': '1', 08:34:03 INFO - 'TERM': 'linux', 08:34:03 INFO - 'TMOUT': '86400', 08:34:03 INFO - 'USER': 'cltbld', 08:34:03 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:03 INFO - '_': '/tools/buildbot/bin/python'} 08:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:04 INFO - Running setup.py (path:/tmp/pip-vsVIWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:04 INFO - Running setup.py (path:/tmp/pip-cI7R0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:04 INFO - Running setup.py (path:/tmp/pip-JVg_pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:04 INFO - Running setup.py (path:/tmp/pip-WthiMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:04 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)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:04 INFO - Running setup.py (path:/tmp/pip-gAeARR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:04 INFO - Running setup.py (path:/tmp/pip-X_89tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:04 INFO - Running setup.py (path:/tmp/pip-uucVvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:04 INFO - Running setup.py (path:/tmp/pip-1Dxwid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:04 INFO - Running setup.py (path:/tmp/pip-OZk2WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:04 INFO - Running setup.py (path:/tmp/pip-cykYoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:04 INFO - Running setup.py (path:/tmp/pip-UABZOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:04 INFO - Running setup.py (path:/tmp/pip-lZYn_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:04 INFO - Running setup.py (path:/tmp/pip-6Q9Sg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:05 INFO - Running setup.py (path:/tmp/pip-lZ1heV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:05 INFO - Running setup.py (path:/tmp/pip-GQGVwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:05 INFO - Running setup.py (path:/tmp/pip-T2zkcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:05 INFO - Running setup.py (path:/tmp/pip-IXYzPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:34:05 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)) 08:34:05 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)) 08:34:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:06 INFO - Downloading blessings-1.6.tar.gz 08:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:34:06 INFO - Installing collected packages: blessings 08:34:06 INFO - Running setup.py install for blessings 08:34:06 INFO - Successfully installed blessings 08:34:06 INFO - Cleaning up... 08:34:06 INFO - Return code: 0 08:34:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:34:06 INFO - Reading from file tmpfile_stdout 08:34:06 INFO - Current package versions: 08:34:06 INFO - argparse == 1.2.1 08:34:06 INFO - blessings == 1.6 08:34:06 INFO - blobuploader == 1.2.4 08:34:06 INFO - docopt == 0.6.1 08:34:06 INFO - functools32 == 3.2.3-2 08:34:06 INFO - jsonschema == 2.5.1 08:34:06 INFO - manifestparser == 1.1 08:34:06 INFO - mozInstall == 1.12 08:34:06 INFO - mozcrash == 1.0 08:34:06 INFO - mozdebug == 0.1 08:34:06 INFO - mozdevice == 0.50 08:34:06 INFO - mozfile == 1.2 08:34:06 INFO - mozhttpd == 0.7 08:34:06 INFO - mozinfo == 0.9 08:34:06 INFO - mozleak == 0.1 08:34:06 INFO - mozlog == 3.4 08:34:06 INFO - moznetwork == 0.27 08:34:06 INFO - mozprocess == 0.25 08:34:06 INFO - mozprofile == 0.28 08:34:06 INFO - mozrunner == 6.13 08:34:06 INFO - mozscreenshot == 0.1 08:34:06 INFO - mozsystemmonitor == 0.3 08:34:06 INFO - moztest == 0.8 08:34:06 INFO - mozversion == 1.4 08:34:06 INFO - psutil == 3.1.1 08:34:06 INFO - requests == 1.2.3 08:34:06 INFO - wsgiref == 0.1.2 08:34:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:06 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 0xef91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, '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-1494257148.633881-878491815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:06 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 08:34:06 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 08:34:06 INFO - Using env: {'DISPLAY': ':0', 08:34:06 INFO - 'HOME': '/home/cltbld', 08:34:06 INFO - 'LANG': 'en_US.UTF-8', 08:34:06 INFO - 'LANGUAGE': 'en_US:en', 08:34:06 INFO - 'LOGNAME': 'cltbld', 08:34:06 INFO - 'MAIL': '/var/mail/cltbld', 08:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:06 INFO - 'MOZ_NO_REMOTE': '1', 08:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:06 INFO - 'NO_EM_RESTART': '1', 08:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:06 INFO - 'PWD': '/builds/slave/test', 08:34:06 INFO - 'SHELL': '/bin/bash', 08:34:06 INFO - 'SHLVL': '1', 08:34:06 INFO - 'TERM': 'linux', 08:34:06 INFO - 'TMOUT': '86400', 08:34:06 INFO - 'USER': 'cltbld', 08:34:06 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:06 INFO - '_': '/tools/buildbot/bin/python'} 08:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:34:07 INFO - Cleaning up... 08:34:07 INFO - Return code: 0 08:34:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:34: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')]} 08:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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')]} 08:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, '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-1494257148.633881-878491815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:34:07 INFO - Using env: {'DISPLAY': ':0', 08:34:07 INFO - 'HOME': '/home/cltbld', 08:34:07 INFO - 'LANG': 'en_US.UTF-8', 08:34:07 INFO - 'LANGUAGE': 'en_US:en', 08:34:07 INFO - 'LOGNAME': 'cltbld', 08:34:07 INFO - 'MAIL': '/var/mail/cltbld', 08:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:07 INFO - 'MOZ_NO_REMOTE': '1', 08:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:07 INFO - 'NO_EM_RESTART': '1', 08:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:07 INFO - 'PWD': '/builds/slave/test', 08:34:07 INFO - 'SHELL': '/bin/bash', 08:34:07 INFO - 'SHLVL': '1', 08:34:07 INFO - 'TERM': 'linux', 08:34:07 INFO - 'TMOUT': '86400', 08:34:07 INFO - 'USER': 'cltbld', 08:34:07 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:07 INFO - '_': '/tools/buildbot/bin/python'} 08:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:34:07 INFO - Cleaning up... 08:34:07 INFO - Return code: 0 08:34:07 INFO - Running post-action listener: _resource_record_post_action 08:34:07 INFO - Running post-action listener: _start_resource_monitoring 08:34:07 INFO - Starting resource monitoring. 08:34:07 INFO - [mozharness: 2017-05-08 15:34:07.359750Z] Finished create-virtualenv step (success) 08:34:07 INFO - [mozharness: 2017-05-08 15:34:07.360217Z] Running install step. 08:34:07 INFO - Running pre-action listener: _resource_record_pre_action 08:34:07 INFO - Running main action method: install 08:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:34:07 INFO - Reading from file tmpfile_stdout 08:34:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:34:07 INFO - Reading from file tmpfile_stdout 08:34:07 INFO - Output received: 08:34:07 INFO - Usage: mozinstall [options] installer 08:34:07 INFO - Options: 08:34:07 INFO - -h, --help show this help message and exit 08:34:07 INFO - -d DEST, --destination=DEST 08:34:07 INFO - Directory to install application into. [default: 08:34:07 INFO - "/builds/slave/test"] 08:34:07 INFO - --app=APP Application being installed. [default: firefox] 08:34:07 INFO - mkdir: /builds/slave/test/build/application 08:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:34:23 INFO - Reading from file tmpfile_stdout 08:34:23 INFO - Output received: 08:34:23 INFO - /builds/slave/test/build/application/firefox/firefox 08:34:23 INFO - Running post-action listener: _resource_record_post_action 08:34:23 INFO - [mozharness: 2017-05-08 15:34:23.103887Z] Finished install step (success) 08:34:23 INFO - [mozharness: 2017-05-08 15:34:23.104162Z] Running run-tests step. 08:34:23 INFO - Running pre-action listener: _resource_record_pre_action 08:34:23 INFO - Running main action method: run_tests 08:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:34:23 INFO - Python 2.7.3 08:34:23 INFO - Return code: 0 08:34:23 INFO - grabbing minidump binary from tooltool 08:34: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')]} 08:34:23 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 0x1268a30>, '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 0x12697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1269ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:34:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:34:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:34:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:34:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:34:23 INFO - Return code: 0 08:34:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:34:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:34:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:34:23 INFO - ENV: RUST_BACKTRACE is now 1 08:34:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:34:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/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 08:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/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 08:34:23 INFO - Using env: {'DISPLAY': ':0', 08:34:23 INFO - 'HOME': '/home/cltbld', 08:34:23 INFO - 'LANG': 'en_US.UTF-8', 08:34:23 INFO - 'LANGUAGE': 'en_US:en', 08:34:23 INFO - 'LOGNAME': 'cltbld', 08:34:23 INFO - 'MAIL': '/var/mail/cltbld', 08:34:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:34:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:23 INFO - 'MOZ_NO_REMOTE': '1', 08:34:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:34:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:23 INFO - 'NO_EM_RESTART': '1', 08:34:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:23 INFO - 'PWD': '/builds/slave/test', 08:34:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:34:23 INFO - 'RUST_BACKTRACE': '1', 08:34:23 INFO - 'SHELL': '/bin/bash', 08:34:23 INFO - 'SHLVL': '1', 08:34:23 INFO - 'TERM': 'linux', 08:34:23 INFO - 'TMOUT': '86400', 08:34:23 INFO - 'USER': 'cltbld', 08:34:23 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1494257148.633881-878491815', 08:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:23 INFO - '_': '/tools/buildbot/bin/python'} 08:34:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/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 08:34:23 INFO - mozversion application_buildid: 20170508145929 08:34:23 INFO - mozversion application_changeset: 38f862749aed4e9a874182a9019e0671289088b0 08:34:23 INFO - mozversion application_display_name: Nightly 08:34:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:34:23 INFO - mozversion application_name: Firefox 08:34:23 INFO - mozversion application_remotingname: firefox 08:34:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:34:23 INFO - mozversion application_vendor: Mozilla 08:34:23 INFO - mozversion application_version: 55.0a1 08:34:23 INFO - mozversion platform_buildid: 20170508145929 08:34:23 INFO - mozversion platform_changeset: 38f862749aed4e9a874182a9019e0671289088b0 08:34:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:34:23 INFO - mozversion platform_version: 55.0a1 08:34:23 INFO - using testdate: 1494257663 08:34:23 INFO - actual date: 1494257663 08:34:23 INFO - starting webserver on 'localhost:44494' 08:34:23 INFO - SUITE-START | Running 2 tests 08:34:23 INFO - TEST-START | dromaeo_css 08:34:23 INFO - operating with platform_type : linux_ 08:34:23 INFO - Initialising browser for dromaeo_css test... 08:34:23 INFO - TEST-INFO | started process 12117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiCO0ig/profile http://localhost:44494/getInfo.html) 08:34:28 INFO - PID 12117 | __metrics Screen width/height:1600/1200 08:34:28 INFO - PID 12117 | colorDepth:24 08:34:28 INFO - PID 12117 | Browser inner width/height: 1024/695 08:34:28 INFO - PID 12117 | __metrics 08:34:29 INFO - PID 12117 | 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" 08:34:29 INFO - PID 12117 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:34:30 INFO - TEST-INFO | 12117: exit 0 08:34:30 INFO - Browser initialized. 08:34:30 INFO - Running cycle 1/1 for dromaeo_css test... 08:34:30 INFO - TEST-INFO | started process 12219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiCO0ig/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:42 INFO - PID 12219 | RSS: Main: 167079936 08:34:42 INFO - PID 12219 | 08:37:48 INFO - PID 12219 | Cycle 1(1): loaded http://localhost:44494/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44494/tests/dromaeo/cssquery-ext.html) 08:37:50 INFO - PID 12219 | RSS: Main: 360103936 08:37:50 INFO - PID 12219 | 08:40:53 INFO - PID 12219 | Cycle 1(1): loaded http://localhost:44494/tests/dromaeo/cssquery-ext.html (next: http://localhost:44494/tests/dromaeo/cssquery-jquery.html) 08:40:53 INFO - PID 12219 | RSS: Main: 256159744 08:40:53 INFO - PID 12219 | 08:43:55 INFO - PID 12219 | Cycle 1(1): loaded http://localhost:44494/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44494/tests/dromaeo/cssquery-mootools.html) 08:43:56 INFO - PID 12219 | RSS: Main: 243392512 08:43:56 INFO - PID 12219 | 08:46:58 INFO - PID 12219 | Cycle 1(1): loaded http://localhost:44494/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44494/tests/dromaeo/cssquery-prototype.html) 08:46:59 INFO - PID 12219 | RSS: Main: 200511488 08:46:59 INFO - PID 12219 | 08:50:02 INFO - PID 12219 | Cycle 1(1): loaded http://localhost:44494/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44494/tests/dromaeo/cssquery-yui.html) 08:50:03 INFO - PID 12219 | RSS: Main: 203358208 08:50:03 INFO - PID 12219 | 08:53:05 INFO - PID 12219 | Cycle 1(1): loaded http://localhost:44494/tests/dromaeo/cssquery-yui.html (next: http://localhost:44494/tests/dromaeo/cssquery-dojo.html) 08:53:05 INFO - PID 12219 | RSS: Main: 291409920 08:53:05 INFO - PID 12219 | 08:53:05 INFO - PID 12219 | __start_tp_report 08:53:05 INFO - PID 12219 | _x_x_mozilla_page_load 08:53:05 INFO - PID 12219 | _x_x_mozilla_page_load_details 08:53:05 INFO - PID 12219 | |i|pagename|runs| 08:53:05 INFO - PID 12219 | |0;dojo.html;2696.7707744841687;2713.6472258606377;2745.0803980666465;2750.559910414333;2755.8208716433433;5088.338515992916;5161.587073034158;5192.483433291219;5196.2725218469395;5248.737563121843;5130.640855140142;5179.611529135311;5182.689038657673;5229.477052294768;5238.816641417551;4258.361245813137;4481.596656300932;4571.977140114294;4616.930746038812;4619.907601847961;4608.078384323132;4617.122746678137;4649.558291962258;4660.067986402716;4681.016986432854;4517.119161763458;4580.770961451914;4587.587117159438;4590.173768721629;4597.3793537872625;4592.632589392841;4594.241950078266;4601.3558101865765;4608.723476591415;4608.907821843578;4503.324501324795;4563.269876819693;4576.610988066019;4581.1753884300815;4586.862394128181;4964.776585053645;4973.801047958077;4980.900381992376;4981.975090124526;5031.6729412588065;5517.834464966018;5520.641158324736;5521.365043020064;5524.558035357202;5582.106862901916;5424.159255315432;5446.21029950655;5503.147012213113;5565.499105080522;5567.415421380778;5211.478852114834;5221.843344699665;5243.475652434726;5259.184826351921;5260.736963151827;5717;5772.191893134965;5772.7113644317615;5773.740181691834;5779.422057794271;5371.946280537145;5388.676679399248;5433.755481003285;5437.592180586472;5535.640183388067;5531.585131115102;5541.445855414507;5541.944580554143;5574.358948720868;5592.2730045094695;5473.75368108436;5485.61600687948;5492.670439773627;5492.780288788484;5495.2856128703015;5392.191171324333;5482.890342193134;5486;5491.258680078218;5547.445255474501;4601.953980460153;4619.769011549476;4648.628109751212;4651.488336283006;4653.604443622262;3929.842806287774;3943.2507823514015;3964.702647301464;4000.7999600019884;4007.919841603152;4645.46577143626;4736.455307639666;4750.976245118822;4752.7385993769985;4752.7385993769985;5561.5272701820795;5561.63849349791;5682.119271512922;5685.687287199161;5690.146478028246;4744.217204161344;4765.332853400527;4768.809247630125;4770.642201834877;4812.759362031955;4959.181735013754;4966.701997880066;4969.701817890938;4972.801087956441;5020.272060551272;5136.9743151284;5167.58659307262;5203.895922081613;5276.023935571931;5277.050130976308;5635.802746903839;5646.237757902795;5648.181013752901;5650.63270887391;5684.488396044376;5218.869528261824;5243.213517972335;5254.080535906278;5261.394939581997;5317.415084340797;5377.784888604412;5413.648112872651;5457.017736807254;5469.972650136724;5543.307086614173;5571.331440227199;5576.219329293983;5578.107502799533;5580.77676892936;5583.55331573465;5312.043832110257;5370.301860758076;5379.919301210407;5383.057964856056;5385.649932754359;5409.0263752524925;5410.188471729272;5412.539934105645;5415.810446634349;5417.674939503642;5296.947030529799;5328.813491527778;5330.120530112643;5361.115415956479;5368.033753924331;5433.5109840113;5438.592105592017;5439;5439.5104440600535;5446.428125046813;5208.9739551302;5263.184206448007;5280.973595132;5298.549623282064;5348.384935732441 08:53:05 INFO - PID 12219 | |1;ext.html;716.7563028570287;731.0131322714336;1026.8562401263819;1029.4183786160818;1044.8171569975257;28128.859355703218;30973.690263097364;31373.215669608242;31381.52927706086;31432.842835785847;32834.50748238772;33144;33181.33637327252;33213.169670758245;33307.50038749415;5148.74256287186;5290.470952904698;6612.437942774858;6665.8333541661605;6715.160604924385;6678.232003319632;6870.278620744824;6870.896936545956;6875.484338674594;6876.346747059047;6864.828379290508;6914.688839002257;6921;6922.169339679245;6974;5151.0470562945975;5272.710000949946;6666.966665166643;6865.210500792398;6889.586624802503;6763.492738044666;6832.350926661959;6834.2140653824945;6836.521443498957;6841.042254084432;28984.42031159386;29240.707592924013;29271;29346.559801602994;29473.852630736925;2941.749951254146;2968.7921845470823;2969.732724054845;2971.272038350596;2972.078655616766;23146.42133946648;23224.4193895154;23225.535489290287;23252.53494930092;23322.183723569593;2769.62610047643;2778.1526634376505;2786.178077467152;2789.6373471448783;2879.8992035278875;138180.30909845486;138905;139382;139528;139808.99999999898;33575.328493429995;34123.4881476778;34142.31715365679;39100.41349379761;39193.41209881854;35164.296714065575;35679.28641427157;39507.60492395097;41204.587954120674;41238.79380603078;12270.202436841577;12591.622251332476;12610.81083783744;12622.431990560446;12636.936815315865;10110.494475276353;10132.696019119438;10133.138683211862;10138.087572118544;10142.492875356204;12321.630351089481;12378.195417297848;12394.81407778884;12446.626601201979;12563.120581559204;5142.228665700175;5156.948430515647;5162.793488260428;5176;5216.921746173811;885.9025507194203;898.8471959766855;910.6175406329357;920.6639576554643;940.8118376324762;19421.2231510738;20337.49156271105;20502.897485512774;20808.167673292897;20810.583788324147;966.1353088985319;975.7024107647094;985.2265971212707;988.5551501824208;1018.1956254558963;10047.949760251153;10688.625898093685;10791.730206744895;10850.620228291971;10942.507587158598;172325;174100;174270.12864935593;174434;174813;37908.81045594755;37983;37988;38046;38074.80962595169;1205.7046023724245;1237.4864431261105;1242.8260043593905;1247.0896245740478;1260.1997731440601;19081;19619.70570441416;20098.497537561678;20144.899275504114;20437.284695035603;28024.57963130514;28046.71953280441;28048.57927131054;28081.297967550974;28127.156185314474;148161;148343.2582837079;149152;149305;149339;23716.288511344686;24089.638655419833;27028.729712703407;27368.726312737414;27778.166655000383;33105.50341744828;33133.83433082819;33140.83429582837;33476.330473389906;33518;23853;24705.50588988246;24893.377665558506;25486.23541293764;26057.439948009403;25129;25182.11862584801;25236.62145067862;25367.112151075362;26638.200853974413;28406.43187136287;28413.289667758472;28437.289067772643;28522.857385712938;28524.144275671762;24282.757172428755;24632.13787517428;24916.981564181522;25310.240692779247;25385.873070634527;20613;21870.781292187512;22008.559828803012;22184.445388864762;22263.888680556494 08:53:05 INFO - PID 12219 | |2;jquery.html;397.1005672152575;400.5953986473661;401.2736946127508;419.1554018652415;421.22915065430266;15633.609159771011;16076.919615401921;16811;16830.663386732274;16931.83068169321;17037.57406064849;17286.56783580411;17402.47792566225;17826.376076837314;18192.90903545484;5209.21861720743;5225.268462415255;5461.726913654321;5477.424870388611;5481;5310.946890531103;5408;5412.621116521845;5414.810481633143;5422.457754224585;5249.081410753122;5379.542738867201;5387.811426600069;5436.91844622331;5441.564674826004;5304.443033481487;5374.274472946141;5381.569474442035;5401.081816091274;5414.296141501619;4819.614430845524;4878.634102442331;4886.53577910098;4891.1195984722735;4894.070126675921;21766.693998360148;21812;22266.443338916495;22379.216727414627;22505.21231756897;1634.1012443156335;1648.2006226979904;1660.6844699507055;1660.7591899174672;1661.2192269633254;14098.71802563943;14600.415983360654;14757.55727328171;14917.403303867832;14925.402983880631;2020.979790202094;2057.722207501998;2116.502621883856;2116.5766846630736;2122.405726396596;72101;88027.55986220091;88523;90031.54984225103;91900.54049729776;10591.311564748266;10671.46642667879;10700.571977120828;10945.726356841144;11001.779964400666;14770.335334909954;14786;14808.62978425548;14817.40730370773;14856.108633482027;7380.630968451664;7558.319751222416;7730.497517661334;7801.141874393812;7811;6975.128108986377;6988.615626140611;7044.542104763174;7232.421406287484;7297.270272972661;6955.269696681877;6988.860222795617;7009.579425234502;7021.591245193709;7092.397146242524;2022.0900594732136;2034.6846238833004;2059.7631272403564;2071.4717746974725;2236.530328630973;878.8154487557557;904.6607522179182;909.4497828813605;914.9817003659889;937.5171786529943;16816.74774878378;16952.660946780994;17513.47459576215;17670.204840782197;17940.372086976895;902.3142411766974;909.4497828813472;910.8906931168169;925.8842644669417;928.3223247029706;9076;9399;9644.373115747454;9758.17055550272;9901.702948911545;340573;341613;342244;348428;355309;75810.62094689491;77299;78394;78808.60595696984;80132.59933700411;1105.5467258424007;1132.592266783957;1163.3485248261002;1165.318288801044;1168.6260396673154;16797;17129;17578.82421175823;18050.194980501845;19203.21553374725;40743.1851362977;41326.38010429786;41569.79215104026;41882.37176442295;42595.787021064694;47582.762086189345;48125;49632.50367496279;49845.252321215936;50004;8166.510009399455;8316.50100993918;8325.916740832514;8376.246137847624;8383.58082095905;13606.183628982293;13626.591202263948;13724;13758.65603359924;13917.443302267797;11644.767104658029;11832.881671183179;11865.347405892413;11873;12219.26684398939;10312.535935882754;10533.894661053291;10631.734206644896;10937.56249750001;11115.888841111486;11579.942100289445;11695.356755378536;11867.109966752701;11899.583514576949;12376.319302438093;8228.3005944493;8263.710770123258;8326.542040187847;8424.915750842412;8453.66185352579;11060.723481913017;11244.381559014006;11554.711132221762;11620.360880151673;11925.165238433574 08:53:05 INFO - PID 12219 | |3;mootools.html;1303.9162380969008;1346.3672074125163;1355.2139758939823;1361.285325204268;1373.2721657521504;9233.7691557711;9654.710358689234;9655.806883862328;9657.710268691933;9658.903410965888;9321.114494123047;9440.244780417568;9460.432374057562;9555.092266234715;9567.760805979853;2071.8860462674547;2103.2112957640884;2105.378913220596;2105.768365479796;2108.462342102762;1843.9262429502871;2110.3246960972497;2157.2449642625033;2178.8583742056717;2211.9778802212013;1783.7948635906841;2063.6698128299477;2201;2220.467087898901;2237.3623517297574;2213.656883183109;2258.4015235962565;2261.604219261639;2264.388615073921;2265.037359122383;2175.5540114276537;2225.63277059285;2226.109556177526;2227.9220227291967;2228.8885555722313;9286.257099432029;9460.85808712863;9464.242860571207;9474.194693451065;9477.052294770538;5098.311727916721;5323.30796996388;5325.653832500875;5333.4399888011585;5334.706591137486;3014.623172103487;3145.213696575856;3226.6934641209045;3227.3222623249144;3229.951550726741;1001.3841487485145;1010.4998025977114;1016.2885979814085;1047.9685609431729;1049.4962418039308;13020.804687929689;13207.801882971668;13283.86716132836;13342.733145337039;13352.666183345495;4858.368412106474;4911.705297682151;5022.196448568212;5038.3198268234055;5101.438841727407;11875.643730688093;11883.346415947206;11885.702857428634;11913.880861191277;11917.582884598998;5629.324481062299;5638.689872057076;5642.4075472075665;5649.152627105885;5655.745491452894;4742.620590352833;4745.620350371962;4812.230043193073;4817.662763606584;4976.701397916137;4040.595940405936;4089.161721847014;4094.590540945941;4168.645665118438;4196.853110141192;1311.2525860259561;1333.419962316376;1341.7987301904793;1344.193483909666;1368.609946165338;723.4284914917157;745.0537816972414;746.3618606091713;748.9251074892467;759.1990450075224;5482.780688772485;5486.725663716798;5570.2480165177185;5574.1917421973585;5615.747291371817;528.8519214619913;554.9944500555024;555.2670474972997;559.2617744577201;560.28563581434;3384.4754063120254;3456.723462123024;3523.066387407288;3525.3654342218133;3594.964050359515;12033.217840840318;12353.876461235452;12525.624231273076;12540.372981350896;12559.681233470537;11955.342456164994;12251.571195008131;12328.19866708661;12347.38263086842;12361.505539778487;6437.195350581177;6690.096836927147;6807.183138023469;6882.69027893746;6906.516543841883;6030.185924900083;6059.969700151471;6153.4154255345675;6212.534059945612;6395.616263024233;11068.7824339321;11113.110951123728;11149.609763658233;11228.606998755004;11240.494177762184;11074.335539867312;11237.38194399316;11263.831042534204;11545.942270288595;11614.187006909435;7525.661345239587;7711.575863327346;7714.267144621252;7719.382449403922;7720.420968427278;8463.66145354179;8687.522186279815;8740.781480462785;8795.076516965883;8799.956000219958;7932.444728868923;7969.322607578189;7977.44157908964;8009.359251259769;8065.112837587978;7173.748918787817;7416.221296763762;7436.96281518589;7467.775966721007;7469.887951680837;6788.490863185182;6888.690008949709;6892.862142757217;6896.931030689629;6897.931020689729;5026.572741317029;5030.3963524377305;5091.796328146981;5150.0472412603785;5278.630495865253;5384.111621582395;5396.811111611075;5434.592405569519;5570.637908535932;5604.8318550443555 08:53:05 INFO - PID 12219 | |4;prototype.html;379.5938345969812;379.8044007336224;384.99230015399695;387.242940052198;387.67048009192183;5367.221752845835;5374.865628359288;5394.595405344605;5403.567714582834;5422.593305502083;5067.949320506794;5293.947060529394;5309.442508536606;5320.787168513264;5325.840224793253;4289.442372491588;4289.656827453796;4300.032492689135;4304.3643415502065;4316.97841510792;4309.095090031097;4317.525072242051;4323.913521729563;4328.091100868822;4330.84842030529;4164.500779719298;4256.2764330063965;4271.78641067947;4290.957090429102;4303.505096913848;4260.31834906415;4264.23243816113;4274.658027357819;4286.678499112548;4286.978565107154;3883.728139030269;3884.844606215748;3887.941680874789;3888.5333759948703;3889.8055097245306;5085.338905942241;5227.843164705065;5228.5555727763185;5249.921251181236;5271.551918086967;4992.80172758539;5045.142325804585;5056;5058.772355244023;5061.291419201315;5730.713464326767;5735.799247026376;5741.856453588652;5759.712014399305;5761.798337058183;4275.914481710349;4354.934675979863;4357.3899654048455;4366.410534577855;4373.737575745466;5743.4543718346695;5906.793262235844;5909.438603332676;5985.221921150266;6109.297430795471;4452.977735111303;4453.532379100213;4466.3523789050405;4466.821327146943;4476.903158726068;4364.716293440916;4547.15877562652;4547.545245475426;4548.431446069241;4573.291139873325;4901.6668665307225;4933.112039832865;5000.099982003201;5038.79844806211;5042.495750424928;5721.942780572224;5726.828195154152;5729.7708091676695;5732.856678582985;5737.3688894221605;1559.688062387527;1566.929488173035;1573.339197537037;1589.737693280619;1595.197426907587;1096.6709987003867;1109.1698697149768;1116.3246236027087;1125.5666568371073;1144.5822274869613;4966.478519755446;4975.154223781966;4976.502349765067;4992.151334273182;4996.90006199874;5872.647641141545;5896.734646940898;5897.852553686106;5903.173555702205;5910.7291932234775;4756.7145971241835;4890.290907818347;4913.975430122827;4938.802447902043;4953.653244272867;3061.6326040875238;3117.9220519487194;3127.390158918989;3131.9217019574694;3135.2318681923075;5454.4545545445135;5455.1271796512365;5456.263404440429;5456.48163424474;5483.369412517532;5773.711314434346;6009.759609615654;6068.544859135583;6071.241094863142;6073.878522429527;5470.91793623096;5480.547654871462;5491.203775452537;5496.477834605706;5504.2294078829;5738.1679656450415;5879.441453061952;5896.823095307148;5899.793507227227;5904.350521442724;5521.641093328921;5655.915161272502;5767.653940763567;5796.797112101225;5804.448577385142;5313.867153321198;5496.422875598005;5508.338999320107;5513.751881165277;5522.22688823573;4042.3936409537628;4050.7164498486004;4059.3505039193587;4071.75569465833;4075.2257071156387;5689.601727879009;5905.557083218861;5925.703714814328;5932.703364831655;5933.614315069507;5714.285714285715;5714.771324165325;5718.542516598745;5731.684757338219;5740.225069615715;5531.419200983839;5722.484976352148;5734.655920644775;5737;5748.137779333133;5586.553075754011;5620.718964051863;5627.352854421794;5628.802991895264;5631.211630371833;5724;5759.193712880284;5761.625494342854;5765;5768.971155144198;5262.789488420421;5519.558435325244;5591.077472217039;5594.580406469612;5600.915986260291 08:53:05 INFO - PID 12219 | |5;yui.html;747.1034758290053;754.777340684498;764.6253335865426;768.8154842837718;789.2029050658834;12958.287294198815;13828.792568111487;13855.307234638278;13884.444622215113;13892.861071389296;14630.853691463082;15853;15912;15926;15952.680946381066;876.1282523888724;889.9065598112202;891.790429249126;894.6287290774321;894.8255090257402;882.5322579033123;885.5970533407317;893.4371346052011;893.530896279452;895.4537731983485;891.2914233184601;921.5576523268835;928.9721308360727;929.0430856218106;930.2093220762365;913.9999999999967;919.296737995434;921.5162039929057;921.7511271956602;923.1138107416888;670.0786418674322;671.6037537852642;671.8320419895026;671.8320419895026;672.0524061073862;13331.866681333257;13373.66565835852;13580.932095339558;13713.931430342884;13727.519536816164;15658.451954181663;15728.842711572852;15977.760333595006;16076.919615401848;16096.114713690742;12422.316772577504;12513.687157821036;12666.746665066647;12685.682857928534;12699.746005079847;2940.2355387599378;2957.911262662102;2962.481565726011;2962.9407411851644;2972.1083674897445;61677.383226167614;61697.38302616961;61921;63484;70785.29214707839;12074.758504829853;12408.441620127116;12444.502219911283;12562.05784566143;12573.559925402567;20583.176672932914;20898;21097.789022109584;21104.89447552783;21463.46341341479;5187.948120518747;5339.332583427072;5348.358197016383;5353.223782551586;5411.107167317348;3069.9846500767353;3099.9070027899197;3108.1452600535035;3131.6711745266875;3133.122725636825;3439.226174110855;3510.297940411928;3597.8560857565403;3683.5027271318563;3687.0597997510463;687.8693048320803;689.1695506914157;689.2418339826152;691.4986634689809;692.9341712537301;540.1627477409999;552.1414200917532;554.7503623369419;555.5000499550356;559.233849626015;9445.338826282094;10100.545475453475;10117.747056323651;10288.897111028944;10470.842937355947;506.33164223225725;514.5677630790154;514.9613778966518;522.7020598259032;527.6965744696814;4028.48931650631;4144.295469770146;4149.232392007489;4299.204647140289;4306.590873866978;57833.710831445576;57979.71010144922;61329.69335153296;63016;63515;50929.490705093216;51595.22607160896;51613;51751.74124129431;51822.74088629533;34792.65207347945;47419.5258047422;47889.52110478851;48159.073637054826;50258.49741502611;10451.268411211142;10460.372377657364;10562;10814.56741730322;10993.61522346714;24660.753392465846;25173.118940836983;25734.485310294065;26174;26619.20142395731;41439.171216576106;41844.58155418407;42434.5756542443;42536.78731606322;42788.14423711446;13200.943924485826;13298.335083245605;13347.799783003456;13439.932800335935;13620.52328168549;13561.050726449448;13633.182009079486;13771.517996870061;14232.288385580887;14264.215468148936;12581;12634.684132896384;12667.746645066863;12746.553870614483;12901.806472902726;13486.527971520949;13579.45682172702;13706.24615646149;13804.93097534506;13908.374123164684;12034.157608967289;12299.385030748606;12310.199837010565;12379.381030948596;12388.132830701765;9634.807303853744;9829.716726888126;9888.110070093726;10305.845412318971;10394.116500097576;10154.949225253826;10211.693649190536;10305.639302624371;10503;10672.146228301872 08:53:05 INFO - PID 12219 | __end_tp_report 08:53:05 INFO - PID 12219 | __start_cc_report 08:53:05 INFO - PID 12219 | _x_x_mozilla_cycle_collect,2368 08:53:05 INFO - PID 12219 | __end_cc_report 08:53:05 INFO - PID 12219 | __startTimestamp1494258785643__endTimestamp 08:53:05 INFO - PID 12219 | 08:53:05 INFO - PID 12219 | ------- Summary: start ------- 08:53:05 INFO - PID 12219 | Number of tests: 6 08:53:05 INFO - PID 12219 | 08:53:05 INFO - PID 12219 | [#0] dojo.html Cycles:165 Average:5081.31 Median:5261.39 stddev:594.27 (11.3%) stddev-sans-first:565.88 08:53:05 INFO - PID 12219 | Values: 2696.8 2713.6 2745.1 2750.6 2755.8 5088.3 5161.6 5192.5 5196.3 5248.7 5130.6 5179.6 5182.7 5229.5 5238.8 4258.4 4481.6 4572.0 4616.9 4619.9 4608.1 4617.1 4649.6 4660.1 4681.0 4517.1 4580.8 4587.6 4590.2 4597.4 4592.6 4594.2 4601.4 4608.7 4608.9 4503.3 4563.3 4576.6 4581.2 4586.9 4964.8 4973.8 4980.9 4982.0 5031.7 5517.8 5520.6 5521.4 5524.6 5582.1 5424.2 5446.2 5503.1 5565.5 5567.4 5211.5 5221.8 5243.5 5259.2 5260.7 5717.0 5772.2 5772.7 5773.7 5779.4 5371.9 5388.7 5433.8 5437.6 5535.6 5531.6 5541.4 5541.9 5574.4 5592.3 5473.8 5485.6 5492.7 5492.8 5495.3 5392.2 5482.9 5486.0 5491.3 5547.4 4602.0 4619.8 4648.6 4651.5 4653.6 3929.8 3943.3 3964.7 4000.8 4007.9 4645.5 4736.5 4751.0 4752.7 4752.7 5561.5 5561.6 5682.1 5685.7 5690.1 4744.2 4765.3 4768.8 4770.6 4812.8 4959.2 4966.7 4969.7 4972.8 5020.3 5137.0 5167.6 5203.9 5276.0 5277.1 5635.8 5646.2 5648.2 5650.6 5684.5 5218.9 5243.2 5254.1 5261.4 5317.4 5377.8 5413.6 5457.0 5470.0 5543.3 5571.3 5576.2 5578.1 5580.8 5583.6 5312.0 5370.3 5379.9 5383.1 5385.6 5409.0 5410.2 5412.5 5415.8 5417.7 5296.9 5328.8 5330.1 5361.1 5368.0 5433.5 5438.6 5439.0 5439.5 5446.4 5209.0 5263.2 5281.0 5298.5 5348.4 08:53:05 INFO - PID 12219 | 08:53:05 INFO - PID 12219 | [#1] ext.html Cycles:180 Average:28825.48 Median:28064.94 stddev:39875.32 (142.1%) stddev-sans-first:39931.32 08:53:05 INFO - PID 12219 | Values: 716.8 731.0 1026.9 1029.4 1044.8 28128.9 30973.7 31373.2 31381.5 31432.8 32834.5 33144.0 33181.3 33213.2 33307.5 5148.7 5290.5 6612.4 6665.8 6715.2 6678.2 6870.3 6870.9 6875.5 6876.3 6864.8 6914.7 6921.0 6922.2 6974.0 5151.0 5272.7 6667.0 6865.2 6889.6 6763.5 6832.4 6834.2 6836.5 6841.0 28984.4 29240.7 29271.0 29346.6 29473.9 2941.7 2968.8 2969.7 2971.3 2972.1 23146.4 23224.4 23225.5 23252.5 23322.2 2769.6 2778.2 2786.2 2789.6 2879.9 138180.3 138905.0 139382.0 139528.0 139809.0 33575.3 34123.5 34142.3 39100.4 39193.4 35164.3 35679.3 39507.6 41204.6 41238.8 12270.2 12591.6 12610.8 12622.4 12636.9 10110.5 10132.7 10133.1 10138.1 10142.5 12321.6 12378.2 12394.8 12446.6 12563.1 5142.2 5156.9 5162.8 5176.0 5216.9 885.9 898.8 910.6 920.7 940.8 19421.2 20337.5 20502.9 20808.2 20810.6 966.1 975.7 985.2 988.6 1018.2 10047.9 10688.6 10791.7 10850.6 10942.5 172325.0 174100.0 174270.1 174434.0 174813.0 37908.8 37983.0 37988.0 38046.0 38074.8 1205.7 1237.5 1242.8 1247.1 1260.2 19081.0 19619.7 20098.5 20144.9 20437.3 28024.6 28046.7 28048.6 28081.3 28127.2 148161.0 148343.3 149152.0 149305.0 149339.0 23716.3 24089.6 27028.7 27368.7 27778.2 33105.5 33133.8 33140.8 33476.3 33518.0 23853.0 24705.5 24893.4 25486.2 26057.4 25129.0 25182.1 25236.6 25367.1 26638.2 28406.4 28413.3 28437.3 28522.9 28524.1 24282.8 24632.1 24917.0 25310.2 25385.9 20613.0 21870.8 22008.6 22184.4 22263.9 08:53:05 INFO - PID 12219 | 08:53:05 INFO - PID 12219 | [#2] jquery.html Cycles:180 Average:24313.91 Median:398.85 stddev:57754.93 (14480.4%) stddev-sans-first:57889.03 08:53:05 INFO - PID 12219 | Values: 397.1 400.6 401.3 419.2 421.2 15633.6 16076.9 16811.0 16830.7 16931.8 17037.6 17286.6 17402.5 17826.4 18192.9 5209.2 5225.3 5461.7 5477.4 5481.0 5310.9 5408.0 5412.6 5414.8 5422.5 5249.1 5379.5 5387.8 5436.9 5441.6 5304.4 5374.3 5381.6 5401.1 5414.3 4819.6 4878.6 4886.5 4891.1 4894.1 21766.7 21812.0 22266.4 22379.2 22505.2 1634.1 1648.2 1660.7 1660.8 1661.2 14098.7 14600.4 14757.6 14917.4 14925.4 2021.0 2057.7 2116.5 2116.6 2122.4 72101.0 88027.6 88523.0 90031.5 91900.5 10591.3 10671.5 10700.6 10945.7 11001.8 14770.3 14786.0 14808.6 14817.4 14856.1 7380.6 7558.3 7730.5 7801.1 7811.0 6975.1 6988.6 7044.5 7232.4 7297.3 6955.3 6988.9 7009.6 7021.6 7092.4 2022.1 2034.7 2059.8 2071.5 2236.5 878.8 904.7 909.4 915.0 937.5 16816.7 16952.7 17513.5 17670.2 17940.4 902.3 909.4 910.9 925.9 928.3 9076.0 9399.0 9644.4 9758.2 9901.7 340573.0 341613.0 342244.0 348428.0 355309.0 75810.6 77299.0 78394.0 78808.6 80132.6 1105.5 1132.6 1163.3 1165.3 1168.6 16797.0 17129.0 17578.8 18050.2 19203.2 40743.2 41326.4 41569.8 41882.4 42595.8 47582.8 48125.0 49632.5 49845.3 50004.0 8166.5 8316.5 8325.9 8376.2 8383.6 13606.2 13626.6 13724.0 13758.7 13917.4 11644.8 11832.9 11865.3 11873.0 12219.3 10312.5 10533.9 10631.7 10937.6 11115.9 11579.9 11695.4 11867.1 11899.6 12376.3 8228.3 8263.7 8326.5 8424.9 8453.7 11060.7 11244.4 11554.7 11620.4 11925.2 08:53:05 INFO - PID 12219 | 08:53:05 INFO - PID 12219 | [#3] mootools.html Cycles:180 Average:5993.07 Median:4944.20 stddev:3730.68 (75.5%) stddev-sans-first:3724.51 08:53:05 INFO - PID 12219 | Values: 1303.9 1346.4 1355.2 1361.3 1373.3 9233.8 9654.7 9655.8 9657.7 9658.9 9321.1 9440.2 9460.4 9555.1 9567.8 2071.9 2103.2 2105.4 2105.8 2108.5 1843.9 2110.3 2157.2 2178.9 2212.0 1783.8 2063.7 2201.0 2220.5 2237.4 2213.7 2258.4 2261.6 2264.4 2265.0 2175.6 2225.6 2226.1 2227.9 2228.9 9286.3 9460.9 9464.2 9474.2 9477.1 5098.3 5323.3 5325.7 5333.4 5334.7 3014.6 3145.2 3226.7 3227.3 3230.0 1001.4 1010.5 1016.3 1048.0 1049.5 13020.8 13207.8 13283.9 13342.7 13352.7 4858.4 4911.7 5022.2 5038.3 5101.4 11875.6 11883.3 11885.7 11913.9 11917.6 5629.3 5638.7 5642.4 5649.2 5655.7 4742.6 4745.6 4812.2 4817.7 4976.7 4040.6 4089.2 4094.6 4168.6 4196.9 1311.3 1333.4 1341.8 1344.2 1368.6 723.4 745.1 746.4 748.9 759.2 5482.8 5486.7 5570.2 5574.2 5615.7 528.9 555.0 555.3 559.3 560.3 3384.5 3456.7 3523.1 3525.4 3595.0 12033.2 12353.9 12525.6 12540.4 12559.7 11955.3 12251.6 12328.2 12347.4 12361.5 6437.2 6690.1 6807.2 6882.7 6906.5 6030.2 6060.0 6153.4 6212.5 6395.6 11068.8 11113.1 11149.6 11228.6 11240.5 11074.3 11237.4 11263.8 11545.9 11614.2 7525.7 7711.6 7714.3 7719.4 7720.4 8463.7 8687.5 8740.8 8795.1 8800.0 7932.4 7969.3 7977.4 8009.4 8065.1 7173.7 7416.2 7437.0 7467.8 7469.9 6788.5 6888.7 6892.9 6896.9 6897.9 5026.6 5030.4 5091.8 5150.0 5278.6 5384.1 5396.8 5434.6 5570.6 5604.8 08:53:05 INFO - PID 12219 | 08:53:05 INFO - PID 12219 | [#4] prototype.html Cycles:180 Average:4774.10 Median:5267.17 stddev:1336.89 (25.4%) stddev-sans-first:1299.32 08:53:05 INFO - PID 12219 | Values: 379.6 379.8 385.0 387.2 387.7 5367.2 5374.9 5394.6 5403.6 5422.6 5067.9 5293.9 5309.4 5320.8 5325.8 4289.4 4289.7 4300.0 4304.4 4317.0 4309.1 4317.5 4323.9 4328.1 4330.8 4164.5 4256.3 4271.8 4291.0 4303.5 4260.3 4264.2 4274.7 4286.7 4287.0 3883.7 3884.8 3887.9 3888.5 3889.8 5085.3 5227.8 5228.6 5249.9 5271.6 4992.8 5045.1 5056.0 5058.8 5061.3 5730.7 5735.8 5741.9 5759.7 5761.8 4275.9 4354.9 4357.4 4366.4 4373.7 5743.5 5906.8 5909.4 5985.2 6109.3 4453.0 4453.5 4466.4 4466.8 4476.9 4364.7 4547.2 4547.5 4548.4 4573.3 4901.7 4933.1 5000.1 5038.8 5042.5 5721.9 5726.8 5729.8 5732.9 5737.4 1559.7 1566.9 1573.3 1589.7 1595.2 1096.7 1109.2 1116.3 1125.6 1144.6 4966.5 4975.2 4976.5 4992.2 4996.9 5872.6 5896.7 5897.9 5903.2 5910.7 4756.7 4890.3 4914.0 4938.8 4953.7 3061.6 3117.9 3127.4 3131.9 3135.2 5454.5 5455.1 5456.3 5456.5 5483.4 5773.7 6009.8 6068.5 6071.2 6073.9 5470.9 5480.5 5491.2 5496.5 5504.2 5738.2 5879.4 5896.8 5899.8 5904.4 5521.6 5655.9 5767.7 5796.8 5804.4 5313.9 5496.4 5508.3 5513.8 5522.2 4042.4 4050.7 4059.4 4071.8 4075.2 5689.6 5905.6 5925.7 5932.7 5933.6 5714.3 5714.8 5718.5 5731.7 5740.2 5531.4 5722.5 5734.7 5737.0 5748.1 5586.6 5620.7 5627.4 5628.8 5631.2 5724.0 5759.2 5761.6 5765.0 5769.0 5262.8 5519.6 5591.1 5594.6 5600.9 08:53:05 INFO - PID 12219 | 08:53:05 INFO - PID 12219 | [#5] yui.html Cycles:180 Average:14657.45 Median:3286.17 stddev:16943.48 (515.6%) stddev-sans-first:16958.81 08:53:05 INFO - PID 12219 | Values: 747.1 754.8 764.6 768.8 789.2 12958.3 13828.8 13855.3 13884.4 13892.9 14630.9 15853.0 15912.0 15926.0 15952.7 876.1 889.9 891.8 894.6 894.8 882.5 885.6 893.4 893.5 895.5 891.3 921.6 929.0 929.0 930.2 914.0 919.3 921.5 921.8 923.1 670.1 671.6 671.8 671.8 672.1 13331.9 13373.7 13580.9 13713.9 13727.5 15658.5 15728.8 15977.8 16076.9 16096.1 12422.3 12513.7 12666.7 12685.7 12699.7 2940.2 2957.9 2962.5 2962.9 2972.1 61677.4 61697.4 61921.0 63484.0 70785.3 12074.8 12408.4 12444.5 12562.1 12573.6 20583.2 20898.0 21097.8 21104.9 21463.5 5187.9 5339.3 5348.4 5353.2 5411.1 3070.0 3099.9 3108.1 3131.7 3133.1 3439.2 3510.3 3597.9 3683.5 3687.1 687.9 689.2 689.2 691.5 692.9 540.2 552.1 554.8 555.5 559.2 9445.3 10100.5 10117.7 10288.9 10470.8 506.3 514.6 515.0 522.7 527.7 4028.5 4144.3 4149.2 4299.2 4306.6 57833.7 57979.7 61329.7 63016.0 63515.0 50929.5 51595.2 51613.0 51751.7 51822.7 34792.7 47419.5 47889.5 48159.1 50258.5 10451.3 10460.4 10562.0 10814.6 10993.6 24660.8 25173.1 25734.5 26174.0 26619.2 41439.2 41844.6 42434.6 42536.8 42788.1 13200.9 13298.3 13347.8 13439.9 13620.5 13561.1 13633.2 13771.5 14232.3 14264.2 12581.0 12634.7 12667.7 12746.6 12901.8 13486.5 13579.5 13706.2 13804.9 13908.4 12034.2 12299.4 12310.2 12379.4 12388.1 9634.8 9829.7 9888.1 10305.8 10394.1 10154.9 10211.7 10305.6 10503.0 10672.1 08:53:05 INFO - PID 12219 | -------- Summary: end -------- 08:53:05 INFO - PID 12219 | 08:53:06 INFO - TEST-INFO | 12219: exit 0 08:53:06 INFO - TEST-OK | dromaeo_css | took 1123134ms 08:53:06 INFO - TEST-START | kraken 08:53:06 INFO - operating with platform_type : linux_ 08:53:06 INFO - Initialising browser for kraken test... 08:53:06 INFO - TEST-INFO | started process 12554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2YGysp/profile http://localhost:44494/getInfo.html) 08:53:10 INFO - PID 12554 | __metrics Screen width/height:1600/1200 08:53:10 INFO - PID 12554 | colorDepth:24 08:53:10 INFO - PID 12554 | Browser inner width/height: 1024/695 08:53:10 INFO - PID 12554 | __metrics 08:53:11 INFO - PID 12554 | 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" 08:53:11 INFO - PID 12554 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:53:12 INFO - TEST-INFO | 12554: exit 0 08:53:12 INFO - Browser initialized. 08:53:12 INFO - Running cycle 1/1 for kraken test... 08:53:12 INFO - TEST-INFO | started process 12657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2YGysp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:24 INFO - PID 12657 | RSS: Main: 167616512 08:53:24 INFO - PID 12657 | 08:53:27 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44494/tests/kraken/driver.html?testName=audio-beat-detection) 08:53:28 INFO - PID 12657 | RSS: Main: 243703808 08:53:28 INFO - PID 12657 | 08:53:31 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44494/tests/kraken/driver.html?testName=audio-dft) 08:53:32 INFO - PID 12657 | RSS: Main: 203923456 08:53:32 INFO - PID 12657 | 08:53:35 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44494/tests/kraken/driver.html?testName=audio-fft) 08:53:35 INFO - PID 12657 | RSS: Main: 287199232 08:53:35 INFO - PID 12657 | 08:53:37 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44494/tests/kraken/driver.html?testName=audio-oscillator) 08:53:38 INFO - PID 12657 | RSS: Main: 199741440 08:53:38 INFO - PID 12657 | 08:53:40 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44494/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:53:41 INFO - PID 12657 | RSS: Main: 201109504 08:53:41 INFO - PID 12657 | 08:53:44 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44494/tests/kraken/driver.html?testName=imaging-darkroom) 08:53:44 INFO - PID 12657 | RSS: Main: 262414336 08:53:44 INFO - PID 12657 | 08:53:48 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44494/tests/kraken/driver.html?testName=imaging-desaturate) 08:53:49 INFO - PID 12657 | RSS: Main: 262504448 08:53:49 INFO - PID 12657 | 08:53:52 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44494/tests/kraken/driver.html?testName=json-parse-financial) 08:53:52 INFO - PID 12657 | RSS: Main: 260521984 08:53:52 INFO - PID 12657 | 08:53:54 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44494/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:53:54 INFO - PID 12657 | RSS: Main: 224583680 08:53:54 INFO - PID 12657 | 08:53:56 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44494/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:53:57 INFO - PID 12657 | RSS: Main: 231682048 08:53:57 INFO - PID 12657 | 08:53:59 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44494/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:54:00 INFO - PID 12657 | RSS: Main: 240340992 08:54:00 INFO - PID 12657 | 08:54:02 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:54:03 INFO - PID 12657 | RSS: Main: 245415936 08:54:03 INFO - PID 12657 | 08:54:06 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:54:07 INFO - PID 12657 | RSS: Main: 227000320 08:54:07 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | Cycle 1(1): loaded http://localhost:44494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44494/tests/kraken/driver.html?testName=ai-astar) 08:54:09 INFO - PID 12657 | RSS: Main: 295358464 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | __start_tp_report 08:54:09 INFO - PID 12657 | _x_x_mozilla_page_load 08:54:09 INFO - PID 12657 | _x_x_mozilla_page_load_details 08:54:09 INFO - PID 12657 | |i|pagename|runs| 08:54:09 INFO - PID 12657 | |0;ai-astar;109;114;113;112;111;113;112;111;112;112 08:54:09 INFO - PID 12657 | |1;audio-beat-detection;152;127;124;167;131;132;130;120;141;123 08:54:09 INFO - PID 12657 | |2;audio-dft;161;160;161;162;162;161;161;161;161;162 08:54:09 INFO - PID 12657 | |3;audio-fft;76;74;75;108;75;73;74;74;94;74 08:54:09 INFO - PID 12657 | |4;audio-oscillator;83;82;108;84;83;83;102;84;83;104 08:54:09 INFO - PID 12657 | |5;imaging-gaussian-blur;112;113;113;113;115;113;113;113;113;114 08:54:09 INFO - PID 12657 | |6;imaging-darkroom;149;149;149;150;150;150;149;149;150;150 08:54:09 INFO - PID 12657 | |7;imaging-desaturate;93;93;94;94;95;94;94;94;95;94 08:54:09 INFO - PID 12657 | |8;json-parse-financial;54;56;56;53;55;57;56;54;55;56 08:54:09 INFO - PID 12657 | |9;json-stringify-tinderbox;56;57;56;57;56;58;56;56;56;57 08:54:09 INFO - PID 12657 | |10;stanford-crypto-aes;81;79;80;80;80;82;79;80;79;80 08:54:09 INFO - PID 12657 | |11;stanford-crypto-ccm;129;127;128;128;130;135;128;127;220;129 08:54:09 INFO - PID 12657 | |12;stanford-crypto-pbkdf2;179;191;191;203;189;179;177;192;178;184 08:54:09 INFO - PID 12657 | |13;stanford-crypto-sha256-iterative;76;72;68;71;67;68;70;72;69;71 08:54:09 INFO - PID 12657 | __end_tp_report 08:54:09 INFO - PID 12657 | __start_cc_report 08:54:09 INFO - PID 12657 | _x_x_mozilla_cycle_collect,1977 08:54:09 INFO - PID 12657 | __end_cc_report 08:54:09 INFO - PID 12657 | __startTimestamp1494258849363__endTimestamp 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | ------- Summary: start ------- 08:54:09 INFO - PID 12657 | Number of tests: 14 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:1.37 (1.2%) stddev-sans-first:0.97 08:54:09 INFO - PID 12657 | Values: 109.0 114.0 113.0 112.0 111.0 113.0 112.0 111.0 112.0 112.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:131.50 stddev:14.73 (11.2%) stddev-sans-first:14.23 08:54:09 INFO - PID 12657 | Values: 152.0 127.0 124.0 167.0 131.0 132.0 130.0 120.0 141.0 123.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:54:09 INFO - PID 12657 | Values: 161.0 160.0 161.0 162.0 162.0 161.0 161.0 161.0 161.0 162.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#3] audio-fft Cycles:10 Average:79.70 Median:74.50 stddev:11.73 (15.7%) stddev-sans-first:12.36 08:54:09 INFO - PID 12657 | Values: 76.0 74.0 75.0 108.0 75.0 73.0 74.0 74.0 94.0 74.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.00 stddev:10.51 (12.7%) stddev-sans-first:10.87 08:54:09 INFO - PID 12657 | Values: 83.0 82.0 108.0 84.0 83.0 83.0 102.0 84.0 83.0 104.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 08:54:09 INFO - PID 12657 | Values: 112.0 113.0 113.0 113.0 115.0 113.0 113.0 113.0 113.0 114.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:150.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:54:09 INFO - PID 12657 | Values: 149.0 149.0 149.0 150.0 150.0 150.0 149.0 149.0 150.0 150.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 08:54:09 INFO - PID 12657 | Values: 93.0 93.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.23 (2.2%) stddev-sans-first:1.22 08:54:09 INFO - PID 12657 | Values: 54.0 56.0 56.0 53.0 55.0 57.0 56.0 54.0 55.0 56.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 08:54:09 INFO - PID 12657 | Values: 56.0 57.0 56.0 57.0 56.0 58.0 56.0 56.0 56.0 57.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:0.94 (1.2%) stddev-sans-first:0.93 08:54:09 INFO - PID 12657 | Values: 81.0 79.0 80.0 80.0 80.0 82.0 79.0 80.0 79.0 80.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:129.00 stddev:28.87 (22.4%) stddev-sans-first:30.43 08:54:09 INFO - PID 12657 | Values: 129.0 127.0 128.0 128.0 130.0 135.0 128.0 127.0 220.0 129.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:190.00 stddev:8.37 (4.4%) stddev-sans-first:8.45 08:54:09 INFO - PID 12657 | Values: 179.0 191.0 191.0 203.0 189.0 179.0 177.0 192.0 178.0 184.0 08:54:09 INFO - PID 12657 | 08:54:09 INFO - PID 12657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:2.63 (3.7%) stddev-sans-first:1.86 08:54:09 INFO - PID 12657 | Values: 76.0 72.0 68.0 71.0 67.0 68.0 70.0 72.0 69.0 71.0 08:54:09 INFO - PID 12657 | -------- Summary: end -------- 08:54:09 INFO - PID 12657 | 08:54:10 INFO - TEST-INFO | 12657: exit 0 08:54:10 INFO - TEST-OK | kraken | took 64244ms 08:54:10 INFO - SUITE-END | took 1187s 08:54:11 INFO - Completed test suite (00:19:47) 08:54:11 INFO - javascript benchmark 08:54:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6586.630712095967, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2696.7707744841687, 2713.6472258606377, 2745.0803980666465, 2750.559910414333, 2755.8208716433433, 5088.338515992916, 5161.587073034158, 5192.483433291219, 5196.2725218469395, 5248.737563121843, 5130.640855140142, 5179.611529135311, 5182.689038657673, 5229.477052294768, 5238.816641417551, 4258.361245813137, 4481.596656300932, 4571.977140114294, 4616.930746038812, 4619.907601847961, 4608.078384323132, 4617.122746678137, 4649.558291962258, 4660.067986402716, 4681.016986432854, 4517.119161763458, 4580.770961451914, 4587.587117159438, 4590.173768721629, 4597.3793537872625, 4592.632589392841, 4594.241950078266, 4601.3558101865765, 4608.723476591415, 4608.907821843578, 4503.324501324795, 4563.269876819693, 4576.610988066019, 4581.1753884300815, 4586.862394128181, 4964.776585053645, 4973.801047958077, 4980.900381992376, 4981.975090124526, 5031.6729412588065, 5517.834464966018, 5520.641158324736, 5521.365043020064, 5524.558035357202, 5582.106862901916, 5424.159255315432, 5446.21029950655, 5503.147012213113, 5565.499105080522, 5567.415421380778, 5211.478852114834, 5221.843344699665, 5243.475652434726, 5259.184826351921, 5260.736963151827, 5717.0, 5772.191893134965, 5772.7113644317615, 5773.740181691834, 5779.422057794271, 5371.946280537145, 5388.676679399248, 5433.755481003285, 5437.592180586472, 5535.640183388067, 5531.585131115102, 5541.445855414507, 5541.944580554143, 5574.358948720868, 5592.2730045094695, 5473.75368108436, 5485.61600687948, 5492.670439773627, 5492.780288788484, 5495.2856128703015, 5392.191171324333, 5482.890342193134, 5486.0, 5491.258680078218, 5547.445255474501, 4601.953980460153, 4619.769011549476, 4648.628109751212, 4651.488336283006, 4653.604443622262, 3929.842806287774, 3943.2507823514015, 3964.702647301464, 4000.7999600019884, 4007.919841603152, 4645.46577143626, 4736.455307639666, 4750.976245118822, 4752.7385993769985, 4752.7385993769985, 5561.5272701820795, 5561.63849349791, 5682.119271512922, 5685.687287199161, 5690.146478028246, 4744.217204161344, 4765.332853400527, 4768.809247630125, 4770.642201834877, 4812.759362031955, 4959.181735013754, 4966.701997880066, 4969.701817890938, 4972.801087956441, 5020.272060551272, 5136.9743151284, 5167.58659307262, 5203.895922081613, 5276.023935571931, 5277.050130976308, 5635.802746903839, 5646.237757902795, 5648.181013752901, 5650.63270887391, 5684.488396044376, 5218.869528261824, 5243.213517972335, 5254.080535906278, 5261.394939581997, 5317.415084340797, 5377.784888604412, 5413.648112872651, 5457.017736807254, 5469.972650136724, 5543.307086614173, 5571.331440227199, 5576.219329293983, 5578.107502799533, 5580.77676892936, 5583.55331573465, 5312.043832110257, 5370.301860758076, 5379.919301210407, 5383.057964856056, 5385.649932754359, 5409.0263752524925, 5410.188471729272, 5412.539934105645, 5415.810446634349, 5417.674939503642, 5296.947030529799, 5328.813491527778, 5330.120530112643, 5361.115415956479, 5368.033753924331, 5433.5109840113, 5438.592105592017, 5439.0, 5439.5104440600535, 5446.428125046813, 5208.9739551302, 5263.184206448007, 5280.973595132, 5298.549623282064, 5348.384935732441], "value": 5038.766950468666, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7563028570287, 731.0131322714336, 1026.8562401263819, 1029.4183786160818, 1044.8171569975257, 28128.859355703218, 30973.690263097364, 31373.215669608242, 31381.52927706086, 31432.842835785847, 32834.50748238772, 33144.0, 33181.33637327252, 33213.169670758245, 33307.50038749415, 5148.74256287186, 5290.470952904698, 6612.437942774858, 6665.8333541661605, 6715.160604924385, 6678.232003319632, 6870.278620744824, 6870.896936545956, 6875.484338674594, 6876.346747059047, 6864.828379290508, 6914.688839002257, 6921.0, 6922.169339679245, 6974.0, 5151.0470562945975, 5272.710000949946, 6666.966665166643, 6865.210500792398, 6889.586624802503, 6763.492738044666, 6832.350926661959, 6834.2140653824945, 6836.521443498957, 6841.042254084432, 28984.42031159386, 29240.707592924013, 29271.0, 29346.559801602994, 29473.852630736925, 2941.749951254146, 2968.7921845470823, 2969.732724054845, 2971.272038350596, 2972.078655616766, 23146.42133946648, 23224.4193895154, 23225.535489290287, 23252.53494930092, 23322.183723569593, 2769.62610047643, 2778.1526634376505, 2786.178077467152, 2789.6373471448783, 2879.8992035278875, 138180.30909845486, 138905.0, 139382.0, 139528.0, 139808.99999999898, 33575.328493429995, 34123.4881476778, 34142.31715365679, 39100.41349379761, 39193.41209881854, 35164.296714065575, 35679.28641427157, 39507.60492395097, 41204.587954120674, 41238.79380603078, 12270.202436841577, 12591.622251332476, 12610.81083783744, 12622.431990560446, 12636.936815315865, 10110.494475276353, 10132.696019119438, 10133.138683211862, 10138.087572118544, 10142.492875356204, 12321.630351089481, 12378.195417297848, 12394.81407778884, 12446.626601201979, 12563.120581559204, 5142.228665700175, 5156.948430515647, 5162.793488260428, 5176.0, 5216.921746173811, 885.9025507194203, 898.8471959766855, 910.6175406329357, 920.6639576554643, 940.8118376324762, 19421.2231510738, 20337.49156271105, 20502.897485512774, 20808.167673292897, 20810.583788324147, 966.1353088985319, 975.7024107647094, 985.2265971212707, 988.5551501824208, 1018.1956254558963, 10047.949760251153, 10688.625898093685, 10791.730206744895, 10850.620228291971, 10942.507587158598, 172325.0, 174100.0, 174270.12864935593, 174434.0, 174813.0, 37908.81045594755, 37983.0, 37988.0, 38046.0, 38074.80962595169, 1205.7046023724245, 1237.4864431261105, 1242.8260043593905, 1247.0896245740478, 1260.1997731440601, 19081.0, 19619.70570441416, 20098.497537561678, 20144.899275504114, 20437.284695035603, 28024.57963130514, 28046.71953280441, 28048.57927131054, 28081.297967550974, 28127.156185314474, 148161.0, 148343.2582837079, 149152.0, 149305.0, 149339.0, 23716.288511344686, 24089.638655419833, 27028.729712703407, 27368.726312737414, 27778.166655000383, 33105.50341744828, 33133.83433082819, 33140.83429582837, 33476.330473389906, 33518.0, 23853.0, 24705.50588988246, 24893.377665558506, 25486.23541293764, 26057.439948009403, 25129.0, 25182.11862584801, 25236.62145067862, 25367.112151075362, 26638.200853974413, 28406.43187136287, 28413.289667758472, 28437.289067772643, 28522.857385712938, 28524.144275671762, 24282.757172428755, 24632.13787517428, 24916.981564181522, 25310.240692779247, 25385.873070634527, 20613.0, 21870.781292187512, 22008.559828803012, 22184.445388864762, 22263.888680556494], "value": 13816.737054700829, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.1005672152575, 400.5953986473661, 401.2736946127508, 419.1554018652415, 421.22915065430266, 15633.609159771011, 16076.919615401921, 16811.0, 16830.663386732274, 16931.83068169321, 17037.57406064849, 17286.56783580411, 17402.47792566225, 17826.376076837314, 18192.90903545484, 5209.21861720743, 5225.268462415255, 5461.726913654321, 5477.424870388611, 5481.0, 5310.946890531103, 5408.0, 5412.621116521845, 5414.810481633143, 5422.457754224585, 5249.081410753122, 5379.542738867201, 5387.811426600069, 5436.91844622331, 5441.564674826004, 5304.443033481487, 5374.274472946141, 5381.569474442035, 5401.081816091274, 5414.296141501619, 4819.614430845524, 4878.634102442331, 4886.53577910098, 4891.1195984722735, 4894.070126675921, 21766.693998360148, 21812.0, 22266.443338916495, 22379.216727414627, 22505.21231756897, 1634.1012443156335, 1648.2006226979904, 1660.6844699507055, 1660.7591899174672, 1661.2192269633254, 14098.71802563943, 14600.415983360654, 14757.55727328171, 14917.403303867832, 14925.402983880631, 2020.979790202094, 2057.722207501998, 2116.502621883856, 2116.5766846630736, 2122.405726396596, 72101.0, 88027.55986220091, 88523.0, 90031.54984225103, 91900.54049729776, 10591.311564748266, 10671.46642667879, 10700.571977120828, 10945.726356841144, 11001.779964400666, 14770.335334909954, 14786.0, 14808.62978425548, 14817.40730370773, 14856.108633482027, 7380.630968451664, 7558.319751222416, 7730.497517661334, 7801.141874393812, 7811.0, 6975.128108986377, 6988.615626140611, 7044.542104763174, 7232.421406287484, 7297.270272972661, 6955.269696681877, 6988.860222795617, 7009.579425234502, 7021.591245193709, 7092.397146242524, 2022.0900594732136, 2034.6846238833004, 2059.7631272403564, 2071.4717746974725, 2236.530328630973, 878.8154487557557, 904.6607522179182, 909.4497828813605, 914.9817003659889, 937.5171786529943, 16816.74774878378, 16952.660946780994, 17513.47459576215, 17670.204840782197, 17940.372086976895, 902.3142411766974, 909.4497828813472, 910.8906931168169, 925.8842644669417, 928.3223247029706, 9076.0, 9399.0, 9644.373115747454, 9758.17055550272, 9901.702948911545, 340573.0, 341613.0, 342244.0, 348428.0, 355309.0, 75810.62094689491, 77299.0, 78394.0, 78808.60595696984, 80132.59933700411, 1105.5467258424007, 1132.592266783957, 1163.3485248261002, 1165.318288801044, 1168.6260396673154, 16797.0, 17129.0, 17578.82421175823, 18050.194980501845, 19203.21553374725, 40743.1851362977, 41326.38010429786, 41569.79215104026, 41882.37176442295, 42595.787021064694, 47582.762086189345, 48125.0, 49632.50367496279, 49845.252321215936, 50004.0, 8166.510009399455, 8316.50100993918, 8325.916740832514, 8376.246137847624, 8383.58082095905, 13606.183628982293, 13626.591202263948, 13724.0, 13758.65603359924, 13917.443302267797, 11644.767104658029, 11832.881671183179, 11865.347405892413, 11873.0, 12219.26684398939, 10312.535935882754, 10533.894661053291, 10631.734206644896, 10937.56249750001, 11115.888841111486, 11579.942100289445, 11695.356755378536, 11867.109966752701, 11899.583514576949, 12376.319302438093, 8228.3005944493, 8263.710770123258, 8326.542040187847, 8424.915750842412, 8453.66185352579, 11060.723481913017, 11244.381559014006, 11554.711132221762, 11620.360880151673, 11925.165238433574], "value": 8901.859546962629, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.9162380969008, 1346.3672074125163, 1355.2139758939823, 1361.285325204268, 1373.2721657521504, 9233.7691557711, 9654.710358689234, 9655.806883862328, 9657.710268691933, 9658.903410965888, 9321.114494123047, 9440.244780417568, 9460.432374057562, 9555.092266234715, 9567.760805979853, 2071.8860462674547, 2103.2112957640884, 2105.378913220596, 2105.768365479796, 2108.462342102762, 1843.9262429502871, 2110.3246960972497, 2157.2449642625033, 2178.8583742056717, 2211.9778802212013, 1783.7948635906841, 2063.6698128299477, 2201.0, 2220.467087898901, 2237.3623517297574, 2213.656883183109, 2258.4015235962565, 2261.604219261639, 2264.388615073921, 2265.037359122383, 2175.5540114276537, 2225.63277059285, 2226.109556177526, 2227.9220227291967, 2228.8885555722313, 9286.257099432029, 9460.85808712863, 9464.242860571207, 9474.194693451065, 9477.052294770538, 5098.311727916721, 5323.30796996388, 5325.653832500875, 5333.4399888011585, 5334.706591137486, 3014.623172103487, 3145.213696575856, 3226.6934641209045, 3227.3222623249144, 3229.951550726741, 1001.3841487485145, 1010.4998025977114, 1016.2885979814085, 1047.9685609431729, 1049.4962418039308, 13020.804687929689, 13207.801882971668, 13283.86716132836, 13342.733145337039, 13352.666183345495, 4858.368412106474, 4911.705297682151, 5022.196448568212, 5038.3198268234055, 5101.438841727407, 11875.643730688093, 11883.346415947206, 11885.702857428634, 11913.880861191277, 11917.582884598998, 5629.324481062299, 5638.689872057076, 5642.4075472075665, 5649.152627105885, 5655.745491452894, 4742.620590352833, 4745.620350371962, 4812.230043193073, 4817.662763606584, 4976.701397916137, 4040.595940405936, 4089.161721847014, 4094.590540945941, 4168.645665118438, 4196.853110141192, 1311.2525860259561, 1333.419962316376, 1341.7987301904793, 1344.193483909666, 1368.609946165338, 723.4284914917157, 745.0537816972414, 746.3618606091713, 748.9251074892467, 759.1990450075224, 5482.780688772485, 5486.725663716798, 5570.2480165177185, 5574.1917421973585, 5615.747291371817, 528.8519214619913, 554.9944500555024, 555.2670474972997, 559.2617744577201, 560.28563581434, 3384.4754063120254, 3456.723462123024, 3523.066387407288, 3525.3654342218133, 3594.964050359515, 12033.217840840318, 12353.876461235452, 12525.624231273076, 12540.372981350896, 12559.681233470537, 11955.342456164994, 12251.571195008131, 12328.19866708661, 12347.38263086842, 12361.505539778487, 6437.195350581177, 6690.096836927147, 6807.183138023469, 6882.69027893746, 6906.516543841883, 6030.185924900083, 6059.969700151471, 6153.4154255345675, 6212.534059945612, 6395.616263024233, 11068.7824339321, 11113.110951123728, 11149.609763658233, 11228.606998755004, 11240.494177762184, 11074.335539867312, 11237.38194399316, 11263.831042534204, 11545.942270288595, 11614.187006909435, 7525.661345239587, 7711.575863327346, 7714.267144621252, 7719.382449403922, 7720.420968427278, 8463.66145354179, 8687.522186279815, 8740.781480462785, 8795.076516965883, 8799.956000219958, 7932.444728868923, 7969.322607578189, 7977.44157908964, 8009.359251259769, 8065.112837587978, 7173.748918787817, 7416.221296763762, 7436.96281518589, 7467.775966721007, 7469.887951680837, 6788.490863185182, 6888.690008949709, 6892.862142757217, 6896.931030689629, 6897.931020689729, 5026.572741317029, 5030.3963524377305, 5091.796328146981, 5150.0472412603785, 5278.630495865253, 5384.111621582395, 5396.811111611075, 5434.592405569519, 5570.637908535932, 5604.8318550443555], "value": 4559.1777890503645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.5938345969812, 379.8044007336224, 384.99230015399695, 387.242940052198, 387.67048009192183, 5367.221752845835, 5374.865628359288, 5394.595405344605, 5403.567714582834, 5422.593305502083, 5067.949320506794, 5293.947060529394, 5309.442508536606, 5320.787168513264, 5325.840224793253, 4289.442372491588, 4289.656827453796, 4300.032492689135, 4304.3643415502065, 4316.97841510792, 4309.095090031097, 4317.525072242051, 4323.913521729563, 4328.091100868822, 4330.84842030529, 4164.500779719298, 4256.2764330063965, 4271.78641067947, 4290.957090429102, 4303.505096913848, 4260.31834906415, 4264.23243816113, 4274.658027357819, 4286.678499112548, 4286.978565107154, 3883.728139030269, 3884.844606215748, 3887.941680874789, 3888.5333759948703, 3889.8055097245306, 5085.338905942241, 5227.843164705065, 5228.5555727763185, 5249.921251181236, 5271.551918086967, 4992.80172758539, 5045.142325804585, 5056.0, 5058.772355244023, 5061.291419201315, 5730.713464326767, 5735.799247026376, 5741.856453588652, 5759.712014399305, 5761.798337058183, 4275.914481710349, 4354.934675979863, 4357.3899654048455, 4366.410534577855, 4373.737575745466, 5743.4543718346695, 5906.793262235844, 5909.438603332676, 5985.221921150266, 6109.297430795471, 4452.977735111303, 4453.532379100213, 4466.3523789050405, 4466.821327146943, 4476.903158726068, 4364.716293440916, 4547.15877562652, 4547.545245475426, 4548.431446069241, 4573.291139873325, 4901.6668665307225, 4933.112039832865, 5000.099982003201, 5038.79844806211, 5042.495750424928, 5721.942780572224, 5726.828195154152, 5729.7708091676695, 5732.856678582985, 5737.3688894221605, 1559.688062387527, 1566.929488173035, 1573.339197537037, 1589.737693280619, 1595.197426907587, 1096.6709987003867, 1109.1698697149768, 1116.3246236027087, 1125.5666568371073, 1144.5822274869613, 4966.478519755446, 4975.154223781966, 4976.502349765067, 4992.151334273182, 4996.90006199874, 5872.647641141545, 5896.734646940898, 5897.852553686106, 5903.173555702205, 5910.7291932234775, 4756.7145971241835, 4890.290907818347, 4913.975430122827, 4938.802447902043, 4953.653244272867, 3061.6326040875238, 3117.9220519487194, 3127.390158918989, 3131.9217019574694, 3135.2318681923075, 5454.4545545445135, 5455.1271796512365, 5456.263404440429, 5456.48163424474, 5483.369412517532, 5773.711314434346, 6009.759609615654, 6068.544859135583, 6071.241094863142, 6073.878522429527, 5470.91793623096, 5480.547654871462, 5491.203775452537, 5496.477834605706, 5504.2294078829, 5738.1679656450415, 5879.441453061952, 5896.823095307148, 5899.793507227227, 5904.350521442724, 5521.641093328921, 5655.915161272502, 5767.653940763567, 5796.797112101225, 5804.448577385142, 5313.867153321198, 5496.422875598005, 5508.338999320107, 5513.751881165277, 5522.22688823573, 4042.3936409537628, 4050.7164498486004, 4059.3505039193587, 4071.75569465833, 4075.2257071156387, 5689.601727879009, 5905.557083218861, 5925.703714814328, 5932.703364831655, 5933.614315069507, 5714.285714285715, 5714.771324165325, 5718.542516598745, 5731.684757338219, 5740.225069615715, 5531.419200983839, 5722.484976352148, 5734.655920644775, 5737.0, 5748.137779333133, 5586.553075754011, 5620.718964051863, 5627.352854421794, 5628.802991895264, 5631.211630371833, 5724.0, 5759.193712880284, 5761.625494342854, 5765.0, 5768.971155144198, 5262.789488420421, 5519.558435325244, 5591.077472217039, 5594.580406469612, 5600.915986260291], "value": 4371.980629517443, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.1034758290053, 754.777340684498, 764.6253335865426, 768.8154842837718, 789.2029050658834, 12958.287294198815, 13828.792568111487, 13855.307234638278, 13884.444622215113, 13892.861071389296, 14630.853691463082, 15853.0, 15912.0, 15926.0, 15952.680946381066, 876.1282523888724, 889.9065598112202, 891.790429249126, 894.6287290774321, 894.8255090257402, 882.5322579033123, 885.5970533407317, 893.4371346052011, 893.530896279452, 895.4537731983485, 891.2914233184601, 921.5576523268835, 928.9721308360727, 929.0430856218106, 930.2093220762365, 913.9999999999967, 919.296737995434, 921.5162039929057, 921.7511271956602, 923.1138107416888, 670.0786418674322, 671.6037537852642, 671.8320419895026, 671.8320419895026, 672.0524061073862, 13331.866681333257, 13373.66565835852, 13580.932095339558, 13713.931430342884, 13727.519536816164, 15658.451954181663, 15728.842711572852, 15977.760333595006, 16076.919615401848, 16096.114713690742, 12422.316772577504, 12513.687157821036, 12666.746665066647, 12685.682857928534, 12699.746005079847, 2940.2355387599378, 2957.911262662102, 2962.481565726011, 2962.9407411851644, 2972.1083674897445, 61677.383226167614, 61697.38302616961, 61921.0, 63484.0, 70785.29214707839, 12074.758504829853, 12408.441620127116, 12444.502219911283, 12562.05784566143, 12573.559925402567, 20583.176672932914, 20898.0, 21097.789022109584, 21104.89447552783, 21463.46341341479, 5187.948120518747, 5339.332583427072, 5348.358197016383, 5353.223782551586, 5411.107167317348, 3069.9846500767353, 3099.9070027899197, 3108.1452600535035, 3131.6711745266875, 3133.122725636825, 3439.226174110855, 3510.297940411928, 3597.8560857565403, 3683.5027271318563, 3687.0597997510463, 687.8693048320803, 689.1695506914157, 689.2418339826152, 691.4986634689809, 692.9341712537301, 540.1627477409999, 552.1414200917532, 554.7503623369419, 555.5000499550356, 559.233849626015, 9445.338826282094, 10100.545475453475, 10117.747056323651, 10288.897111028944, 10470.842937355947, 506.33164223225725, 514.5677630790154, 514.9613778966518, 522.7020598259032, 527.6965744696814, 4028.48931650631, 4144.295469770146, 4149.232392007489, 4299.204647140289, 4306.590873866978, 57833.710831445576, 57979.71010144922, 61329.69335153296, 63016.0, 63515.0, 50929.490705093216, 51595.22607160896, 51613.0, 51751.74124129431, 51822.74088629533, 34792.65207347945, 47419.5258047422, 47889.52110478851, 48159.073637054826, 50258.49741502611, 10451.268411211142, 10460.372377657364, 10562.0, 10814.56741730322, 10993.61522346714, 24660.753392465846, 25173.118940836983, 25734.485310294065, 26174.0, 26619.20142395731, 41439.171216576106, 41844.58155418407, 42434.5756542443, 42536.78731606322, 42788.14423711446, 13200.943924485826, 13298.335083245605, 13347.799783003456, 13439.932800335935, 13620.52328168549, 13561.050726449448, 13633.182009079486, 13771.517996870061, 14232.288385580887, 14264.215468148936, 12581.0, 12634.684132896384, 12667.746645066863, 12746.553870614483, 12901.806472902726, 13486.527971520949, 13579.45682172702, 13706.24615646149, 13804.93097534506, 13908.374123164684, 12034.157608967289, 12299.385030748606, 12310.199837010565, 12379.381030948596, 12388.132830701765, 9634.807303853744, 9829.716726888126, 9888.110070093726, 10305.845412318971, 10394.116500097576, 10154.949225253826, 10211.693649190536, 10305.639302624371, 10503.0, 10672.146228301872], "value": 6609.575122112083, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 113.0, 112.0, 111.0, 113.0, 112.0, 111.0, 112.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 124.0, 167.0, 131.0, 132.0, 130.0, 120.0, 141.0, 123.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 108.0, 75.0, 73.0, 74.0, 74.0, 94.0, 74.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 84.0, 83.0, 83.0, 102.0, 84.0, 83.0, 104.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 113.0, 115.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 150.0, 150.0, 150.0, 149.0, 149.0, 150.0, 150.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 56.0, 53.0, 55.0, 57.0, 56.0, 54.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 57.0, 56.0, 58.0, 56.0, 56.0, 56.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 80.0, 80.0, 82.0, 79.0, 80.0, 79.0, 80.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 128.0, 128.0, 130.0, 135.0, 128.0, 127.0, 220.0, 129.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 191.0, 191.0, 203.0, 189.0, 179.0, 177.0, 192.0, 178.0, 184.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 68.0, 71.0, 67.0, 68.0, 70.0, 72.0, 69.0, 71.0], "value": 70.4, "unit": "score"}]}]} 08:54:11 INFO - Return code: 0 08:54:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:54:11 INFO - # TBPL SUCCESS # 08:54:11 INFO - Running post-action listener: _resource_record_post_action 08:54:11 INFO - [mozharness: 2017-05-08 15:54:11.166988Z] Finished run-tests step (success) 08:54:11 INFO - Running post-run listener: _resource_record_post_run 08:54:11 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 358789120; Read time: 228; Write time: 216052 08:54:11 INFO - TinderboxPrint: CPU usage
12.9% 08:54:11 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 228 08:54:11 INFO - TinderboxPrint: I/O write bytes / time
358,789,120 / 216,052 08:54:11 INFO - TinderboxPrint: CPU idle
8,359.3 (87.1%) 08:54:11 INFO - TinderboxPrint: CPU user
1,198.8 (12.5%) 08:54:11 INFO - TinderboxPrint: Swap in / out
0 / 0 08:54:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 90677248; Read time: 32; Write time: 69016 08:54:11 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 268111872; Read time: 196; Write time: 147036 08:54:11 INFO - Running post-run listener: _upload_blobber_files 08:54:11 INFO - Blob upload gear active. 08:54:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:54:11 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 08:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:54:12 INFO - (blobuploader) - INFO - Open directory for files ... 08:54:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:54:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:54:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:54:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:54:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:54:13 INFO - (blobuploader) - INFO - Done attempting. 08:54:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:54:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:54:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:54:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:54:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:54:13 INFO - (blobuploader) - INFO - Done attempting. 08:54:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:54:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:54:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:54:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:54:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:54:14 INFO - (blobuploader) - INFO - Done attempting. 08:54:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:54:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:54:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:54:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:54:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:54:17 INFO - (blobuploader) - INFO - Done attempting. 08:54:17 INFO - (blobuploader) - INFO - Iteration through files over. 08:54:17 INFO - Return code: 0 08:54:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:54:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:54:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82704ec9f41721e525593f2acae14c8a78995e8986afd9934fc3f8189fb1abc663dba32cae38e64a55dacc3732ea36ee298f831721a20641424dfee6be80c611", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f62b5962c1a973b6f56a281a580534388780a4c5b8f2e98082d3ba095242c5360ef4411e4d1b9252cb5effa1ec6fc7913e66213405641656a0be3d2eee70abdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae6a931359251baf4a427eb47b82292320cfdf20ad19ab2d51dafc5d26ae649515c237c6bb565b00855bdc773f9358401be331cbbdc4abac3329d034357dc62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/295e5f79c3a92dbc24b9189d6fc51b7295d6aeb98c5fd8e6b2db79a57519805b6958e7d12c55d8d4282b70919f69ddfc9bfd7f5262bb9da8460b53e970c84629"} 08:54:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:54:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:54:17 INFO - Contents: 08:54:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82704ec9f41721e525593f2acae14c8a78995e8986afd9934fc3f8189fb1abc663dba32cae38e64a55dacc3732ea36ee298f831721a20641424dfee6be80c611", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f62b5962c1a973b6f56a281a580534388780a4c5b8f2e98082d3ba095242c5360ef4411e4d1b9252cb5effa1ec6fc7913e66213405641656a0be3d2eee70abdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae6a931359251baf4a427eb47b82292320cfdf20ad19ab2d51dafc5d26ae649515c237c6bb565b00855bdc773f9358401be331cbbdc4abac3329d034357dc62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/295e5f79c3a92dbc24b9189d6fc51b7295d6aeb98c5fd8e6b2db79a57519805b6958e7d12c55d8d4282b70919f69ddfc9bfd7f5262bb9da8460b53e970c84629"} 08:54:17 INFO - Running post-run listener: copy_logs_to_upload_dir 08:54:17 INFO - Copying logs to upload dir... 08:54:17 INFO - mkdir: /builds/slave/test/build/upload/logs 08:54:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.623926 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-08 08:54:17.099275) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 08:54:17.102886) ========= 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-1494257148.633881-878491815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82704ec9f41721e525593f2acae14c8a78995e8986afd9934fc3f8189fb1abc663dba32cae38e64a55dacc3732ea36ee298f831721a20641424dfee6be80c611", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f62b5962c1a973b6f56a281a580534388780a4c5b8f2e98082d3ba095242c5360ef4411e4d1b9252cb5effa1ec6fc7913e66213405641656a0be3d2eee70abdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae6a931359251baf4a427eb47b82292320cfdf20ad19ab2d51dafc5d26ae649515c237c6bb565b00855bdc773f9358401be331cbbdc4abac3329d034357dc62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/295e5f79c3a92dbc24b9189d6fc51b7295d6aeb98c5fd8e6b2db79a57519805b6958e7d12c55d8d4282b70919f69ddfc9bfd7f5262bb9da8460b53e970c84629"} build_url:https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/AOxXR9PGQPOUhYXOPwFZiQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82704ec9f41721e525593f2acae14c8a78995e8986afd9934fc3f8189fb1abc663dba32cae38e64a55dacc3732ea36ee298f831721a20641424dfee6be80c611", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f62b5962c1a973b6f56a281a580534388780a4c5b8f2e98082d3ba095242c5360ef4411e4d1b9252cb5effa1ec6fc7913e66213405641656a0be3d2eee70abdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae6a931359251baf4a427eb47b82292320cfdf20ad19ab2d51dafc5d26ae649515c237c6bb565b00855bdc773f9358401be331cbbdc4abac3329d034357dc62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/295e5f79c3a92dbc24b9189d6fc51b7295d6aeb98c5fd8e6b2db79a57519805b6958e7d12c55d8d4282b70919f69ddfc9bfd7f5262bb9da8460b53e970c84629"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 08:54:17.128964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 08:54:17.129321) ========= 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-1494257148.633881-878491815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 08:54:17.214773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 08:54:17.215736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 08:54:17.216459) ========= ========= Total master_lag: 0.16 =========