builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1486674439.57 results: success (0) revision: 2e0af7243d08369ef93638aa306f6cc2056c28b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:19.571835) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:19.572334) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:19.572649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:19.590592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:19.591312) ========= 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=41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 13:07: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% 112M=0s 2017-02-09 13:07:19 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:19.729165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:19.729524) ========= 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=41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014812 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:19.778831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 13:07:19.779245) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2e0af7243d08369ef93638aa306f6cc2056c28b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2e0af7243d08369ef93638aa306f6cc2056c28b9 --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=41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 13:07:19,855 truncating revision to first 12 chars 2017-02-09 13:07:19,855 Setting DEBUG logging. 2017-02-09 13:07:19,855 attempt 1/10 2017-02-09 13:07:19,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2e0af7243d08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 13:07:20,603 unpacking tar archive at: mozilla-aurora-2e0af7243d08/testing/mozharness/ program finished with exit code 0 elapsedTime=1.067553 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 13:07:20.860700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:20.861194) ========= script_repo_revision: 2e0af7243d08369ef93638aa306f6cc2056c28b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:20.861626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:20.862033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 13:07:20.871068) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 13:07:20.871376) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:07:21 INFO - MultiFileLogger online at 20170209 13:07:21 in /builds/slave/test 13:07:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:07:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:21 INFO - {'append_to_log': False, 13:07:21 INFO - 'base_work_dir': '/builds/slave/test', 13:07:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:07:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:21 INFO - 'branch': 'Mozilla-Aurora', 13:07:21 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:21 INFO - 'config_files': ('talos/linux_config.py',), 13:07:21 INFO - 'default_actions': ('clobber', 13:07:21 INFO - 'read-buildbot-config', 13:07:21 INFO - 'download-and-extract', 13:07:21 INFO - 'populate-webroot', 13:07:21 INFO - 'create-virtualenv', 13:07:21 INFO - 'install', 13:07:21 INFO - 'run-tests'), 13:07:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:21 INFO - 'download_minidump_stackwalk': True, 13:07:21 INFO - 'download_symbols': 'ondemand', 13:07:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:21 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:21 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:21 INFO - 'installer_path': 'installer.exe', 13:07:21 INFO - 'log_level': 'info', 13:07:21 INFO - 'log_name': 'talos', 13:07:21 INFO - 'log_to_console': True, 13:07:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:07:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:07:21 INFO - 'opt_config_files': (), 13:07:21 INFO - 'pip_index': False, 13:07:21 INFO - 'sps_profile': False, 13:07:21 INFO - 'sps_profile_interval': 0, 13:07:21 INFO - 'suite': 'dromaeojs-e10s', 13:07:21 INFO - 'system_bits': '32', 13:07:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:21 INFO - 'title': 'talos-linux64-ix-024', 13:07:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:21 INFO - 'use_talos_json': True, 13:07:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:21 INFO - 'work_dir': 'build'} 13:07:21 INFO - [mozharness: 2017-02-09 21:07:21.048638Z] Running clobber step. 13:07:21 INFO - Running pre-action listener: _resource_record_pre_action 13:07:21 INFO - Running main action method: clobber 13:07:21 INFO - rmtree: /builds/slave/test/build 13:07:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:21 INFO - Running post-action listener: _resource_record_post_action 13:07:21 INFO - [mozharness: 2017-02-09 21:07:21.506207Z] Finished clobber step (success) 13:07:21 INFO - [mozharness: 2017-02-09 21:07:21.506308Z] Running read-buildbot-config step. 13:07:21 INFO - Running pre-action listener: _resource_record_pre_action 13:07:21 INFO - Running main action method: read_buildbot_config 13:07:21 INFO - Using buildbot properties: 13:07:21 INFO - { 13:07:21 INFO - "project": "", 13:07:21 INFO - "product": "firefox", 13:07:21 INFO - "who": "Callek@gmail.com", 13:07:21 INFO - "installer_path": "public/build/target.tar.bz2", 13:07:21 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:07:21 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 13:07:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:07:21 INFO - "stage_platform": "linux64-pgo", 13:07:21 INFO - "basedir": "/builds/slave/test", 13:07:21 INFO - "buildnumber": 760, 13:07:21 INFO - "platform": "ubuntu64_hw", 13:07:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:07:21 INFO - "slavebuilddir": "test", 13:07:21 INFO - "taskId": "dKMWb6LCSjqBpDNtOWMIXw", 13:07:21 INFO - "branch": "mozilla-aurora", 13:07:21 INFO - "script_repo_revision": "production", 13:07:21 INFO - "revision": "2e0af7243d08369ef93638aa306f6cc2056c28b9", 13:07:21 INFO - "slavename": "talos-linux64-ix-024", 13:07:21 INFO - "repo_path": "releases/mozilla-aurora" 13:07:21 INFO - } 13:07:21 INFO - Finding installer, test and symbols from parent task. 13:07:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dKMWb6LCSjqBpDNtOWMIXw'}, attempt #1 13:07:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dKMWb6LCSjqBpDNtOWMIXw'}, attempt #1 13:07:22 INFO - Task dependencies: J3rb7_JlQJ-a0ckKlkqCgA 13:07:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA'}, attempt #1 13:07:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.tar.bz2 13:07:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/test_packages.json 13:07:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.crashreporter-symbols.zip 13:07:22 INFO - Running post-action listener: _resource_record_post_action 13:07:22 INFO - [mozharness: 2017-02-09 21:07:22.956362Z] Finished read-buildbot-config step (success) 13:07:22 INFO - [mozharness: 2017-02-09 21:07:22.956580Z] Running download-and-extract step. 13:07:22 INFO - Running pre-action listener: _resource_record_pre_action 13:07:22 INFO - Running main action method: download_and_extract 13:07:22 INFO - mkdir: /builds/slave/test/build/tests 13:07:22 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')]} 13:07:22 INFO - trying https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.test_packages.json 13:07:22 INFO - Downloading https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:07:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:07:23 INFO - Downloaded 896 bytes. 13:07:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:07:23 INFO - Using the following test package requirements: 13:07:23 INFO - {u'common': [u'target.common.tests.zip'], 13:07:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:07:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:07:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:07:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:07:23 INFO - u'mozbase': [u'target.common.tests.zip'], 13:07:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:07:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:07:23 INFO - u'web-platform': [u'target.common.tests.zip', 13:07:23 INFO - u'target.web-platform.tests.zip'], 13:07:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:07:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:07:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.common.tests.zip 13:07:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:07:23 INFO - Fetch https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.common.tests.zip into memory 13:07:24 INFO - Expected file size: 21859747 13:07:24 INFO - Obtained file size: 21859747 13:07:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:07:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.common.tests.zip 13:07:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:07:28 INFO - Fetch https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.common.tests.zip into memory 13:07:29 INFO - Expected file size: 21859747 13:07:29 INFO - Obtained file size: 21859747 13:07:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.talos.tests.zip 13:07:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:07:33 INFO - Fetch https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.talos.tests.zip into memory 13:07:34 INFO - Expected file size: 14403485 13:07:34 INFO - Obtained file size: 14403485 13:07:34 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')]} 13:07:34 INFO - trying https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.tar.bz2 13:07:34 INFO - Downloading https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:07:35 INFO - Downloaded 66034465 bytes. 13:07:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.tar.bz2 13:07:35 INFO - mkdir: /builds/slave/test/properties 13:07:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:35 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:35 INFO - Contents: 13:07:35 INFO - build_url:https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.tar.bz2 13:07:35 INFO - Running post-action listener: _resource_record_post_action 13:07:35 INFO - Running post-action listener: set_extra_try_arguments 13:07:35 INFO - [mozharness: 2017-02-09 21:07:35.860003Z] Finished download-and-extract step (success) 13:07:35 INFO - [mozharness: 2017-02-09 21:07:35.860101Z] Running populate-webroot step. 13:07:35 INFO - Running pre-action listener: _resource_record_pre_action 13:07:35 INFO - Running main action method: populate_webroot 13:07:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:35 INFO - '--tppagecycles', 13:07:35 INFO - '7'], 13:07:35 INFO - 'tests': ['tsvgm']}}, 13:07:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:07:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:07:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:07:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:07:35 INFO - 'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:07:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:07:35 INFO - 'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['damp', 'tps']}, 13:07:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:07:35 INFO - 'tests': ['damp', 'tps']}, 13:07:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['dromaeo_dom']}, 13:07:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['basic_compositor_video']}, 13:07:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:07:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['a11yr', 13:07:35 INFO - 'ts_paint', 13:07:35 INFO - 'tpaint', 13:07:35 INFO - 'sessionrestore', 13:07:35 INFO - 'sessionrestore_no_auto_restore', 13:07:35 INFO - 'tabpaint']}, 13:07:35 INFO - 'other-e10s': {'tests': ['a11yr', 13:07:35 INFO - 'ts_paint', 13:07:35 INFO - 'tpaint', 13:07:35 INFO - 'sessionrestore', 13:07:35 INFO - 'sessionrestore_no_auto_restore', 13:07:35 INFO - 'tabpaint']}, 13:07:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:07:35 INFO - 'ts_paint', 13:07:35 INFO - 'tpaint', 13:07:35 INFO - 'sessionrestore', 13:07:35 INFO - 'sessionrestore_no_auto_restore', 13:07:35 INFO - 'tabpaint']}, 13:07:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:07:35 INFO - 'ts_paint', 13:07:35 INFO - 'tpaint', 13:07:35 INFO - 'sessionrestore', 13:07:35 INFO - 'sessionrestore_no_auto_restore', 13:07:35 INFO - 'tabpaint']}, 13:07:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['a11yr', 13:07:35 INFO - 'ts_paint', 13:07:35 INFO - 'tpaint', 13:07:35 INFO - 'sessionrestore', 13:07:35 INFO - 'sessionrestore_no_auto_restore', 13:07:35 INFO - 'tabpaint']}, 13:07:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['a11yr', 13:07:35 INFO - 'ts_paint', 13:07:35 INFO - 'tpaint', 13:07:35 INFO - 'sessionrestore', 13:07:35 INFO - 'sessionrestore_no_auto_restore', 13:07:35 INFO - 'tabpaint']}, 13:07:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['tsvgx', 13:07:35 INFO - 'tsvgr_opacity', 13:07:35 INFO - 'tart', 13:07:35 INFO - 'tscrollx', 13:07:35 INFO - 'cart', 13:07:35 INFO - 'tsvg_static']}, 13:07:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:07:35 INFO - 'tsvgr_opacity', 13:07:35 INFO - 'tart', 13:07:35 INFO - 'tscrollx', 13:07:35 INFO - 'cart', 13:07:35 INFO - 'tsvg_static']}, 13:07:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:07:35 INFO - 'talos_options': ['--disable-e10s'], 13:07:35 INFO - 'tests': ['tp5o']}, 13:07:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:07:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:07:35 INFO - 'talos_options': ['--disable-e10s', 13:07:35 INFO - '--xperf_path', 13:07:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:35 INFO - 'tests': ['tp5n']}, 13:07:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:07:35 INFO - 'talos_options': ['--xperf_path', 13:07:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:35 INFO - 'tests': ['tp5n']}}, 13:07:35 INFO - 'talos.zip': {'path': '', 13:07:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:35 INFO - Running post-action listener: _resource_record_post_action 13:07:35 INFO - [mozharness: 2017-02-09 21:07:35.873269Z] Finished populate-webroot step (success) 13:07:35 INFO - [mozharness: 2017-02-09 21:07:35.873359Z] Running create-virtualenv step. 13:07:35 INFO - Running pre-action listener: _resource_record_pre_action 13:07:35 INFO - Running main action method: create_virtualenv 13:07:35 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:35 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 13:07:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:35 INFO - Using real prefix '/usr' 13:07:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:36 INFO - Installing distribute.............................................................................................................................................................................................done. 13:07:38 INFO - Installing pip.................done. 13:07:38 INFO - Return code: 0 13:07:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:07:38 INFO - Reading from file tmpfile_stdout 13:07:38 INFO - Output received: 13:07:38 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) 13:07:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:38 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 0xaa21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, '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': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', '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 13:07:38 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 13:07:38 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 13:07:38 INFO - Using env: {'DISPLAY': ':0', 13:07:38 INFO - 'HOME': '/home/cltbld', 13:07:38 INFO - 'LANG': 'en_US.UTF-8', 13:07:38 INFO - 'LANGUAGE': 'en_US:en', 13:07:38 INFO - 'LOGNAME': 'cltbld', 13:07:38 INFO - 'MAIL': '/var/mail/cltbld', 13:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:38 INFO - 'MOZ_NO_REMOTE': '1', 13:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:38 INFO - 'NO_EM_RESTART': '1', 13:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:38 INFO - 'PWD': '/builds/slave/test', 13:07:38 INFO - 'SHELL': '/bin/bash', 13:07:38 INFO - 'SHLVL': '1', 13:07:38 INFO - 'TERM': 'linux', 13:07:38 INFO - 'TMOUT': '86400', 13:07:38 INFO - 'USER': 'cltbld', 13:07:38 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:38 INFO - '_': '/tools/buildbot/bin/python'} 13:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:38 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 13:07:38 INFO - Cleaning up... 13:07:38 INFO - Return code: 0 13:07:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:38 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 0xaa21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, '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': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', '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 13:07:38 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 13:07:38 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 13:07:38 INFO - Using env: {'DISPLAY': ':0', 13:07:38 INFO - 'HOME': '/home/cltbld', 13:07:38 INFO - 'LANG': 'en_US.UTF-8', 13:07:38 INFO - 'LANGUAGE': 'en_US:en', 13:07:38 INFO - 'LOGNAME': 'cltbld', 13:07:38 INFO - 'MAIL': '/var/mail/cltbld', 13:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:38 INFO - 'MOZ_NO_REMOTE': '1', 13:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:38 INFO - 'NO_EM_RESTART': '1', 13:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:38 INFO - 'PWD': '/builds/slave/test', 13:07:38 INFO - 'SHELL': '/bin/bash', 13:07:38 INFO - 'SHLVL': '1', 13:07:38 INFO - 'TERM': 'linux', 13:07:38 INFO - 'TMOUT': '86400', 13:07:38 INFO - 'USER': 'cltbld', 13:07:38 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:38 INFO - '_': '/tools/buildbot/bin/python'} 13:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:39 INFO - Downloading/unpacking psutil>=3.1.1 13:07:39 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 13:07:39 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 13:07:39 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 13:07:39 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 13:07:39 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 13:07:39 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 13:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:07:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:41 INFO - Installing collected packages: psutil 13:07:41 INFO - Running setup.py install for psutil 13:07:41 INFO - building 'psutil._psutil_linux' extension 13:07:41 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 13:07:41 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 13:07:41 INFO - building 'psutil._psutil_posix' extension 13:07:41 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 13:07:41 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 13:07:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:41 INFO - Successfully installed psutil 13:07:41 INFO - Cleaning up... 13:07:41 INFO - Return code: 0 13:07:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:07:41 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')]} 13:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:41 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')]} 13:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:41 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 0xaa21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, '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': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', '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 13:07:41 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 13:07:41 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 13:07:41 INFO - Using env: {'DISPLAY': ':0', 13:07:41 INFO - 'HOME': '/home/cltbld', 13:07:41 INFO - 'LANG': 'en_US.UTF-8', 13:07:41 INFO - 'LANGUAGE': 'en_US:en', 13:07:41 INFO - 'LOGNAME': 'cltbld', 13:07:41 INFO - 'MAIL': '/var/mail/cltbld', 13:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:41 INFO - 'MOZ_NO_REMOTE': '1', 13:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:41 INFO - 'NO_EM_RESTART': '1', 13:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:41 INFO - 'PWD': '/builds/slave/test', 13:07:41 INFO - 'SHELL': '/bin/bash', 13:07:41 INFO - 'SHLVL': '1', 13:07:41 INFO - 'TERM': 'linux', 13:07:41 INFO - 'TMOUT': '86400', 13:07:41 INFO - 'USER': 'cltbld', 13:07:41 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:41 INFO - '_': '/tools/buildbot/bin/python'} 13:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:07:42 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 13:07:42 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 13:07:42 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 13:07:42 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 13:07:42 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 13:07:42 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 13:07:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:07:44 INFO - Installing collected packages: mozsystemmonitor 13:07:44 INFO - Running setup.py install for mozsystemmonitor 13:07:44 INFO - Successfully installed mozsystemmonitor 13:07:44 INFO - Cleaning up... 13:07:44 INFO - Return code: 0 13:07:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:07:44 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')]} 13:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:44 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')]} 13:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:44 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 0xaa21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, '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': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', '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 13:07:44 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 13:07:44 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 13:07:44 INFO - Using env: {'DISPLAY': ':0', 13:07:44 INFO - 'HOME': '/home/cltbld', 13:07:44 INFO - 'LANG': 'en_US.UTF-8', 13:07:44 INFO - 'LANGUAGE': 'en_US:en', 13:07:44 INFO - 'LOGNAME': 'cltbld', 13:07:44 INFO - 'MAIL': '/var/mail/cltbld', 13:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:44 INFO - 'MOZ_NO_REMOTE': '1', 13:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:44 INFO - 'NO_EM_RESTART': '1', 13:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:44 INFO - 'PWD': '/builds/slave/test', 13:07:44 INFO - 'SHELL': '/bin/bash', 13:07:44 INFO - 'SHLVL': '1', 13:07:44 INFO - 'TERM': 'linux', 13:07:44 INFO - 'TMOUT': '86400', 13:07:44 INFO - 'USER': 'cltbld', 13:07:44 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:44 INFO - '_': '/tools/buildbot/bin/python'} 13:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:44 INFO - Downloading/unpacking jsonschema==2.5.1 13:07:44 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 13:07:44 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 13:07:44 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 13:07:44 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 13:07:44 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 13:07:44 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 13:07:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:07:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 INFO - Downloading functools32-3.2.3-2.tar.gz 13:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:07:46 INFO - warning: no files found matching '*.txt' 13:07:46 INFO - no previously-included directories found matching 'build' 13:07:46 INFO - no previously-included directories found matching 'dist' 13:07:46 INFO - no previously-included directories found matching '.git*' 13:07:46 INFO - Installing collected packages: jsonschema, functools32 13:07:46 INFO - Running setup.py install for functools32 13:07:46 INFO - warning: no files found matching '*.txt' 13:07:46 INFO - no previously-included directories found matching 'build' 13:07:46 INFO - no previously-included directories found matching 'dist' 13:07:46 INFO - no previously-included directories found matching '.git*' 13:07:46 INFO - Successfully installed jsonschema functools32 13:07:46 INFO - Cleaning up... 13:07:47 INFO - Return code: 0 13:07:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:47 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 0xaa21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, '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': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', '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 13:07:47 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 13:07:47 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 13:07:47 INFO - Using env: {'DISPLAY': ':0', 13:07:47 INFO - 'HOME': '/home/cltbld', 13:07:47 INFO - 'LANG': 'en_US.UTF-8', 13:07:47 INFO - 'LANGUAGE': 'en_US:en', 13:07:47 INFO - 'LOGNAME': 'cltbld', 13:07:47 INFO - 'MAIL': '/var/mail/cltbld', 13:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:47 INFO - 'MOZ_NO_REMOTE': '1', 13:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:47 INFO - 'NO_EM_RESTART': '1', 13:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:47 INFO - 'PWD': '/builds/slave/test', 13:07:47 INFO - 'SHELL': '/bin/bash', 13:07:47 INFO - 'SHLVL': '1', 13:07:47 INFO - 'TERM': 'linux', 13:07:47 INFO - 'TMOUT': '86400', 13:07:47 INFO - 'USER': 'cltbld', 13:07:47 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:47 INFO - '_': '/tools/buildbot/bin/python'} 13:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:07:47 INFO - Cleaning up... 13:07:47 INFO - Return code: 0 13:07:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:47 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 0xaa21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, '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': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', '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 13:07:47 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 13:07:47 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 13:07:47 INFO - Using env: {'DISPLAY': ':0', 13:07:47 INFO - 'HOME': '/home/cltbld', 13:07:47 INFO - 'LANG': 'en_US.UTF-8', 13:07:47 INFO - 'LANGUAGE': 'en_US:en', 13:07:47 INFO - 'LOGNAME': 'cltbld', 13:07:47 INFO - 'MAIL': '/var/mail/cltbld', 13:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:47 INFO - 'MOZ_NO_REMOTE': '1', 13:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:47 INFO - 'NO_EM_RESTART': '1', 13:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:47 INFO - 'PWD': '/builds/slave/test', 13:07:47 INFO - 'SHELL': '/bin/bash', 13:07:47 INFO - 'SHLVL': '1', 13:07:47 INFO - 'TERM': 'linux', 13:07:47 INFO - 'TMOUT': '86400', 13:07:47 INFO - 'USER': 'cltbld', 13:07:47 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:47 INFO - '_': '/tools/buildbot/bin/python'} 13:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:47 INFO - Downloading/unpacking blobuploader==1.2.4 13:07:47 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 13:07:47 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 13:07:47 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 13:07:47 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 13:07:47 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 13:07:47 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 13:07:49 INFO - Downloading blobuploader-1.2.4.tar.gz 13:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:07:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:07:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:50 INFO - Downloading docopt-0.6.1.tar.gz 13:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:07:50 INFO - Installing collected packages: blobuploader, requests, docopt 13:07:50 INFO - Running setup.py install for blobuploader 13:07:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:07:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:07:50 INFO - Running setup.py install for requests 13:07:50 INFO - Running setup.py install for docopt 13:07:50 INFO - Successfully installed blobuploader requests docopt 13:07:50 INFO - Cleaning up... 13:07:50 INFO - Return code: 0 13:07:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:50 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 0xaa21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, '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': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', '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 13:07:50 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 13:07:50 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 13:07:50 INFO - Using env: {'DISPLAY': ':0', 13:07:50 INFO - 'HOME': '/home/cltbld', 13:07:50 INFO - 'LANG': 'en_US.UTF-8', 13:07:50 INFO - 'LANGUAGE': 'en_US:en', 13:07:50 INFO - 'LOGNAME': 'cltbld', 13:07:50 INFO - 'MAIL': '/var/mail/cltbld', 13:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:50 INFO - 'MOZ_NO_REMOTE': '1', 13:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:50 INFO - 'NO_EM_RESTART': '1', 13:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:50 INFO - 'PWD': '/builds/slave/test', 13:07:50 INFO - 'SHELL': '/bin/bash', 13:07:50 INFO - 'SHLVL': '1', 13:07:50 INFO - 'TERM': 'linux', 13:07:50 INFO - 'TMOUT': '86400', 13:07:50 INFO - 'USER': 'cltbld', 13:07:50 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:50 INFO - '_': '/tools/buildbot/bin/python'} 13:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:51 INFO - Running setup.py (path:/tmp/pip-kOCJR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:51 INFO - Running setup.py (path:/tmp/pip-0d0IP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:51 INFO - Running setup.py (path:/tmp/pip-7uGCgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:51 INFO - Running setup.py (path:/tmp/pip-wV4Yna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:51 INFO - Running setup.py (path:/tmp/pip-4evnub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:51 INFO - Running setup.py (path:/tmp/pip-ESMKjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:51 INFO - Running setup.py (path:/tmp/pip-FhGY5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:51 INFO - Running setup.py (path:/tmp/pip-s8Q6rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:51 INFO - Running setup.py (path:/tmp/pip-9uYQ9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:51 INFO - Running setup.py (path:/tmp/pip-o2vDmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:51 INFO - Running setup.py (path:/tmp/pip-3RCe2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:51 INFO - Running setup.py (path:/tmp/pip-aLr4vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:51 INFO - Running setup.py (path:/tmp/pip-SFaUl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:52 INFO - Running setup.py (path:/tmp/pip-qcDJga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:52 INFO - Running setup.py (path:/tmp/pip-LvhQZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:52 INFO - Running setup.py (path:/tmp/pip-sfFzjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:52 INFO - Running setup.py (path:/tmp/pip-Sb4RVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:07:52 INFO - Running setup.py install for manifestparser 13:07:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:07:52 INFO - Running setup.py install for mozcrash 13:07:52 INFO - Running setup.py install for mozdebug 13:07:52 INFO - Running setup.py install for mozdevice 13:07:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:07:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:07:52 INFO - Running setup.py install for mozfile 13:07:52 INFO - Running setup.py install for mozhttpd 13:07:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for mozinfo 13:07:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for mozInstall 13:07:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for mozleak 13:07:53 INFO - Running setup.py install for mozlog 13:07:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for moznetwork 13:07:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for mozprocess 13:07:53 INFO - Running setup.py install for mozprofile 13:07:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for mozrunner 13:07:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for mozscreenshot 13:07:53 INFO - Running setup.py install for moztest 13:07:54 INFO - Running setup.py install for mozversion 13:07:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:07:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:07:54 INFO - Cleaning up... 13:07:54 INFO - Return code: 0 13:07:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:54 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 0xaa21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, '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': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', '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 13:07:54 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 13:07:54 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 13:07:54 INFO - Using env: {'DISPLAY': ':0', 13:07:54 INFO - 'HOME': '/home/cltbld', 13:07:54 INFO - 'LANG': 'en_US.UTF-8', 13:07:54 INFO - 'LANGUAGE': 'en_US:en', 13:07:54 INFO - 'LOGNAME': 'cltbld', 13:07:54 INFO - 'MAIL': '/var/mail/cltbld', 13:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:54 INFO - 'MOZ_NO_REMOTE': '1', 13:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:54 INFO - 'NO_EM_RESTART': '1', 13:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:54 INFO - 'PWD': '/builds/slave/test', 13:07:54 INFO - 'SHELL': '/bin/bash', 13:07:54 INFO - 'SHLVL': '1', 13:07:54 INFO - 'TERM': 'linux', 13:07:54 INFO - 'TMOUT': '86400', 13:07:54 INFO - 'USER': 'cltbld', 13:07:54 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:54 INFO - '_': '/tools/buildbot/bin/python'} 13:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:54 INFO - Running setup.py (path:/tmp/pip-Ds_6ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:54 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)) 13:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:54 INFO - Running setup.py (path:/tmp/pip-7HtjMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:54 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)) 13:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:54 INFO - Running setup.py (path:/tmp/pip-4Uk215-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:54 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)) 13:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:54 INFO - Running setup.py (path:/tmp/pip-ay54D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:54 INFO - Running setup.py (path:/tmp/pip-emNYzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:54 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)) 13:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:54 INFO - Running setup.py (path:/tmp/pip-nzmO_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:54 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)) 13:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:54 INFO - Running setup.py (path:/tmp/pip-NESSI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:54 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)) 13:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:54 INFO - Running setup.py (path:/tmp/pip-fIg71K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:55 INFO - Running setup.py (path:/tmp/pip-5YS0Yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:55 INFO - Running setup.py (path:/tmp/pip-QpQ7aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:55 INFO - Running setup.py (path:/tmp/pip-dxdFc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:55 INFO - Running setup.py (path:/tmp/pip-8AWIel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:55 INFO - Running setup.py (path:/tmp/pip-kc4XxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:55 INFO - Running setup.py (path:/tmp/pip-z17xti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:55 INFO - Running setup.py (path:/tmp/pip-x5LRRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:55 INFO - Running setup.py (path:/tmp/pip-916cjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:55 INFO - Running setup.py (path:/tmp/pip-lFHLVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:07:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:57 INFO - Downloading blessings-1.6.tar.gz 13:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:07:57 INFO - Installing collected packages: blessings 13:07:57 INFO - Running setup.py install for blessings 13:07:57 INFO - Successfully installed blessings 13:07:57 INFO - Cleaning up... 13:07:57 INFO - Return code: 0 13:07:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:07:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:07:58 INFO - Reading from file tmpfile_stdout 13:07:58 INFO - Current package versions: 13:07:58 INFO - argparse == 1.2.1 13:07:58 INFO - blessings == 1.6 13:07:58 INFO - blobuploader == 1.2.4 13:07:58 INFO - docopt == 0.6.1 13:07:58 INFO - functools32 == 3.2.3-2 13:07:58 INFO - jsonschema == 2.5.1 13:07:58 INFO - manifestparser == 1.1 13:07:58 INFO - mozInstall == 1.12 13:07:58 INFO - mozcrash == 1.0 13:07:58 INFO - mozdebug == 0.1 13:07:58 INFO - mozdevice == 0.49 13:07:58 INFO - mozfile == 1.2 13:07:58 INFO - mozhttpd == 0.7 13:07:58 INFO - mozinfo == 0.9 13:07:58 INFO - mozleak == 0.1 13:07:58 INFO - mozlog == 3.4 13:07:58 INFO - moznetwork == 0.27 13:07:58 INFO - mozprocess == 0.24 13:07:58 INFO - mozprofile == 0.28 13:07:58 INFO - mozrunner == 6.13 13:07:58 INFO - mozscreenshot == 0.1 13:07:58 INFO - mozsystemmonitor == 0.3 13:07:58 INFO - moztest == 0.8 13:07:58 INFO - mozversion == 1.4 13:07:58 INFO - psutil == 3.1.1 13:07:58 INFO - requests == 1.2.3 13:07:58 INFO - wsgiref == 0.1.2 13:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:58 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 0xaa21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, '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': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', '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 13:07:58 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 13:07:58 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 13:07:58 INFO - Using env: {'DISPLAY': ':0', 13:07:58 INFO - 'HOME': '/home/cltbld', 13:07:58 INFO - 'LANG': 'en_US.UTF-8', 13:07:58 INFO - 'LANGUAGE': 'en_US:en', 13:07:58 INFO - 'LOGNAME': 'cltbld', 13:07:58 INFO - 'MAIL': '/var/mail/cltbld', 13:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:58 INFO - 'MOZ_NO_REMOTE': '1', 13:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:58 INFO - 'NO_EM_RESTART': '1', 13:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:58 INFO - 'PWD': '/builds/slave/test', 13:07:58 INFO - 'SHELL': '/bin/bash', 13:07:58 INFO - 'SHLVL': '1', 13:07:58 INFO - 'TERM': 'linux', 13:07:58 INFO - 'TMOUT': '86400', 13:07:58 INFO - 'USER': 'cltbld', 13:07:58 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:58 INFO - '_': '/tools/buildbot/bin/python'} 13:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:58 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)) 13:07:58 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)) 13:07:58 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)) 13:07:58 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)) 13:07:58 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)) 13:07:58 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)) 13:07:58 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)) 13:07:58 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)) 13:07:58 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)) 13:07:58 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)) 13:07:58 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)) 13:07:58 INFO - Cleaning up... 13:07:58 INFO - Return code: 0 13:07:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaa21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, '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': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', '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 13:07: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', 'jsonschema'] in /builds/slave/test/build 13:07: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 jsonschema 13:07:58 INFO - Using env: {'DISPLAY': ':0', 13:07:58 INFO - 'HOME': '/home/cltbld', 13:07:58 INFO - 'LANG': 'en_US.UTF-8', 13:07:58 INFO - 'LANGUAGE': 'en_US:en', 13:07:58 INFO - 'LOGNAME': 'cltbld', 13:07:58 INFO - 'MAIL': '/var/mail/cltbld', 13:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:58 INFO - 'MOZ_NO_REMOTE': '1', 13:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:58 INFO - 'NO_EM_RESTART': '1', 13:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:58 INFO - 'PWD': '/builds/slave/test', 13:07:58 INFO - 'SHELL': '/bin/bash', 13:07:58 INFO - 'SHLVL': '1', 13:07:58 INFO - 'TERM': 'linux', 13:07:58 INFO - 'TMOUT': '86400', 13:07:58 INFO - 'USER': 'cltbld', 13:07:58 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:58 INFO - '_': '/tools/buildbot/bin/python'} 13:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:07:58 INFO - Cleaning up... 13:07:58 INFO - Return code: 0 13:07:58 INFO - Running post-action listener: _resource_record_post_action 13:07:58 INFO - Running post-action listener: _start_resource_monitoring 13:07:58 INFO - Starting resource monitoring. 13:07:58 INFO - [mozharness: 2017-02-09 21:07:58.626032Z] Finished create-virtualenv step (success) 13:07:58 INFO - [mozharness: 2017-02-09 21:07:58.626524Z] Running install step. 13:07:58 INFO - Running pre-action listener: _resource_record_pre_action 13:07:58 INFO - Running main action method: install 13:07:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:07:58 INFO - Reading from file tmpfile_stdout 13:07:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:07:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:07:58 INFO - Reading from file tmpfile_stdout 13:07:58 INFO - Output received: 13:07:58 INFO - Usage: mozinstall [options] installer 13:07:58 INFO - Options: 13:07:58 INFO - -h, --help show this help message and exit 13:07:58 INFO - -d DEST, --destination=DEST 13:07:58 INFO - Directory to install application into. [default: 13:07:58 INFO - "/builds/slave/test"] 13:07:58 INFO - --app=APP Application being installed. [default: firefox] 13:07:58 INFO - mkdir: /builds/slave/test/build/application 13:07:58 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'] 13:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:08:15 INFO - Reading from file tmpfile_stdout 13:08:15 INFO - Output received: 13:08:15 INFO - /builds/slave/test/build/application/firefox/firefox 13:08:15 INFO - Running post-action listener: _resource_record_post_action 13:08:15 INFO - [mozharness: 2017-02-09 21:08:15.429579Z] Finished install step (success) 13:08:15 INFO - [mozharness: 2017-02-09 21:08:15.429865Z] Running run-tests step. 13:08:15 INFO - Running pre-action listener: _resource_record_pre_action 13:08:15 INFO - Running main action method: run_tests 13:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:15 INFO - Python 2.7.3 13:08:15 INFO - Return code: 0 13:08:15 INFO - grabbing minidump binary from tooltool 13:08:15 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')]} 13:08:15 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 0xe11820>, '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 0xe12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe129b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:15 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 13:08:15 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 13:08:15 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 13:08:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:15 INFO - Return code: 0 13:08:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:08:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:08:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:08:15 INFO - Using env: {'DISPLAY': ':0', 13:08:15 INFO - 'HOME': '/home/cltbld', 13:08:15 INFO - 'LANG': 'en_US.UTF-8', 13:08:15 INFO - 'LANGUAGE': 'en_US:en', 13:08:15 INFO - 'LOGNAME': 'cltbld', 13:08:15 INFO - 'MAIL': '/var/mail/cltbld', 13:08:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:15 INFO - 'MOZ_NO_REMOTE': '1', 13:08:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:15 INFO - 'NO_EM_RESTART': '1', 13:08:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:15 INFO - 'PWD': '/builds/slave/test', 13:08:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:15 INFO - 'SHELL': '/bin/bash', 13:08:15 INFO - 'SHLVL': '1', 13:08:15 INFO - 'TERM': 'linux', 13:08:15 INFO - 'TMOUT': '86400', 13:08:15 INFO - 'USER': 'cltbld', 13:08:15 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487', 13:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:15 INFO - '_': '/tools/buildbot/bin/python'} 13:08:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:08:15 INFO - mozversion application_buildid: 20170209200327 13:08:15 INFO - mozversion application_changeset: 2e0af7243d08369ef93638aa306f6cc2056c28b9 13:08:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:08:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:15 INFO - mozversion application_name: Firefox 13:08:15 INFO - mozversion application_remotingname: firefox-dev 13:08:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:08:15 INFO - mozversion application_vendor: Mozilla 13:08:15 INFO - mozversion application_version: 53.0a2 13:08:15 INFO - mozversion platform_buildid: 20170209200327 13:08:15 INFO - mozversion platform_changeset: 2e0af7243d08369ef93638aa306f6cc2056c28b9 13:08:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:08:15 INFO - mozversion platform_version: 53.0a2 13:08:15 INFO - using testdate: 1486674495 13:08:15 INFO - actual date: 1486674495 13:08:15 INFO - starting webserver on 'localhost:45933' 13:08:15 INFO - SUITE-START | Running 2 tests 13:08:15 INFO - TEST-START | dromaeo_css 13:08:15 INFO - operating with platform_type : linux_ 13:08:15 INFO - Initialising browser for dromaeo_css test... 13:08:15 INFO - TEST-INFO | started process 5542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSKuAWU/profile http://localhost:45933/getInfo.html) 13:08:20 INFO - PROCESS | 5542 | __metrics Screen width/height:1600/1200 13:08:20 INFO - PROCESS | 5542 | colorDepth:24 13:08:20 INFO - PROCESS | 5542 | Browser inner width/height: 1024/697 13:08:20 INFO - PROCESS | 5542 | __metrics 13:08:21 INFO - PROCESS | 5542 | 1486674501292 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpSKuAWU/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpSKuAWU/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpSKuAWU/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpSKuAWU/profile/extensions/talos-powers@TalosPowersService.js:55:9 13:08:21 ERROR - PROCESS | 5542 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 13:08:22 INFO - TEST-INFO | 5542: exit 0 13:08:22 INFO - Browser initialized. 13:08:22 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:22 INFO - TEST-INFO | started process 5669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSKuAWU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:34 INFO - PROCESS | 5669 | RSS: Main: 144232448 13:08:34 INFO - PROCESS | 5669 | 13:11:33 INFO - PROCESS | 5669 | Cycle 1(1): loaded http://localhost:45933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45933/tests/dromaeo/cssquery-ext.html) 13:11:34 INFO - PROCESS | 5669 | RSS: Main: 152002560 13:11:34 INFO - PROCESS | 5669 | 13:13:22 INFO - PROCESS | 5669 | ************************* 13:13:22 INFO - PROCESS | 5669 | A coding exception was thrown and uncaught in a Task. 13:13:22 INFO - PROCESS | 5669 | 13:13:22 ERROR - PROCESS | 5669 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:13:22 INFO - PROCESS | 5669 | Full stack: 13:13:22 INFO - PROCESS | 5669 | ************************* 13:14:36 INFO - PROCESS | 5669 | Cycle 1(1): loaded http://localhost:45933/tests/dromaeo/cssquery-ext.html (next: http://localhost:45933/tests/dromaeo/cssquery-jquery.html) 13:14:37 INFO - PROCESS | 5669 | RSS: Main: 149798912 13:14:37 INFO - PROCESS | 5669 | 13:17:39 INFO - PROCESS | 5669 | Cycle 1(1): loaded http://localhost:45933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45933/tests/dromaeo/cssquery-mootools.html) 13:17:39 INFO - PROCESS | 5669 | RSS: Main: 154083328 13:17:39 INFO - PROCESS | 5669 | 13:20:41 INFO - PROCESS | 5669 | Cycle 1(1): loaded http://localhost:45933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45933/tests/dromaeo/cssquery-prototype.html) 13:20:42 INFO - PROCESS | 5669 | RSS: Main: 149606400 13:20:42 INFO - PROCESS | 5669 | 13:23:44 INFO - PROCESS | 5669 | Cycle 1(1): loaded http://localhost:45933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45933/tests/dromaeo/cssquery-yui.html) 13:23:45 INFO - PROCESS | 5669 | RSS: Main: 152903680 13:23:45 INFO - PROCESS | 5669 | 13:26:47 INFO - PROCESS | 5669 | Cycle 1(1): loaded http://localhost:45933/tests/dromaeo/cssquery-yui.html (next: http://localhost:45933/tests/dromaeo/cssquery-dojo.html) 13:26:47 INFO - PROCESS | 5669 | RSS: Main: 153075712 13:26:47 INFO - PROCESS | 5669 | 13:26:47 INFO - PROCESS | 5669 | __start_tp_report 13:26:47 INFO - PROCESS | 5669 | _x_x_mozilla_page_load 13:26:47 INFO - PROCESS | 5669 | _x_x_mozilla_page_load_details 13:26:47 INFO - PROCESS | 5669 | |i|pagename|runs| 13:26:47 INFO - PROCESS | 5669 | |0;dojo.html;3282.4748040313552;3288.276579152586;3303.405387030335;3306.6197387300467;3314.0057982605213;5578.748956296966;5629.943700562993;5653.434656534345;5654.378018417976;5655.23654306669;5583.804566840151;5695.45893140151;5717.685527295997;5731.512821410185;5766.481016708495;5060.69635821851;5075.873103172414;5114.360704911886;5114.462981386957;5142.7428628568605;5123.769430375623;5128.974355128238;5134.460881607433;5143.3570803649545;5157.71632560209;5034.798608055673;5039.974800125994;5145.794168233266;5159.406668233145;5185.299984502081;5011.473795251482;5012.147934851084;5050.696958182484;5119.692818430887;5122.282880396748;4996.575291100261;5055.898882022376;5059.114654935372;5063.01271252106;5066.986602679479;5554.222408862763;5570.275864137677;5644.858878528029;5646.576506761969;5648.63283886546;5913.852153696149;5935.258092738408;5938.406159384027;5949.553783466257;6026.2165918430765;6052.152698622196;6055.364186760415;6057.121717351003;6075.483583895374;6078.544109191828;5614.550835933115;5622.353429355595;5624.21261023457;5627.634203776783;5656.264685590847;6029.306629737549;6030.849228769316;6064.120702498113;6093.6039157454625;6107.96946015276;5878;5968.671723055187;5982.641041537521;5998.940010599838;6001.909971350433;6028.5478589106;6068.878622427526;6080.878382432326;6089.086637004396;6103.023516237381;5808.273965754281;5835.183074369592;5927.673977931255;6028.698565071729;6047;5971;6025.216721826135;6054.212952316171;6086.817395478142;6100.938990610126;4616.6537509686905;4636.744979026186;4640;4656.8602941911795;4663.650226233046;4020.2361551305157;4038.2327357801923;4106.876793696194;4110.095778928631;4156.189543039139;5775.913361299584;5777.8555536111935;5798.246227990334;5837.211976383219;5890.9410905891245;6004.279486461653;6040.577159598874;6040.879182416327;6045;6069.969650151721;5653.530082178663;5766.509846662997;5807.738651760681;5809.767609295665;5820.82537523875;5140;5196.168613021899;5198.740062996911;5202.401723801736;5224.764885580158;6342.936570634327;6358.1734374531015;6376.171097757355;6382.904256436157;6383.616982981036;5918.822435326947;5967.671778052075;6106.755729770937;6114.48026917717;6118.143459915705;6217.96891015542;6225.470834979077;6256.655883926428;6319.715612797527;6334.904976425265;5954.970225148846;6001.309849367379;6018.3981601841215;6037.939620603738;6071.150038994456;5961.195238642727;5991.7902873399225;6062.696865156637;6103.725332359965;6125.908111378422;5839.386864379179;5849.356570777296;5879.529637628894;5885.08781138907;5988.700564971647;5896.882062358814;5947.405259474018;5962.672053037125;5964.642121472725;5975.223220981245;5874.618149820248;5905.852353691021;5911.201987731602;5913.793017244376;5930.436608522184;5724.856878578069;5904.586678932434;5907.852303692442;5958.940410595838;6027.78902738402;5829.737661805314;5847.1229315603;5849.3858144894175;5850.53195744348;5851.765929362778 13:26:47 INFO - PROCESS | 5669 | |1;ext.html;569.2514343638115;582.8542864283929;589.6255877517776;607.1590846677351;635.9841003974902;46606.3009054864;49090.754546227305;49252.999999999956;53770.46229537713;53910;50897.49102508974;51419;51449;51526.74236628812;51640.225396619084;9330.113639204264;9525.380850244746;9532;9553.235741140727;10727.08819750322;10200.642977495789;10588.258821882433;10593.417362045084;10642.733931651694;10671.83992240117;10495.212859035564;10625.574977000912;10639.52122154501;10719.571217151344;10759.300645458059;10577.153827693804;10624.831268560452;10625.574977000912;10641.574337026586;10651.573937042547;10917.23579349446;10975.670729878117;11001.504932278067;11003;11030.613928512545;42834.35748463775;43014;43094.78452607717;43516.56483435157;43608.78195609002;4442.5113237544165;4466.1067786442845;4476.261416866213;4481.551844815525;4589.944312808039;29537.852310738523;31836;32261.193470163198;32515;32813.343733125206;4635.536446355338;4685.976570117162;4690.4605970313505;4700.882477938045;4716.292556116576;395869;399049;400490;400945;404147;62659.37340626626;62810.68594657089;63079;63375.683121584094;63409;65852.34147658462;66126.66936665382;66376.6681166591;66462.33537664561;66651;19145.80854191468;19637;19643.90178049129;19663.213471461266;19674;13692.246926418944;14014;15151.393944242327;15343.769843452357;15387.153706546247;20130.094145763476;20138.19447222095;20580.794192058187;20660.690089648666;20663.17347306121;7415.8146046349275;7467.551946883204;7586.696532138763;7622.771316860392;7701.961490192513;990.9900900990898;1013.1084645511902;1024.1704219582161;1026.4970164619433;1030.6147343055252;33850.322993539994;33858.49212261818;33883.39822302047;34046.48930266048;34153.829230853684;1118.3178261260625;1187.352892673495;1216.3310179401294;1225.2954551133134;1229.3115855120982;17458.912705436393;17551.210195541233;17654;17677.911610441864;17836.821631783518;521876;523225;524467;525304;525686;71951;72207.63896180486;72344;72601.2739872605;72711.27288727151;1552.270432896537;1569.1369746639302;1577.4952015355207;1588.563145135074;1595.3060418717894;30941.226469338446;32617.18457038593;32950;33208.667913320554;33269.667303326656;56840.71579642075;57722.134167986675;57889;58037;58378.7081064592;472947;474913;475535;480791;481770;27834;28419;28888.133355999355;28979.130626081253;29925.850370748878;47453.52546474629;47929;47974.760126199144;48138.5186148134;49165.75417122892;41904.371434429115;42676.359854601586;42998;43037.3544396828;43252.35121473118;42220;42312;42422.575774241865;42776.06680609491;42854.78572607117;42513.36229956615;42533.1493370137;48689.75655121844;49007;49416.752916235186;42693.35959960665;47630;48234.27648585344;48757.756211218715;48987.75506122447;36440.72008668112;36657.26685466222;36939.63060369362;37183.256334873695;37275.44086838645 13:26:47 INFO - PROCESS | 5669 | |2;jquery.html;432.37737657772783;439.6416920210029;439.70320033977055;441.3842689448219;446.29931008316936;21830.345089647315;21882.452938676543;22308.442288942784;22467.21364752234;22588.20941267056;22356.10575576979;22387;22402.775972240273;22721.20475783348;23462.882685586548;6039.75840966363;6061.333253342129;6259.311475737688;6261.592996455239;6285.371462853724;6052.485538729214;6125.509959203276;6196.287426945892;6202.534809889254;6216.285127210361;6023.488003519706;6149.6617686027475;6189.040698691688;6208.596441231328;6227.532935029891;6269.968650156766;6324;6338;6340.84147896304;6392.073149393358;6078.787242446538;6252.781152659681;6278.058291256302;6288.811335659938;6300.086487459339;14683.706325873423;14702.926485367612;14887.10677359351;15640.374385024585;15755.369785208577;3155.8106513609027;3206.278587317858;3229.5801545798895;3275.901722948315;3311.106001379638;11291.378974156418;11448.912353326421;11535.423228838525;11545.826812597817;11670.066394688405;1992.860499765017;2042.3974927396453;2048.6312463756517;2067.7518697756364;2107.504736386948;88717.11282887218;95752.56371154368;97641;101453;101946.49026754819;12157.209781364183;12207.816882746765;12453.75092498145;12528.749425011449;13090.410931508104;18273.17770700322;18297.634047319247;18298.17658205384;18319;18331.908340458478;8688.652453901774;8795.208431241092;8864.468131911977;8866.911330886738;9038.728838134866;8023.277904988579;8027.959860200662;8158.306543943712;8323.209295117076;8339.916600833914;5342.465753424704;5389;5400.270963419966;5424.972875135678;5526.944730552724;2166.018093444512;2180.9018594162985;2188.9562208755738;2199.747029091643;2251.4371407148215;950.8716323296405;972.6304004478253;975.7902051058915;978.6525783346951;995.5221493683073;20576.38270851877;22240.999155038062;22679.092836286694;23021.88489057544;23669.526609467714;1087.478010554938;1088.5754555723274;1090.547422819537;1104.5692180049787;1105.618561596248;11161.330320180816;11660.358680272497;11879;11939.283642981449;11948.103892208119;711797;711804;751913;792592;829823;89024;91796;110389;116660;117534.41232793781;1121.556984990924;1145.1525870855507;1172.6833754886304;1172.8533933258343;1178.6287319494331;19500.609987799882;19551.315703950295;19712.112954916778;19726;19794.307199247956;46514.30228546507;47206.76396617995;47290.76354618205;47371.76314118407;48429;67327.66336168288;67366.326336736;67628.3237167622;67965.66017169882;68071.65964170148;7922.643481043252;8650.178233067849;8679.869801953102;8900.599473023858;9604.135627793532;10769.892301076889;13953.3720982554;14307.284635767961;14472.276386180438;14564.126152430888;12384;12583.05627077991;12587.74824503523;12618;12858.871411286142;12322.199057061622;12408.503659853504;12408.62774116778;12511.812322814983;13022.869771302167;9625.085616866387;12775.80836287475;12800.487980480677;12831.10182287231;13192.274424906722;8611.052784193858;8757;8777.648894044167;8839.734807955772;8957.19385255304;12157.878421216028;12505.43725532335;12565.93717031409;12618.936905315415;12684.809727854274 13:26:47 INFO - PROCESS | 5669 | |3;mootools.html;1497.2438918346234;1516.651170230847;1526.2139997901083;1541.7764424158497;1552.8136623605162;8463.492190468569;8541.145885411455;8961.193492585666;9034.141756533136;9056.320775941806;8929.1517305856;9028.593713282902;9030.277577793777;9058.320625953063;9085;2434.4400787818813;2466.6053431450973;2468.814838887082;2475.4801491686767;2480.5659009673327;2420.5279970405777;2448.9387765305833;2457.803375729937;2538.3019669590826;2538.834975726581;2427.1383658801137;2487.8631675257852;2490.0413340863715;2491.9252422427357;2514.9119780807673;2371.9288421347387;2394.7964423024064;2404.939876503093;2411.7588241175918;2421.8183636227354;2428.3200703802786;2433.7687919647606;2434.6348047792794;2442.7435119312395;2457.2751038443525;8841.115888411172;8961.59672814725;8970.102989701043;8988.820223595558;9016.639334426614;5474.534664553478;5611.2144299798065;5615.438456154393;5626.268585083953;5636.633618814764;3470.774399664014;3646.197836475971;3651.653092956165;3656.378415669316;3680.705543556509;1436.1670231265946;1465.4870795221693;1530.0590137065735;2210.546837898227;2231.4421394651336;11878.465469053914;11918.940405298004;11943.283402995849;11951.820722689166;11967.222130561486;4575.382323386367;4660.231061874821;4714.5992590630185;4730.5032971538185;4863.8540843774745;9732.41605503672;9832.606695732233;9848.162906152915;9864.704058878246;9865.901340986498;5570.136628822539;5585.832425027255;5605.691686957175;5610.635308704921;5628.127640215773;5017.598592112622;5161.612879034087;5214.530692237641;5268.78924843002;5307.840764777063;3934.272159650474;4003.799810009546;4026.939595906064;4064.8577299794365;4093;1268.1630124118037;1273.2042473454092;1274.2800317820402;1278.7634287656813;1282.8524719657173;1018.3787889387468;1019.6329321444274;1029.4801125431609;1031.8091153136693;1048.753542917429;5838.153467747238;6116.327204007555;6121.265448146251;6229.470495007975;6458.22501299847;1075.6504136155781;1106.5573770491708;1107.95568177272;1117.2124600638913;1140.1562843495753;4239.427677263591;4313.158934007838;4391.297392417198;4401.823927042947;4457;10164.644237451801;10406.58373665045;10420.68737937863;10456.947715261374;10548.894511054945;10132.392056476636;10261.74345641365;10268.973102689672;10394.272400932014;10403.375797452025;7715.845683086307;8113.350931925432;8211.137830527709;8359.038710548242;8365.623546940402;5980.401959803985;6186.876262474815;6342.619442833445;6360.681965901779;6457.096006558992;9537.380070295409;9696.9030309696;9717.951410242904;9722.659706910224;9790.314677972474;9785.266105042008;9797.363171394121;9835.803283934425;9880.209583233467;9912.752181195528;7028.929710702828;7403.852402877563;7787.532748035136;7828.960855195687;7908.130105688485;8482.660693572188;8517.957410213157;8580.227779499624;8594.570271486276;8614.138586141336;7642.5032372895585;7650.349720273839;7713.922860771545;7734.2265773422205;7981.680732770624;7538.833689850386;7579.242075792376;7606.885896711443;7640.426967977535;7765.7670269892;6643.269240383651;6789.89815152783;6848.828779280558;6853.246142924374;6890.10428644273;5336.386315573759;5354.973225134006;5414.539764119936;5427.185922111715;5445.673259604437;5500.4499550044675;5533.612647114664;5539.307586551681;5637.351704554028;5639.520640745419 13:26:47 INFO - PROCESS | 5669 | |4;prototype.html;408.977506237157;410.9971669127329;425.08606496033525;427.9416008996724;428.7813215260218;5431.972840135803;5553.861153471155;5566;5598.552115830739;5599.776008959642;5437.429069947658;5464.562834973202;5474.698891560963;5488.1493368527845;5511.807086751955;4084.8774536763945;4267.125239325938;4267.935980960288;4269.509006464265;4288.957110428887;4236.766977816219;4261.803647264552;4283.271843786564;4284;4300.967767735737;4228.809703563332;4237.364395340708;4241.766702831343;4252.213340531996;4285.314349704048;4198.8320467181275;4208.179405016023;4260.68044896634;4275.358696195564;4291.678124140686;3770.622937706235;3780.111673756665;3780.319542482352;3782.3901507959695;3784.280986612535;5422.376426710939;5428.511433970962;5437.477506298243;5441.095616534221;5447.937652157831;4779.904401911977;4912.975435122838;4992.650514463989;5002;5031.874203144951;5761.366249712528;5770.163326317703;5771.971140144273;5776.335721392052;5776.682282474462;4160.2303573838635;4160.479940007499;4165.625093741578;4169.56219596944;4193.098483825992;5837.299524057098;5971.820845374646;6032.909506357408;6044.607100538451;6049.879002419927;4242.978785106055;4250.256205164084;4265.786710664516;4269.295566231537;4269.316909294498;4330.155619654201;4339.1972485090355;4347.934780978288;4363.825446982149;4374.912501749947;4755.9286610700865;4902.90194196114;4985.4823314226805;4993;4994.200927851526;5794.88410231793;5802.564807639359;5819.156222347736;5827.737751801094;5832.445917637818;1425.7148570285983;1432.6776475293184;1441.2865631512468;1444.4005737618982;1446.7991566999576;953.947532885684;975.9316847820585;989.6684610655511;991.791723738023;1016.364772017489;5458.945410545924;5473.343198816167;5475.644083134664;5527.917081243784;5548.5838562108;5678.659280443187;5715.571332150105;5762.366139724627;5848.736806843617;5850.2905161345525;5359.356877174764;5397.460253974649;5443.741041567132;5520.751566179531;5619.971900140473;3004.6244219472565;3014.291641464254;3024.6370435547874;3053.450378931769;3071.9232019199253;5728.799492017843;5956.85107872298;5981.0729336952845;5986.904583395777;6016.2479690038745;5778.306603207642;5843.766249350064;5849.122631605208;5867.647941123546;5900.262467191601;5934.525237980951;5982.893164764446;5992.760289588455;5997.560585459459;6000.879982400327;5587.346010644911;5603.831885043455;5692;5720.399358067343;5805.535557155502;5663.32040155184;5673.574481913791;5696.373398926197;5706.400827913009;5736.971315143398;5938.524918006463;5993.112169666541;6020.397960203944;6051.576389652682;6143.201383820075;4227.7040607157205;4238.131183107517;4241.681873859411;4243.236217480883;4245.490541135084;5691.630044047124;5809.5352371811;5923.526117910471;5930.911036334544;5937.376575459514;5711.173513745884;5718.942810571841;5719.685417301922;5723.170140329546;5724.227229324155;5670.347909990239;5733.483986441241;5748.6838223898085;5777.422257774357;5816.563757718103;5545.889082218252;5723.828285151452;5740.885182296247;5744;5755.740991655469;5794.043982742969;5825.3592104867585;5827.533797296291;5835.299764028344;5836.241288632451;5501.1938527797965;5570.331560212639;5664.348599910898;5687.857803554944;5703 13:26:47 INFO - PROCESS | 5669 | |5;yui.html;816.9550674712889;832.8875601793756;863.3611127765452;901.909809019098;920.493728449353;15214.999999999985;16266.268017939192;16507.587310317234;18098;18405.631887362244;14776.482823101194;14894.553163405088;14969;16736.83263167368;16895.493135205932;815.3355015662231;834.9165083491663;835.5613303015905;836.6611522333465;837.6984285657159;803.5058439059965;829.8879651247095;835.5738573327586;837.1126605797874;837.7068026190846;867.1025488619281;867.375489647456;868.431177578687;868.8783570300163;870.4907629037021;856.1908995998783;859.7549698335944;862.4868203418956;864.191980498233;864.6411739128285;627.595201095291;630.552307861419;630.867517821258;633.0472638678759;634.4638780230698;17624;18042.819571804244;18065.72901406467;18092;18161.54596135094;14292.428302867873;15443.150626715526;16168.191590420432;16356.509304720877;16468.505944821674;14112.71774564503;14588.708225835424;14670.363986110091;14713.779293310608;14757.18835464049;4733.857984260478;4824.324594556765;4837.637177211724;4851.830185943475;4988.925166122511;83344;83406.16593834106;83842.74235886466;84421;84664.57667711684;12388.938055309665;12542.749145017231;12675.556355527513;12769.936150319374;12789.744205115845;22682.43293917665;22768;23020.4244893879;23107.88446057759;23197.42006449852;8852.048020849297;8923.798124875273;9089.454632722058;9249.722508324761;9590.712278631652;4681.180793361148;4768.165571025057;4822.132016237041;4859.465458799529;4930.728809915489;4045.271851066836;4146.854860079943;4153.190127925026;4155.688323375759;4164.541900390955;634.9809505714744;720.6144712578745;721.2210812322679;726.12501935168;729.5403895545878;753.3408267765705;786.103841620553;792.9088154862264;800.6557180412362;802.6789284286332;11235.719107022227;11313.773724525463;11606.825897611543;11684.88315116855;11864.169508134348;849.6983570832389;856.280724191682;863.7970077031893;866.5537248317122;872.5375550958003;5035.899282014339;5087.592992560661;5190.506901844319;5200.401953775288;5244.187150991603;84573.57713211395;85253.57373213218;85626.14373856306;86854.56572717223;88534;75433.62283188659;75881;76581;77747.61126194333;78666;51453;53477.73261133747;60780.392196078355;69527.3047269531;69802.65098674575;11059.502322395672;11467.31196128235;11518.424078795859;11559.422028898689;11682.065434765029;40671;41424.37863431991;42386.57613423826;42633;42775;51391.74304128456;55602.721986389806;57914.7104264476;59427;59510.10734838894;14282.928585357007;14408.927955360155;14488.130712157305;14533.92733036328;14794.852051479347;16056.759148612546;16103.597410064842;16334.428295010093;16373.263203155648;16425.260863260944;13664.93167534156;13800.102993305403;13886.09740366873;14101.647458813612;14435.711285774016;14525.273736313353;14713.55859324222;14744.483943061941;14799.704005919606;14939.626509336918;13722.65693357674;13782.448702051806;13893.374798134311;14280.928595356956;14464.783028254795;12051.939740301243;12422.254664720145;12436.626901192978;12473.313967731861;12681;11987.280763153889;12342.75314493687;13105.109117833268;13156.342182891009;13287.40206690682 13:26:47 INFO - PROCESS | 5669 | __end_tp_report 13:26:47 INFO - PROCESS | 5669 | __start_cc_report 13:26:47 INFO - PROCESS | 5669 | _x_x_mozilla_cycle_collect,306 13:26:47 INFO - PROCESS | 5669 | __end_cc_report 13:26:47 INFO - PROCESS | 5669 | __startTimestamp1486675607926__endTimestamp 13:26:47 INFO - PROCESS | 5669 | 13:26:47 INFO - PROCESS | 5669 | ------- Summary: start ------- 13:26:47 INFO - PROCESS | 5669 | Number of tests: 6 13:26:47 INFO - PROCESS | 5669 | 13:26:47 INFO - PROCESS | 5669 | [#0] dojo.html Cycles:165 Average:5613.10 Median:5850.53 stddev:643.88 (11.0%) stddev-sans-first:619.35 13:26:47 INFO - PROCESS | 5669 | Values: 3282.5 3288.3 3303.4 3306.6 3314.0 5578.7 5629.9 5653.4 5654.4 5655.2 5583.8 5695.5 5717.7 5731.5 5766.5 5060.7 5075.9 5114.4 5114.5 5142.7 5123.8 5129.0 5134.5 5143.4 5157.7 5034.8 5040.0 5145.8 5159.4 5185.3 5011.5 5012.1 5050.7 5119.7 5122.3 4996.6 5055.9 5059.1 5063.0 5067.0 5554.2 5570.3 5644.9 5646.6 5648.6 5913.9 5935.3 5938.4 5949.6 6026.2 6052.2 6055.4 6057.1 6075.5 6078.5 5614.6 5622.4 5624.2 5627.6 5656.3 6029.3 6030.8 6064.1 6093.6 6108.0 5878.0 5968.7 5982.6 5998.9 6001.9 6028.5 6068.9 6080.9 6089.1 6103.0 5808.3 5835.2 5927.7 6028.7 6047.0 5971.0 6025.2 6054.2 6086.8 6100.9 4616.7 4636.7 4640.0 4656.9 4663.7 4020.2 4038.2 4106.9 4110.1 4156.2 5775.9 5777.9 5798.2 5837.2 5890.9 6004.3 6040.6 6040.9 6045.0 6070.0 5653.5 5766.5 5807.7 5809.8 5820.8 5140.0 5196.2 5198.7 5202.4 5224.8 6342.9 6358.2 6376.2 6382.9 6383.6 5918.8 5967.7 6106.8 6114.5 6118.1 6218.0 6225.5 6256.7 6319.7 6334.9 5955.0 6001.3 6018.4 6037.9 6071.2 5961.2 5991.8 6062.7 6103.7 6125.9 5839.4 5849.4 5879.5 5885.1 5988.7 5896.9 5947.4 5962.7 5964.6 5975.2 5874.6 5905.9 5911.2 5913.8 5930.4 5724.9 5904.6 5907.9 5958.9 6027.8 5829.7 5847.1 5849.4 5850.5 5851.8 13:26:47 INFO - PROCESS | 5669 | 13:26:47 INFO - PROCESS | 5669 | [#1] ext.html Cycles:180 Average:65088.68 Median:42604.75 stddev:124147.70 (291.4%) stddev-sans-first:124401.45 13:26:47 INFO - PROCESS | 5669 | Values: 569.3 582.9 589.6 607.2 636.0 46606.3 49090.8 49253.0 53770.5 53910.0 50897.5 51419.0 51449.0 51526.7 51640.2 9330.1 9525.4 9532.0 9553.2 10727.1 10200.6 10588.3 10593.4 10642.7 10671.8 10495.2 10625.6 10639.5 10719.6 10759.3 10577.2 10624.8 10625.6 10641.6 10651.6 10917.2 10975.7 11001.5 11003.0 11030.6 42834.4 43014.0 43094.8 43516.6 43608.8 4442.5 4466.1 4476.3 4481.6 4589.9 29537.9 31836.0 32261.2 32515.0 32813.3 4635.5 4686.0 4690.5 4700.9 4716.3 395869.0 399049.0 400490.0 400945.0 404147.0 62659.4 62810.7 63079.0 63375.7 63409.0 65852.3 66126.7 66376.7 66462.3 66651.0 19145.8 19637.0 19643.9 19663.2 19674.0 13692.2 14014.0 15151.4 15343.8 15387.2 20130.1 20138.2 20580.8 20660.7 20663.2 7415.8 7467.6 7586.7 7622.8 7702.0 991.0 1013.1 1024.2 1026.5 1030.6 33850.3 33858.5 33883.4 34046.5 34153.8 1118.3 1187.4 1216.3 1225.3 1229.3 17458.9 17551.2 17654.0 17677.9 17836.8 521876.0 523225.0 524467.0 525304.0 525686.0 71951.0 72207.6 72344.0 72601.3 72711.3 1552.3 1569.1 1577.5 1588.6 1595.3 30941.2 32617.2 32950.0 33208.7 33269.7 56840.7 57722.1 57889.0 58037.0 58378.7 472947.0 474913.0 475535.0 480791.0 481770.0 27834.0 28419.0 28888.1 28979.1 29925.9 47453.5 47929.0 47974.8 48138.5 49165.8 41904.4 42676.4 42998.0 43037.4 43252.4 42220.0 42312.0 42422.6 42776.1 42854.8 42513.4 42533.1 48689.8 49007.0 49416.8 42693.4 47630.0 48234.3 48757.8 48987.8 36440.7 36657.3 36939.6 37183.3 37275.4 13:26:47 INFO - PROCESS | 5669 | 13:26:47 INFO - PROCESS | 5669 | [#2] jquery.html Cycles:180 Average:38295.38 Median:22871.54 stddev:124848.21 (545.9%) stddev-sans-first:125166.06 13:26:47 INFO - PROCESS | 5669 | Values: 432.4 439.6 439.7 441.4 446.3 21830.3 21882.5 22308.4 22467.2 22588.2 22356.1 22387.0 22402.8 22721.2 23462.9 6039.8 6061.3 6259.3 6261.6 6285.4 6052.5 6125.5 6196.3 6202.5 6216.3 6023.5 6149.7 6189.0 6208.6 6227.5 6270.0 6324.0 6338.0 6340.8 6392.1 6078.8 6252.8 6278.1 6288.8 6300.1 14683.7 14702.9 14887.1 15640.4 15755.4 3155.8 3206.3 3229.6 3275.9 3311.1 11291.4 11448.9 11535.4 11545.8 11670.1 1992.9 2042.4 2048.6 2067.8 2107.5 88717.1 95752.6 97641.0 101453.0 101946.5 12157.2 12207.8 12453.8 12528.7 13090.4 18273.2 18297.6 18298.2 18319.0 18331.9 8688.7 8795.2 8864.5 8866.9 9038.7 8023.3 8028.0 8158.3 8323.2 8339.9 5342.5 5389.0 5400.3 5425.0 5526.9 2166.0 2180.9 2189.0 2199.7 2251.4 950.9 972.6 975.8 978.7 995.5 20576.4 22241.0 22679.1 23021.9 23669.5 1087.5 1088.6 1090.5 1104.6 1105.6 11161.3 11660.4 11879.0 11939.3 11948.1 711797.0 711804.0 751913.0 792592.0 829823.0 89024.0 91796.0 110389.0 116660.0 117534.4 1121.6 1145.2 1172.7 1172.9 1178.6 19500.6 19551.3 19712.1 19726.0 19794.3 46514.3 47206.8 47290.8 47371.8 48429.0 67327.7 67366.3 67628.3 67965.7 68071.7 7922.6 8650.2 8679.9 8900.6 9604.1 10769.9 13953.4 14307.3 14472.3 14564.1 12384.0 12583.1 12587.7 12618.0 12858.9 12322.2 12408.5 12408.6 12511.8 13022.9 9625.1 12775.8 12800.5 12831.1 13192.3 8611.1 8757.0 8777.6 8839.7 8957.2 12157.9 12505.4 12565.9 12618.9 12684.8 13:26:47 INFO - PROCESS | 5669 | 13:26:47 INFO - PROCESS | 5669 | [#3] mootools.html Cycles:180 Average:5853.62 Median:5345.68 stddev:3121.74 (58.4%) stddev-sans-first:3113.33 13:26:47 INFO - PROCESS | 5669 | Values: 1497.2 1516.7 1526.2 1541.8 1552.8 8463.5 8541.1 8961.2 9034.1 9056.3 8929.2 9028.6 9030.3 9058.3 9085.0 2434.4 2466.6 2468.8 2475.5 2480.6 2420.5 2448.9 2457.8 2538.3 2538.8 2427.1 2487.9 2490.0 2491.9 2514.9 2371.9 2394.8 2404.9 2411.8 2421.8 2428.3 2433.8 2434.6 2442.7 2457.3 8841.1 8961.6 8970.1 8988.8 9016.6 5474.5 5611.2 5615.4 5626.3 5636.6 3470.8 3646.2 3651.7 3656.4 3680.7 1436.2 1465.5 1530.1 2210.5 2231.4 11878.5 11918.9 11943.3 11951.8 11967.2 4575.4 4660.2 4714.6 4730.5 4863.9 9732.4 9832.6 9848.2 9864.7 9865.9 5570.1 5585.8 5605.7 5610.6 5628.1 5017.6 5161.6 5214.5 5268.8 5307.8 3934.3 4003.8 4026.9 4064.9 4093.0 1268.2 1273.2 1274.3 1278.8 1282.9 1018.4 1019.6 1029.5 1031.8 1048.8 5838.2 6116.3 6121.3 6229.5 6458.2 1075.7 1106.6 1108.0 1117.2 1140.2 4239.4 4313.2 4391.3 4401.8 4457.0 10164.6 10406.6 10420.7 10456.9 10548.9 10132.4 10261.7 10269.0 10394.3 10403.4 7715.8 8113.4 8211.1 8359.0 8365.6 5980.4 6186.9 6342.6 6360.7 6457.1 9537.4 9696.9 9718.0 9722.7 9790.3 9785.3 9797.4 9835.8 9880.2 9912.8 7028.9 7403.9 7787.5 7829.0 7908.1 8482.7 8518.0 8580.2 8594.6 8614.1 7642.5 7650.3 7713.9 7734.2 7981.7 7538.8 7579.2 7606.9 7640.4 7765.8 6643.3 6789.9 6848.8 6853.2 6890.1 5336.4 5355.0 5414.5 5427.2 5445.7 5500.4 5533.6 5539.3 5637.4 5639.5 13:26:47 INFO - PROCESS | 5669 | 13:26:47 INFO - PROCESS | 5669 | [#4] prototype.html Cycles:180 Average:4832.56 Median:5536.90 stddev:1404.97 (25.4%) stddev-sans-first:1369.11 13:26:47 INFO - PROCESS | 5669 | Values: 409.0 411.0 425.1 427.9 428.8 5432.0 5553.9 5566.0 5598.6 5599.8 5437.4 5464.6 5474.7 5488.1 5511.8 4084.9 4267.1 4267.9 4269.5 4289.0 4236.8 4261.8 4283.3 4284.0 4301.0 4228.8 4237.4 4241.8 4252.2 4285.3 4198.8 4208.2 4260.7 4275.4 4291.7 3770.6 3780.1 3780.3 3782.4 3784.3 5422.4 5428.5 5437.5 5441.1 5447.9 4779.9 4913.0 4992.7 5002.0 5031.9 5761.4 5770.2 5772.0 5776.3 5776.7 4160.2 4160.5 4165.6 4169.6 4193.1 5837.3 5971.8 6032.9 6044.6 6049.9 4243.0 4250.3 4265.8 4269.3 4269.3 4330.2 4339.2 4347.9 4363.8 4374.9 4755.9 4902.9 4985.5 4993.0 4994.2 5794.9 5802.6 5819.2 5827.7 5832.4 1425.7 1432.7 1441.3 1444.4 1446.8 953.9 975.9 989.7 991.8 1016.4 5458.9 5473.3 5475.6 5527.9 5548.6 5678.7 5715.6 5762.4 5848.7 5850.3 5359.4 5397.5 5443.7 5520.8 5620.0 3004.6 3014.3 3024.6 3053.5 3071.9 5728.8 5956.9 5981.1 5986.9 6016.2 5778.3 5843.8 5849.1 5867.6 5900.3 5934.5 5982.9 5992.8 5997.6 6000.9 5587.3 5603.8 5692.0 5720.4 5805.5 5663.3 5673.6 5696.4 5706.4 5737.0 5938.5 5993.1 6020.4 6051.6 6143.2 4227.7 4238.1 4241.7 4243.2 4245.5 5691.6 5809.5 5923.5 5930.9 5937.4 5711.2 5718.9 5719.7 5723.2 5724.2 5670.3 5733.5 5748.7 5777.4 5816.6 5545.9 5723.8 5740.9 5744.0 5755.7 5794.0 5825.4 5827.5 5835.3 5836.2 5501.2 5570.3 5664.3 5687.9 5703.0 13:26:47 INFO - PROCESS | 5669 | 13:26:47 INFO - PROCESS | 5669 | [#5] yui.html Cycles:180 Average:18894.54 Median:4707.52 stddev:23728.37 (504.1%) stddev-sans-first:23756.10 13:26:47 INFO - PROCESS | 5669 | Values: 817.0 832.9 863.4 901.9 920.5 15215.0 16266.3 16507.6 18098.0 18405.6 14776.5 14894.6 14969.0 16736.8 16895.5 815.3 834.9 835.6 836.7 837.7 803.5 829.9 835.6 837.1 837.7 867.1 867.4 868.4 868.9 870.5 856.2 859.8 862.5 864.2 864.6 627.6 630.6 630.9 633.0 634.5 17624.0 18042.8 18065.7 18092.0 18161.5 14292.4 15443.2 16168.2 16356.5 16468.5 14112.7 14588.7 14670.4 14713.8 14757.2 4733.9 4824.3 4837.6 4851.8 4988.9 83344.0 83406.2 83842.7 84421.0 84664.6 12388.9 12542.7 12675.6 12769.9 12789.7 22682.4 22768.0 23020.4 23107.9 23197.4 8852.0 8923.8 9089.5 9249.7 9590.7 4681.2 4768.2 4822.1 4859.5 4930.7 4045.3 4146.9 4153.2 4155.7 4164.5 635.0 720.6 721.2 726.1 729.5 753.3 786.1 792.9 800.7 802.7 11235.7 11313.8 11606.8 11684.9 11864.2 849.7 856.3 863.8 866.6 872.5 5035.9 5087.6 5190.5 5200.4 5244.2 84573.6 85253.6 85626.1 86854.6 88534.0 75433.6 75881.0 76581.0 77747.6 78666.0 51453.0 53477.7 60780.4 69527.3 69802.7 11059.5 11467.3 11518.4 11559.4 11682.1 40671.0 41424.4 42386.6 42633.0 42775.0 51391.7 55602.7 57914.7 59427.0 59510.1 14282.9 14408.9 14488.1 14533.9 14794.9 16056.8 16103.6 16334.4 16373.3 16425.3 13664.9 13800.1 13886.1 14101.6 14435.7 14525.3 14713.6 14744.5 14799.7 14939.6 13722.7 13782.4 13893.4 14280.9 14464.8 12051.9 12422.3 12436.6 12473.3 12681.0 11987.3 12342.8 13105.1 13156.3 13287.4 13:26:47 INFO - PROCESS | 5669 | -------- Summary: end -------- 13:26:47 INFO - PROCESS | 5669 | 13:26:48 INFO - TEST-INFO | 5669: exit 0 13:26:48 INFO - TEST-OK | dromaeo_css | took 1112974ms 13:26:48 INFO - TEST-START | kraken 13:26:48 INFO - operating with platform_type : linux_ 13:26:48 INFO - Initialising browser for kraken test... 13:26:48 INFO - TEST-INFO | started process 6040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuwyDdr/profile http://localhost:45933/getInfo.html) 13:26:53 INFO - PROCESS | 6040 | __metrics Screen width/height:1600/1200 13:26:53 INFO - PROCESS | 6040 | colorDepth:24 13:26:53 INFO - PROCESS | 6040 | Browser inner width/height: 1024/697 13:26:53 INFO - PROCESS | 6040 | __metrics 13:26:53 INFO - PROCESS | 6040 | 1486675613749 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpuwyDdr/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpuwyDdr/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpuwyDdr/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpuwyDdr/profile/extensions/talos-powers@TalosPowersService.js:55:9 13:26:53 ERROR - PROCESS | 6040 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 13:26:54 INFO - TEST-INFO | 6040: exit 0 13:26:54 INFO - Browser initialized. 13:26:54 INFO - Running cycle 1/1 for kraken test... 13:26:54 INFO - TEST-INFO | started process 6170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuwyDdr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:06 INFO - PROCESS | 6170 | RSS: Main: 144719872 13:27:06 INFO - PROCESS | 6170 | 13:27:09 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45933/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:10 INFO - PROCESS | 6170 | RSS: Main: 151486464 13:27:10 INFO - PROCESS | 6170 | 13:27:12 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45933/tests/kraken/driver.html?testName=audio-dft) 13:27:13 INFO - PROCESS | 6170 | RSS: Main: 150618112 13:27:13 INFO - PROCESS | 6170 | 13:27:16 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45933/tests/kraken/driver.html?testName=audio-fft) 13:27:16 INFO - PROCESS | 6170 | RSS: Main: 151085056 13:27:16 INFO - PROCESS | 6170 | 13:27:18 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45933/tests/kraken/driver.html?testName=audio-oscillator) 13:27:19 INFO - PROCESS | 6170 | RSS: Main: 150589440 13:27:19 INFO - PROCESS | 6170 | 13:27:21 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:27:22 INFO - PROCESS | 6170 | RSS: Main: 150265856 13:27:22 INFO - PROCESS | 6170 | 13:27:25 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45933/tests/kraken/driver.html?testName=imaging-darkroom) 13:27:25 INFO - PROCESS | 6170 | RSS: Main: 153137152 13:27:25 INFO - PROCESS | 6170 | 13:27:29 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45933/tests/kraken/driver.html?testName=imaging-desaturate) 13:27:29 INFO - PROCESS | 6170 | RSS: Main: 153755648 13:27:29 INFO - PROCESS | 6170 | 13:27:32 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45933/tests/kraken/driver.html?testName=json-parse-financial) 13:27:33 INFO - PROCESS | 6170 | RSS: Main: 153640960 13:27:33 INFO - PROCESS | 6170 | 13:27:34 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:27:35 INFO - PROCESS | 6170 | RSS: Main: 152371200 13:27:35 INFO - PROCESS | 6170 | 13:27:37 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45933/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:27:37 INFO - PROCESS | 6170 | RSS: Main: 152600576 13:27:37 INFO - PROCESS | 6170 | 13:27:39 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:27:40 INFO - PROCESS | 6170 | RSS: Main: 153010176 13:27:40 INFO - PROCESS | 6170 | 13:27:42 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:27:43 INFO - PROCESS | 6170 | RSS: Main: 153079808 13:27:43 INFO - PROCESS | 6170 | 13:27:46 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:27:47 INFO - PROCESS | 6170 | RSS: Main: 153321472 13:27:47 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:45933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45933/tests/kraken/driver.html?testName=ai-astar) 13:27:48 INFO - PROCESS | 6170 | RSS: Main: 154968064 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | __start_tp_report 13:27:48 INFO - PROCESS | 6170 | _x_x_mozilla_page_load 13:27:48 INFO - PROCESS | 6170 | _x_x_mozilla_page_load_details 13:27:48 INFO - PROCESS | 6170 | |i|pagename|runs| 13:27:48 INFO - PROCESS | 6170 | |0;ai-astar;103;113;115;113;114;113;114;113;113;113 13:27:48 INFO - PROCESS | 6170 | |1;audio-beat-detection;146;119;117;159;124;122;120;117;142;119 13:27:48 INFO - PROCESS | 6170 | |2;audio-dft;161;162;163;161;160;162;163;161;161;166 13:27:48 INFO - PROCESS | 6170 | |3;audio-fft;75;75;75;102;77;77;76;76;104;88 13:27:48 INFO - PROCESS | 6170 | |4;audio-oscillator;82;82;99;82;83;83;102;82;83;106 13:27:48 INFO - PROCESS | 6170 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;118;118;118 13:27:48 INFO - PROCESS | 6170 | |6;imaging-darkroom;147;147;147;147;147;147;146;147;148;147 13:27:48 INFO - PROCESS | 6170 | |7;imaging-desaturate;97;96;97;96;99;97;97;97;96;96 13:27:48 INFO - PROCESS | 6170 | |8;json-parse-financial;57;55;56;56;55;55;56;55;54;60 13:27:48 INFO - PROCESS | 6170 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;65;67;64 13:27:48 INFO - PROCESS | 6170 | |10;stanford-crypto-aes;76;78;85;76;77;82;76;84;78;77 13:27:48 INFO - PROCESS | 6170 | |11;stanford-crypto-ccm;123;132;126;126;135;125;136;119;167;124 13:27:48 INFO - PROCESS | 6170 | |12;stanford-crypto-pbkdf2;160;159;164;157;163;155;157;158;157;158 13:27:48 INFO - PROCESS | 6170 | |13;stanford-crypto-sha256-iterative;61;63;62;62;62;62;64;63;59;61 13:27:48 INFO - PROCESS | 6170 | __end_tp_report 13:27:48 INFO - PROCESS | 6170 | __start_cc_report 13:27:48 INFO - PROCESS | 6170 | _x_x_mozilla_cycle_collect,703 13:27:48 INFO - PROCESS | 6170 | __end_cc_report 13:27:48 INFO - PROCESS | 6170 | __startTimestamp1486675668912__endTimestamp 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | ------- Summary: start ------- 13:27:48 INFO - PROCESS | 6170 | Number of tests: 14 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:3.37 (3.0%) stddev-sans-first:0.73 13:27:48 INFO - PROCESS | 6170 | Values: 103.0 113.0 115.0 113.0 114.0 113.0 114.0 113.0 113.0 113.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:123.00 stddev:14.90 (12.1%) stddev-sans-first:14.40 13:27:48 INFO - PROCESS | 6170 | Values: 146.0 119.0 117.0 159.0 124.0 122.0 120.0 117.0 142.0 119.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.70 (1.0%) stddev-sans-first:1.76 13:27:48 INFO - PROCESS | 6170 | Values: 161.0 162.0 163.0 161.0 160.0 162.0 163.0 161.0 161.0 166.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:11.48 (15.1%) stddev-sans-first:11.85 13:27:48 INFO - PROCESS | 6170 | Values: 75.0 75.0 75.0 102.0 77.0 77.0 76.0 76.0 104.0 88.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:82.50 stddev:9.77 (11.8%) stddev-sans-first:10.08 13:27:48 INFO - PROCESS | 6170 | Values: 82.0 82.0 99.0 82.0 83.0 83.0 102.0 82.0 83.0 106.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:27:48 INFO - PROCESS | 6170 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 13:27:48 INFO - PROCESS | 6170 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 148.0 147.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.92 (0.9%) stddev-sans-first:0.97 13:27:48 INFO - PROCESS | 6170 | Values: 97.0 96.0 97.0 96.0 99.0 97.0 97.0 97.0 96.0 96.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.66 (3.0%) stddev-sans-first:1.72 13:27:48 INFO - PROCESS | 6170 | Values: 57.0 55.0 56.0 56.0 55.0 55.0 56.0 55.0 54.0 60.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 13:27:48 INFO - PROCESS | 6170 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 67.0 64.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:78.00 stddev:3.45 (4.4%) stddev-sans-first:3.49 13:27:48 INFO - PROCESS | 6170 | Values: 76.0 78.0 85.0 76.0 77.0 82.0 76.0 84.0 78.0 77.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:129.00 stddev:13.66 (10.6%) stddev-sans-first:14.16 13:27:48 INFO - PROCESS | 6170 | Values: 123.0 132.0 126.0 126.0 135.0 125.0 136.0 119.0 167.0 124.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:158.50 stddev:2.82 (1.8%) stddev-sans-first:2.96 13:27:48 INFO - PROCESS | 6170 | Values: 160.0 159.0 164.0 157.0 163.0 155.0 157.0 158.0 157.0 158.0 13:27:48 INFO - PROCESS | 6170 | 13:27:48 INFO - PROCESS | 6170 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:1.41 13:27:48 INFO - PROCESS | 6170 | Values: 61.0 63.0 62.0 62.0 62.0 62.0 64.0 63.0 59.0 61.0 13:27:48 INFO - PROCESS | 6170 | -------- Summary: end -------- 13:27:48 INFO - PROCESS | 6170 | 13:27:49 INFO - TEST-INFO | 6170: exit 0 13:27:49 INFO - TEST-OK | kraken | took 61232ms 13:27:49 INFO - SUITE-END | took 1174s 13:27:50 INFO - Completed test suite (00:19:34) 13:27:50 INFO - javascript benchmark 13:27:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7721.791786410891, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.4748040313552, 3288.276579152586, 3303.405387030335, 3306.6197387300467, 3314.0057982605213, 5578.748956296966, 5629.943700562993, 5653.434656534345, 5654.378018417976, 5655.23654306669, 5583.804566840151, 5695.45893140151, 5717.685527295997, 5731.512821410185, 5766.481016708495, 5060.69635821851, 5075.873103172414, 5114.360704911886, 5114.462981386957, 5142.7428628568605, 5123.769430375623, 5128.974355128238, 5134.460881607433, 5143.3570803649545, 5157.71632560209, 5034.798608055673, 5039.974800125994, 5145.794168233266, 5159.406668233145, 5185.299984502081, 5011.473795251482, 5012.147934851084, 5050.696958182484, 5119.692818430887, 5122.282880396748, 4996.575291100261, 5055.898882022376, 5059.114654935372, 5063.01271252106, 5066.986602679479, 5554.222408862763, 5570.275864137677, 5644.858878528029, 5646.576506761969, 5648.63283886546, 5913.852153696149, 5935.258092738408, 5938.406159384027, 5949.553783466257, 6026.2165918430765, 6052.152698622196, 6055.364186760415, 6057.121717351003, 6075.483583895374, 6078.544109191828, 5614.550835933115, 5622.353429355595, 5624.21261023457, 5627.634203776783, 5656.264685590847, 6029.306629737549, 6030.849228769316, 6064.120702498113, 6093.6039157454625, 6107.96946015276, 5878.0, 5968.671723055187, 5982.641041537521, 5998.940010599838, 6001.909971350433, 6028.5478589106, 6068.878622427526, 6080.878382432326, 6089.086637004396, 6103.023516237381, 5808.273965754281, 5835.183074369592, 5927.673977931255, 6028.698565071729, 6047.0, 5971.0, 6025.216721826135, 6054.212952316171, 6086.817395478142, 6100.938990610126, 4616.6537509686905, 4636.744979026186, 4640.0, 4656.8602941911795, 4663.650226233046, 4020.2361551305157, 4038.2327357801923, 4106.876793696194, 4110.095778928631, 4156.189543039139, 5775.913361299584, 5777.8555536111935, 5798.246227990334, 5837.211976383219, 5890.9410905891245, 6004.279486461653, 6040.577159598874, 6040.879182416327, 6045.0, 6069.969650151721, 5653.530082178663, 5766.509846662997, 5807.738651760681, 5809.767609295665, 5820.82537523875, 5140.0, 5196.168613021899, 5198.740062996911, 5202.401723801736, 5224.764885580158, 6342.936570634327, 6358.1734374531015, 6376.171097757355, 6382.904256436157, 6383.616982981036, 5918.822435326947, 5967.671778052075, 6106.755729770937, 6114.48026917717, 6118.143459915705, 6217.96891015542, 6225.470834979077, 6256.655883926428, 6319.715612797527, 6334.904976425265, 5954.970225148846, 6001.309849367379, 6018.3981601841215, 6037.939620603738, 6071.150038994456, 5961.195238642727, 5991.7902873399225, 6062.696865156637, 6103.725332359965, 6125.908111378422, 5839.386864379179, 5849.356570777296, 5879.529637628894, 5885.08781138907, 5988.700564971647, 5896.882062358814, 5947.405259474018, 5962.672053037125, 5964.642121472725, 5975.223220981245, 5874.618149820248, 5905.852353691021, 5911.201987731602, 5913.793017244376, 5930.436608522184, 5724.856878578069, 5904.586678932434, 5907.852303692442, 5958.940410595838, 6027.78902738402, 5829.737661805314, 5847.1229315603, 5849.3858144894175, 5850.53195744348, 5851.765929362778], "value": 5569.386647043564, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.2514343638115, 582.8542864283929, 589.6255877517776, 607.1590846677351, 635.9841003974902, 46606.3009054864, 49090.754546227305, 49252.999999999956, 53770.46229537713, 53910.0, 50897.49102508974, 51419.0, 51449.0, 51526.74236628812, 51640.225396619084, 9330.113639204264, 9525.380850244746, 9532.0, 9553.235741140727, 10727.08819750322, 10200.642977495789, 10588.258821882433, 10593.417362045084, 10642.733931651694, 10671.83992240117, 10495.212859035564, 10625.574977000912, 10639.52122154501, 10719.571217151344, 10759.300645458059, 10577.153827693804, 10624.831268560452, 10625.574977000912, 10641.574337026586, 10651.573937042547, 10917.23579349446, 10975.670729878117, 11001.504932278067, 11003.0, 11030.613928512545, 42834.35748463775, 43014.0, 43094.78452607717, 43516.56483435157, 43608.78195609002, 4442.5113237544165, 4466.1067786442845, 4476.261416866213, 4481.551844815525, 4589.944312808039, 29537.852310738523, 31836.0, 32261.193470163198, 32515.0, 32813.343733125206, 4635.536446355338, 4685.976570117162, 4690.4605970313505, 4700.882477938045, 4716.292556116576, 395869.0, 399049.0, 400490.0, 400945.0, 404147.0, 62659.37340626626, 62810.68594657089, 63079.0, 63375.683121584094, 63409.0, 65852.34147658462, 66126.66936665382, 66376.6681166591, 66462.33537664561, 66651.0, 19145.80854191468, 19637.0, 19643.90178049129, 19663.213471461266, 19674.0, 13692.246926418944, 14014.0, 15151.393944242327, 15343.769843452357, 15387.153706546247, 20130.094145763476, 20138.19447222095, 20580.794192058187, 20660.690089648666, 20663.17347306121, 7415.8146046349275, 7467.551946883204, 7586.696532138763, 7622.771316860392, 7701.961490192513, 990.9900900990898, 1013.1084645511902, 1024.1704219582161, 1026.4970164619433, 1030.6147343055252, 33850.322993539994, 33858.49212261818, 33883.39822302047, 34046.48930266048, 34153.829230853684, 1118.3178261260625, 1187.352892673495, 1216.3310179401294, 1225.2954551133134, 1229.3115855120982, 17458.912705436393, 17551.210195541233, 17654.0, 17677.911610441864, 17836.821631783518, 521876.0, 523225.0, 524467.0, 525304.0, 525686.0, 71951.0, 72207.63896180486, 72344.0, 72601.2739872605, 72711.27288727151, 1552.270432896537, 1569.1369746639302, 1577.4952015355207, 1588.563145135074, 1595.3060418717894, 30941.226469338446, 32617.18457038593, 32950.0, 33208.667913320554, 33269.667303326656, 56840.71579642075, 57722.134167986675, 57889.0, 58037.0, 58378.7081064592, 472947.0, 474913.0, 475535.0, 480791.0, 481770.0, 27834.0, 28419.0, 28888.133355999355, 28979.130626081253, 29925.850370748878, 47453.52546474629, 47929.0, 47974.760126199144, 48138.5186148134, 49165.75417122892, 41904.371434429115, 42676.359854601586, 42998.0, 43037.3544396828, 43252.35121473118, 42220.0, 42312.0, 42422.575774241865, 42776.06680609491, 42854.78572607117, 42513.36229956615, 42533.1493370137, 48689.75655121844, 49007.0, 49416.752916235186, 42693.35959960665, 47630.0, 48234.27648585344, 48757.756211218715, 48987.75506122447, 36440.72008668112, 36657.26685466222, 36939.63060369362, 37183.256334873695, 37275.44086838645], "value": 22290.768500506838, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.37737657772783, 439.6416920210029, 439.70320033977055, 441.3842689448219, 446.29931008316936, 21830.345089647315, 21882.452938676543, 22308.442288942784, 22467.21364752234, 22588.20941267056, 22356.10575576979, 22387.0, 22402.775972240273, 22721.20475783348, 23462.882685586548, 6039.75840966363, 6061.333253342129, 6259.311475737688, 6261.592996455239, 6285.371462853724, 6052.485538729214, 6125.509959203276, 6196.287426945892, 6202.534809889254, 6216.285127210361, 6023.488003519706, 6149.6617686027475, 6189.040698691688, 6208.596441231328, 6227.532935029891, 6269.968650156766, 6324.0, 6338.0, 6340.84147896304, 6392.073149393358, 6078.787242446538, 6252.781152659681, 6278.058291256302, 6288.811335659938, 6300.086487459339, 14683.706325873423, 14702.926485367612, 14887.10677359351, 15640.374385024585, 15755.369785208577, 3155.8106513609027, 3206.278587317858, 3229.5801545798895, 3275.901722948315, 3311.106001379638, 11291.378974156418, 11448.912353326421, 11535.423228838525, 11545.826812597817, 11670.066394688405, 1992.860499765017, 2042.3974927396453, 2048.6312463756517, 2067.7518697756364, 2107.504736386948, 88717.11282887218, 95752.56371154368, 97641.0, 101453.0, 101946.49026754819, 12157.209781364183, 12207.816882746765, 12453.75092498145, 12528.749425011449, 13090.410931508104, 18273.17770700322, 18297.634047319247, 18298.17658205384, 18319.0, 18331.908340458478, 8688.652453901774, 8795.208431241092, 8864.468131911977, 8866.911330886738, 9038.728838134866, 8023.277904988579, 8027.959860200662, 8158.306543943712, 8323.209295117076, 8339.916600833914, 5342.465753424704, 5389.0, 5400.270963419966, 5424.972875135678, 5526.944730552724, 2166.018093444512, 2180.9018594162985, 2188.9562208755738, 2199.747029091643, 2251.4371407148215, 950.8716323296405, 972.6304004478253, 975.7902051058915, 978.6525783346951, 995.5221493683073, 20576.38270851877, 22240.999155038062, 22679.092836286694, 23021.88489057544, 23669.526609467714, 1087.478010554938, 1088.5754555723274, 1090.547422819537, 1104.5692180049787, 1105.618561596248, 11161.330320180816, 11660.358680272497, 11879.0, 11939.283642981449, 11948.103892208119, 711797.0, 711804.0, 751913.0, 792592.0, 829823.0, 89024.0, 91796.0, 110389.0, 116660.0, 117534.41232793781, 1121.556984990924, 1145.1525870855507, 1172.6833754886304, 1172.8533933258343, 1178.6287319494331, 19500.609987799882, 19551.315703950295, 19712.112954916778, 19726.0, 19794.307199247956, 46514.30228546507, 47206.76396617995, 47290.76354618205, 47371.76314118407, 48429.0, 67327.66336168288, 67366.326336736, 67628.3237167622, 67965.66017169882, 68071.65964170148, 7922.643481043252, 8650.178233067849, 8679.869801953102, 8900.599473023858, 9604.135627793532, 10769.892301076889, 13953.3720982554, 14307.284635767961, 14472.276386180438, 14564.126152430888, 12384.0, 12583.05627077991, 12587.74824503523, 12618.0, 12858.871411286142, 12322.199057061622, 12408.503659853504, 12408.62774116778, 12511.812322814983, 13022.869771302167, 9625.085616866387, 12775.80836287475, 12800.487980480677, 12831.10182287231, 13192.274424906722, 8611.052784193858, 8757.0, 8777.648894044167, 8839.734807955772, 8957.19385255304, 12157.878421216028, 12505.43725532335, 12565.93717031409, 12618.936905315415, 12684.809727854274], "value": 10177.988054357733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.2438918346234, 1516.651170230847, 1526.2139997901083, 1541.7764424158497, 1552.8136623605162, 8463.492190468569, 8541.145885411455, 8961.193492585666, 9034.141756533136, 9056.320775941806, 8929.1517305856, 9028.593713282902, 9030.277577793777, 9058.320625953063, 9085.0, 2434.4400787818813, 2466.6053431450973, 2468.814838887082, 2475.4801491686767, 2480.5659009673327, 2420.5279970405777, 2448.9387765305833, 2457.803375729937, 2538.3019669590826, 2538.834975726581, 2427.1383658801137, 2487.8631675257852, 2490.0413340863715, 2491.9252422427357, 2514.9119780807673, 2371.9288421347387, 2394.7964423024064, 2404.939876503093, 2411.7588241175918, 2421.8183636227354, 2428.3200703802786, 2433.7687919647606, 2434.6348047792794, 2442.7435119312395, 2457.2751038443525, 8841.115888411172, 8961.59672814725, 8970.102989701043, 8988.820223595558, 9016.639334426614, 5474.534664553478, 5611.2144299798065, 5615.438456154393, 5626.268585083953, 5636.633618814764, 3470.774399664014, 3646.197836475971, 3651.653092956165, 3656.378415669316, 3680.705543556509, 1436.1670231265946, 1465.4870795221693, 1530.0590137065735, 2210.546837898227, 2231.4421394651336, 11878.465469053914, 11918.940405298004, 11943.283402995849, 11951.820722689166, 11967.222130561486, 4575.382323386367, 4660.231061874821, 4714.5992590630185, 4730.5032971538185, 4863.8540843774745, 9732.41605503672, 9832.606695732233, 9848.162906152915, 9864.704058878246, 9865.901340986498, 5570.136628822539, 5585.832425027255, 5605.691686957175, 5610.635308704921, 5628.127640215773, 5017.598592112622, 5161.612879034087, 5214.530692237641, 5268.78924843002, 5307.840764777063, 3934.272159650474, 4003.799810009546, 4026.939595906064, 4064.8577299794365, 4093.0, 1268.1630124118037, 1273.2042473454092, 1274.2800317820402, 1278.7634287656813, 1282.8524719657173, 1018.3787889387468, 1019.6329321444274, 1029.4801125431609, 1031.8091153136693, 1048.753542917429, 5838.153467747238, 6116.327204007555, 6121.265448146251, 6229.470495007975, 6458.22501299847, 1075.6504136155781, 1106.5573770491708, 1107.95568177272, 1117.2124600638913, 1140.1562843495753, 4239.427677263591, 4313.158934007838, 4391.297392417198, 4401.823927042947, 4457.0, 10164.644237451801, 10406.58373665045, 10420.68737937863, 10456.947715261374, 10548.894511054945, 10132.392056476636, 10261.74345641365, 10268.973102689672, 10394.272400932014, 10403.375797452025, 7715.845683086307, 8113.350931925432, 8211.137830527709, 8359.038710548242, 8365.623546940402, 5980.401959803985, 6186.876262474815, 6342.619442833445, 6360.681965901779, 6457.096006558992, 9537.380070295409, 9696.9030309696, 9717.951410242904, 9722.659706910224, 9790.314677972474, 9785.266105042008, 9797.363171394121, 9835.803283934425, 9880.209583233467, 9912.752181195528, 7028.929710702828, 7403.852402877563, 7787.532748035136, 7828.960855195687, 7908.130105688485, 8482.660693572188, 8517.957410213157, 8580.227779499624, 8594.570271486276, 8614.138586141336, 7642.5032372895585, 7650.349720273839, 7713.922860771545, 7734.2265773422205, 7981.680732770624, 7538.833689850386, 7579.242075792376, 7606.885896711443, 7640.426967977535, 7765.7670269892, 6643.269240383651, 6789.89815152783, 6848.828779280558, 6853.246142924374, 6890.10428644273, 5336.386315573759, 5354.973225134006, 5414.539764119936, 5427.185922111715, 5445.673259604437, 5500.4499550044675, 5533.612647114664, 5539.307586551681, 5637.351704554028, 5639.520640745419], "value": 4809.871822548079, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.977506237157, 410.9971669127329, 425.08606496033525, 427.9416008996724, 428.7813215260218, 5431.972840135803, 5553.861153471155, 5566.0, 5598.552115830739, 5599.776008959642, 5437.429069947658, 5464.562834973202, 5474.698891560963, 5488.1493368527845, 5511.807086751955, 4084.8774536763945, 4267.125239325938, 4267.935980960288, 4269.509006464265, 4288.957110428887, 4236.766977816219, 4261.803647264552, 4283.271843786564, 4284.0, 4300.967767735737, 4228.809703563332, 4237.364395340708, 4241.766702831343, 4252.213340531996, 4285.314349704048, 4198.8320467181275, 4208.179405016023, 4260.68044896634, 4275.358696195564, 4291.678124140686, 3770.622937706235, 3780.111673756665, 3780.319542482352, 3782.3901507959695, 3784.280986612535, 5422.376426710939, 5428.511433970962, 5437.477506298243, 5441.095616534221, 5447.937652157831, 4779.904401911977, 4912.975435122838, 4992.650514463989, 5002.0, 5031.874203144951, 5761.366249712528, 5770.163326317703, 5771.971140144273, 5776.335721392052, 5776.682282474462, 4160.2303573838635, 4160.479940007499, 4165.625093741578, 4169.56219596944, 4193.098483825992, 5837.299524057098, 5971.820845374646, 6032.909506357408, 6044.607100538451, 6049.879002419927, 4242.978785106055, 4250.256205164084, 4265.786710664516, 4269.295566231537, 4269.316909294498, 4330.155619654201, 4339.1972485090355, 4347.934780978288, 4363.825446982149, 4374.912501749947, 4755.9286610700865, 4902.90194196114, 4985.4823314226805, 4993.0, 4994.200927851526, 5794.88410231793, 5802.564807639359, 5819.156222347736, 5827.737751801094, 5832.445917637818, 1425.7148570285983, 1432.6776475293184, 1441.2865631512468, 1444.4005737618982, 1446.7991566999576, 953.947532885684, 975.9316847820585, 989.6684610655511, 991.791723738023, 1016.364772017489, 5458.945410545924, 5473.343198816167, 5475.644083134664, 5527.917081243784, 5548.5838562108, 5678.659280443187, 5715.571332150105, 5762.366139724627, 5848.736806843617, 5850.2905161345525, 5359.356877174764, 5397.460253974649, 5443.741041567132, 5520.751566179531, 5619.971900140473, 3004.6244219472565, 3014.291641464254, 3024.6370435547874, 3053.450378931769, 3071.9232019199253, 5728.799492017843, 5956.85107872298, 5981.0729336952845, 5986.904583395777, 6016.2479690038745, 5778.306603207642, 5843.766249350064, 5849.122631605208, 5867.647941123546, 5900.262467191601, 5934.525237980951, 5982.893164764446, 5992.760289588455, 5997.560585459459, 6000.879982400327, 5587.346010644911, 5603.831885043455, 5692.0, 5720.399358067343, 5805.535557155502, 5663.32040155184, 5673.574481913791, 5696.373398926197, 5706.400827913009, 5736.971315143398, 5938.524918006463, 5993.112169666541, 6020.397960203944, 6051.576389652682, 6143.201383820075, 4227.7040607157205, 4238.131183107517, 4241.681873859411, 4243.236217480883, 4245.490541135084, 5691.630044047124, 5809.5352371811, 5923.526117910471, 5930.911036334544, 5937.376575459514, 5711.173513745884, 5718.942810571841, 5719.685417301922, 5723.170140329546, 5724.227229324155, 5670.347909990239, 5733.483986441241, 5748.6838223898085, 5777.422257774357, 5816.563757718103, 5545.889082218252, 5723.828285151452, 5740.885182296247, 5744.0, 5755.740991655469, 5794.043982742969, 5825.3592104867585, 5827.533797296291, 5835.299764028344, 5836.241288632451, 5501.1938527797965, 5570.331560212639, 5664.348599910898, 5687.857803554944, 5703.0], "value": 4403.143816144345, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.9550674712889, 832.8875601793756, 863.3611127765452, 901.909809019098, 920.493728449353, 15214.999999999985, 16266.268017939192, 16507.587310317234, 18098.0, 18405.631887362244, 14776.482823101194, 14894.553163405088, 14969.0, 16736.83263167368, 16895.493135205932, 815.3355015662231, 834.9165083491663, 835.5613303015905, 836.6611522333465, 837.6984285657159, 803.5058439059965, 829.8879651247095, 835.5738573327586, 837.1126605797874, 837.7068026190846, 867.1025488619281, 867.375489647456, 868.431177578687, 868.8783570300163, 870.4907629037021, 856.1908995998783, 859.7549698335944, 862.4868203418956, 864.191980498233, 864.6411739128285, 627.595201095291, 630.552307861419, 630.867517821258, 633.0472638678759, 634.4638780230698, 17624.0, 18042.819571804244, 18065.72901406467, 18092.0, 18161.54596135094, 14292.428302867873, 15443.150626715526, 16168.191590420432, 16356.509304720877, 16468.505944821674, 14112.71774564503, 14588.708225835424, 14670.363986110091, 14713.779293310608, 14757.18835464049, 4733.857984260478, 4824.324594556765, 4837.637177211724, 4851.830185943475, 4988.925166122511, 83344.0, 83406.16593834106, 83842.74235886466, 84421.0, 84664.57667711684, 12388.938055309665, 12542.749145017231, 12675.556355527513, 12769.936150319374, 12789.744205115845, 22682.43293917665, 22768.0, 23020.4244893879, 23107.88446057759, 23197.42006449852, 8852.048020849297, 8923.798124875273, 9089.454632722058, 9249.722508324761, 9590.712278631652, 4681.180793361148, 4768.165571025057, 4822.132016237041, 4859.465458799529, 4930.728809915489, 4045.271851066836, 4146.854860079943, 4153.190127925026, 4155.688323375759, 4164.541900390955, 634.9809505714744, 720.6144712578745, 721.2210812322679, 726.12501935168, 729.5403895545878, 753.3408267765705, 786.103841620553, 792.9088154862264, 800.6557180412362, 802.6789284286332, 11235.719107022227, 11313.773724525463, 11606.825897611543, 11684.88315116855, 11864.169508134348, 849.6983570832389, 856.280724191682, 863.7970077031893, 866.5537248317122, 872.5375550958003, 5035.899282014339, 5087.592992560661, 5190.506901844319, 5200.401953775288, 5244.187150991603, 84573.57713211395, 85253.57373213218, 85626.14373856306, 86854.56572717223, 88534.0, 75433.62283188659, 75881.0, 76581.0, 77747.61126194333, 78666.0, 51453.0, 53477.73261133747, 60780.392196078355, 69527.3047269531, 69802.65098674575, 11059.502322395672, 11467.31196128235, 11518.424078795859, 11559.422028898689, 11682.065434765029, 40671.0, 41424.37863431991, 42386.57613423826, 42633.0, 42775.0, 51391.74304128456, 55602.721986389806, 57914.7104264476, 59427.0, 59510.10734838894, 14282.928585357007, 14408.927955360155, 14488.130712157305, 14533.92733036328, 14794.852051479347, 16056.759148612546, 16103.597410064842, 16334.428295010093, 16373.263203155648, 16425.260863260944, 13664.93167534156, 13800.102993305403, 13886.09740366873, 14101.647458813612, 14435.711285774016, 14525.273736313353, 14713.55859324222, 14744.483943061941, 14799.704005919606, 14939.626509336918, 13722.65693357674, 13782.448702051806, 13893.374798134311, 14280.928595356956, 14464.783028254795, 12051.939740301243, 12422.254664720145, 12436.626901192978, 12473.313967731861, 12681.0, 11987.280763153889, 12342.75314493687, 13105.109117833268, 13156.342182891009, 13287.40206690682], "value": 7920.842574368915, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1486.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 115.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 117.0, 159.0, 124.0, 122.0, 120.0, 117.0, 142.0, 119.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 160.0, 162.0, 163.0, 161.0, 161.0, 166.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 102.0, 77.0, 77.0, 76.0, 76.0, 104.0, 88.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 99.0, 82.0, 83.0, 83.0, 102.0, 82.0, 83.0, 106.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 96.0, 99.0, 97.0, 97.0, 97.0, 96.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 56.0, 55.0, 55.0, 56.0, 55.0, 54.0, 60.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 67.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 85.0, 76.0, 77.0, 82.0, 76.0, 84.0, 78.0, 77.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 132.0, 126.0, 126.0, 135.0, 125.0, 136.0, 119.0, 167.0, 124.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 164.0, 157.0, 163.0, 155.0, 157.0, 158.0, 157.0, 158.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 62.0, 62.0, 64.0, 63.0, 59.0, 61.0], "value": 61.9, "unit": "score"}]}]} 13:27:50 INFO - Return code: 0 13:27:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:27:50 ERROR - # TBPL SUCCESS # 13:27:50 INFO - Running post-action listener: _resource_record_post_action 13:27:50 INFO - [mozharness: 2017-02-09 21:27:50.221945Z] Finished run-tests step (success) 13:27:50 INFO - Running post-run listener: _resource_record_post_run 13:27:50 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 363405312; Read time: 228; Write time: 270696 13:27:50 INFO - TinderboxPrint: CPU usage
13.3% 13:27:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 228 13:27:50 INFO - TinderboxPrint: I/O write bytes / time
363,405,312 / 270,696 13:27:50 INFO - TinderboxPrint: CPU idle
8,234.2 (86.6%) 13:27:50 INFO - TinderboxPrint: CPU user
1,208.8 (12.7%) 13:27:50 INFO - TinderboxPrint: Swap in / out
0 / 0 13:27:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110002176; Read time: 0; Write time: 110120 13:27:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253403136; Read time: 228; Write time: 160576 13:27:50 INFO - Running post-run listener: _upload_blobber_files 13:27:50 INFO - Blob upload gear active. 13:27:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:27:50 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 13:27:50 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:27:50 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:27:51 INFO - (blobuploader) - INFO - Open directory for files ... 13:27:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:27:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:52 INFO - (blobuploader) - INFO - Done attempting. 13:27:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:27:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:27:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:55 INFO - (blobuploader) - INFO - Done attempting. 13:27:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:27:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:27:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:56 INFO - (blobuploader) - INFO - Done attempting. 13:27:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:27:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:27:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:57 INFO - (blobuploader) - INFO - Done attempting. 13:27:57 INFO - (blobuploader) - INFO - Iteration through files over. 13:27:57 INFO - Return code: 0 13:27:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:27:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:27:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31d106113c8ac6ba59cb0ae735e2845f9f44bcb155672b7a08edf08d772611965932783d3ea602d58ce281b23dfea676c7e89a0f8ab3a34573792ac48f849286", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ffbb47bad85bf78fca2f047038b5c4f22ea60a0db9d644b17150fcd4033d70e8dc4a07fc8c4b77771b259d71865faeaffa5f9b4a4d90127b6a8a88c1b23feab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/254814350a6711eb830e14add05404abe3454f326a9e097074903793b271981f701d49f4ff7b065d7fb1b80b14362577d5b7bd7710cb60d6a87b221a59a8e402", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf82a6d0de1fed6bb26113512224358ec4e8c8f6154ec9e25640dbdc3de57c46619abb5cfa4919807e8e943273c077114dc6afc48bfba75faaac3c527590c60c"} 13:27:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:27:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:27:57 INFO - Contents: 13:27:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31d106113c8ac6ba59cb0ae735e2845f9f44bcb155672b7a08edf08d772611965932783d3ea602d58ce281b23dfea676c7e89a0f8ab3a34573792ac48f849286", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ffbb47bad85bf78fca2f047038b5c4f22ea60a0db9d644b17150fcd4033d70e8dc4a07fc8c4b77771b259d71865faeaffa5f9b4a4d90127b6a8a88c1b23feab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/254814350a6711eb830e14add05404abe3454f326a9e097074903793b271981f701d49f4ff7b065d7fb1b80b14362577d5b7bd7710cb60d6a87b221a59a8e402", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf82a6d0de1fed6bb26113512224358ec4e8c8f6154ec9e25640dbdc3de57c46619abb5cfa4919807e8e943273c077114dc6afc48bfba75faaac3c527590c60c"} 13:27:57 INFO - Running post-run listener: copy_logs_to_upload_dir 13:27:57 INFO - Copying logs to upload dir... 13:27:57 INFO - mkdir: /builds/slave/test/build/upload/logs 13:27:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.250951 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 13:27:57.140656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 13:27:57.144593) ========= 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=41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31d106113c8ac6ba59cb0ae735e2845f9f44bcb155672b7a08edf08d772611965932783d3ea602d58ce281b23dfea676c7e89a0f8ab3a34573792ac48f849286", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ffbb47bad85bf78fca2f047038b5c4f22ea60a0db9d644b17150fcd4033d70e8dc4a07fc8c4b77771b259d71865faeaffa5f9b4a4d90127b6a8a88c1b23feab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/254814350a6711eb830e14add05404abe3454f326a9e097074903793b271981f701d49f4ff7b065d7fb1b80b14362577d5b7bd7710cb60d6a87b221a59a8e402", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf82a6d0de1fed6bb26113512224358ec4e8c8f6154ec9e25640dbdc3de57c46619abb5cfa4919807e8e943273c077114dc6afc48bfba75faaac3c527590c60c"} build_url:https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/J3rb7_JlQJ-a0ckKlkqCgA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31d106113c8ac6ba59cb0ae735e2845f9f44bcb155672b7a08edf08d772611965932783d3ea602d58ce281b23dfea676c7e89a0f8ab3a34573792ac48f849286", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ffbb47bad85bf78fca2f047038b5c4f22ea60a0db9d644b17150fcd4033d70e8dc4a07fc8c4b77771b259d71865faeaffa5f9b4a4d90127b6a8a88c1b23feab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/254814350a6711eb830e14add05404abe3454f326a9e097074903793b271981f701d49f4ff7b065d7fb1b80b14362577d5b7bd7710cb60d6a87b221a59a8e402", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf82a6d0de1fed6bb26113512224358ec4e8c8f6154ec9e25640dbdc3de57c46619abb5cfa4919807e8e943273c077114dc6afc48bfba75faaac3c527590c60c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 13:27:57.172656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:27:57.173008) ========= 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=41a7e32711b8e08598a63237000001d6-1486674438.944585-481390487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:27:57.257841) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 13:27:57.258177) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 13:27:57.258478) ========= ========= Total master_lag: 0.18 =========