builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1450745844.57 results: success (0) buildid: 20151221162217 builduid: 29eb86b3d9fa4b12886cf02417ae1e16 revision: 6eed749b538e6fafe83b45a17000716faf39e623 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.570631) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.571303) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.571585) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006345 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.610747) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.611122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.658554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.658815) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004757 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.717939) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.718208) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.718548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.718826) ========= 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=256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 16:57:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-12-21 16:57:25 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117181 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.855310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.855897) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016766 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.934255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:24.934587) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6eed749b538e6fafe83b45a17000716faf39e623 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6eed749b538e6fafe83b45a17000716faf39e623 --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=256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 16:57:25,596 truncating revision to first 12 chars 2015-12-21 16:57:25,596 Setting DEBUG logging. 2015-12-21 16:57:25,596 attempt 1/10 2015-12-21 16:57:25,597 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6eed749b538e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 16:57:25,988 unpacking tar archive at: fx-team-6eed749b538e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.702275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:25.660641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:25.660918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:25.670180) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:25.670518) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 16:57:25.670954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 26 secs) (at 2015-12-21 16:57:25.671275) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:57:26 INFO - MultiFileLogger online at 20151221 16:57:26 in /builds/slave/test 16:57:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:57:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:57:26 INFO - {'append_to_log': False, 16:57:26 INFO - 'base_work_dir': '/builds/slave/test', 16:57:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:57:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:57:26 INFO - 'branch': 'Fx-Team-Non-PGO', 16:57:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:57:26 INFO - 'config_files': ('talos/linux_config.py',), 16:57:26 INFO - 'default_actions': ('clobber', 16:57:26 INFO - 'read-buildbot-config', 16:57:26 INFO - 'download-and-extract', 16:57:26 INFO - 'populate-webroot', 16:57:26 INFO - 'create-virtualenv', 16:57:26 INFO - 'install', 16:57:26 INFO - 'run-tests'), 16:57:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:57:26 INFO - 'download_minidump_stackwalk': True, 16:57:26 INFO - 'download_symbols': 'ondemand', 16:57:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:57:26 INFO - 'tooltool.py': '/tools/tooltool.py', 16:57:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:57:26 INFO - '/tools/misc-python/virtualenv.py')}, 16:57:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:57:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:57:26 INFO - 'installer_path': 'installer.exe', 16:57:26 INFO - 'log_level': 'info', 16:57:26 INFO - 'log_name': 'talos', 16:57:26 INFO - 'log_to_console': True, 16:57:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:57:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:57:26 INFO - 'opt_config_files': (), 16:57:26 INFO - 'pip_index': False, 16:57:26 INFO - 'sps_profile': False, 16:57:26 INFO - 'sps_profile_interval': 0, 16:57:26 INFO - 'suite': 'dromaeojs', 16:57:26 INFO - 'system_bits': '64', 16:57:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:57:26 INFO - 'title': 'talos-linux64-ix-013', 16:57:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:57:26 INFO - 'use_talos_json': True, 16:57:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:57:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:57:26 INFO - 'work_dir': 'build'} 16:57:26 INFO - ##### 16:57:26 INFO - ##### Running clobber step. 16:57:26 INFO - ##### 16:57:26 INFO - Running pre-action listener: _resource_record_pre_action 16:57:26 INFO - Running main action method: clobber 16:57:26 INFO - rmtree: /builds/slave/test/build 16:57:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:57:26 INFO - Running post-action listener: _resource_record_post_action 16:57:26 INFO - ##### 16:57:26 INFO - ##### Running read-buildbot-config step. 16:57:26 INFO - ##### 16:57:26 INFO - Running pre-action listener: _resource_record_pre_action 16:57:26 INFO - Running main action method: read_buildbot_config 16:57:26 INFO - Using buildbot properties: 16:57:26 INFO - { 16:57:26 INFO - "project": "", 16:57:26 INFO - "product": "firefox", 16:57:26 INFO - "script_repo_revision": "production", 16:57:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:57:26 INFO - "repository": "", 16:57:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:57:26 INFO - "buildid": "20151221162217", 16:57:26 INFO - "pgo_build": "False", 16:57:26 INFO - "basedir": "/builds/slave/test", 16:57:26 INFO - "buildnumber": 2238, 16:57:26 INFO - "slavename": "talos-linux64-ix-013", 16:57:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:57:26 INFO - "platform": "ubuntu64_hw", 16:57:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:57:26 INFO - "branch": "fx-team", 16:57:26 INFO - "repo_path": "integration/fx-team", 16:57:26 INFO - "revision": "6eed749b538e6fafe83b45a17000716faf39e623", 16:57:26 INFO - "stage_platform": "linux64", 16:57:26 INFO - "builduid": "29eb86b3d9fa4b12886cf02417ae1e16", 16:57:26 INFO - "slavebuilddir": "test" 16:57:26 INFO - } 16:57:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:57:26 INFO - Running post-action listener: _resource_record_post_action 16:57:26 INFO - ##### 16:57:26 INFO - ##### Running download-and-extract step. 16:57:26 INFO - ##### 16:57:26 INFO - Running pre-action listener: _resource_record_pre_action 16:57:26 INFO - Running main action method: download_and_extract 16:57:26 INFO - mkdir: /builds/slave/test/build/tests 16:57:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:26 INFO - https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:57:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/test_packages.json 16:57:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/test_packages.json 16:57:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:57:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:57:37 INFO - Downloaded 1302 bytes. 16:57:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:57:37 INFO - Using the following test package requirements: 16:57:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:57:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:57:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:37 INFO - u'jsshell-linux-x86_64.zip'], 16:57:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:57:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:57:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:57:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:57:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:57:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:57:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:57:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:37 INFO - https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:57:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:57:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:57:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:57:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:57:40 INFO - Downloaded 21926753 bytes. 16:57:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 16:57:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:57:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:57:41 INFO - Return code: 0 16:57:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:41 INFO - https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:57:45 INFO - Downloaded 21926753 bytes. 16:57:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 16:57:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:57:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:57:47 INFO - Return code: 0 16:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:47 INFO - https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:57:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:57:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:57:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:57:48 INFO - Downloaded 11132277 bytes. 16:57:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 16:57:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:57:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:57:48 INFO - Return code: 0 16:57:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:48 INFO - https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:57:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:57:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:57:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:57:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:57:50 INFO - Downloaded 53372966 bytes. 16:57:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:57:51 INFO - mkdir: /builds/slave/test/properties 16:57:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:57:51 INFO - Writing to file /builds/slave/test/properties/build_url 16:57:51 INFO - Contents: 16:57:51 INFO - build_url:https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:57:51 INFO - Running post-action listener: _resource_record_post_action 16:57:51 INFO - Running post-action listener: set_extra_try_arguments 16:57:51 INFO - ##### 16:57:51 INFO - ##### Running populate-webroot step. 16:57:51 INFO - ##### 16:57:51 INFO - Running pre-action listener: _resource_record_pre_action 16:57:51 INFO - Running main action method: populate_webroot 16:57:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:57:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:57:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:57:51 INFO - '--tppagecycles', 16:57:51 INFO - '7'], 16:57:51 INFO - 'tests': ['tsvgm']}}, 16:57:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:57:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:57:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:57:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:57:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:57:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:51 INFO - 'talos_options': ['--e10s'], 16:57:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:51 INFO - 'tests': ['damp', 'tps']}, 16:57:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:51 INFO - 'talos_options': ['--e10s'], 16:57:51 INFO - 'tests': ['damp', 'tps']}, 16:57:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:57:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:57:51 INFO - 'other': {'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore']}, 16:57:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:57:51 INFO - 'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore']}, 16:57:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:57:51 INFO - 'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore']}, 16:57:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:57:51 INFO - 'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore']}, 16:57:51 INFO - 'other_l64': {'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore']}, 16:57:51 INFO - 'other_nol64': {'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore']}, 16:57:51 INFO - 'svgr': {'tests': ['tsvgx', 16:57:51 INFO - 'tsvgr_opacity', 16:57:51 INFO - 'tart', 16:57:51 INFO - 'tscrollx', 16:57:51 INFO - 'cart']}, 16:57:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:57:51 INFO - 'tests': ['tsvgx', 16:57:51 INFO - 'tsvgr_opacity', 16:57:51 INFO - 'tart', 16:57:51 INFO - 'tscrollx', 16:57:51 INFO - 'cart']}, 16:57:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:51 INFO - 'tests': ['tp5o']}, 16:57:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:51 INFO - 'talos_options': ['--e10s'], 16:57:51 INFO - 'tests': ['tp5o']}, 16:57:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:51 INFO - 'talos_options': ['--xperf_path', 16:57:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:51 INFO - 'tests': ['tp5n']}, 16:57:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:51 INFO - 'talos_options': ['--e10s', 16:57:51 INFO - '--xperf_path', 16:57:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:51 INFO - 'tests': ['tp5n']}}, 16:57:51 INFO - 'talos.zip': {'path': '', 16:57:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:57:51 INFO - Running post-action listener: _resource_record_post_action 16:57:51 INFO - ##### 16:57:51 INFO - ##### Running create-virtualenv step. 16:57:51 INFO - ##### 16:57:51 INFO - Running pre-action listener: _resource_record_pre_action 16:57:51 INFO - Running main action method: create_virtualenv 16:57:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:57:51 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 16:57:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:57:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:51 INFO - Using real prefix '/usr' 16:57:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:57:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:54 INFO - Installing pip.................done. 16:57:54 INFO - Return code: 0 16:57:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc788b36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25123d0>, '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 0x247ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247e360>, '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': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', '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 16:57:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:57:54 INFO - Using env: {'DISPLAY': ':0', 16:57:54 INFO - 'HOME': '/home/cltbld', 16:57:54 INFO - 'LANG': 'en_US.UTF-8', 16:57:54 INFO - 'LANGUAGE': 'en_US:en', 16:57:54 INFO - 'LOGNAME': 'cltbld', 16:57:54 INFO - 'MAIL': '/var/mail/cltbld', 16:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:54 INFO - 'MOZ_NO_REMOTE': '1', 16:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:54 INFO - 'NO_EM_RESTART': '1', 16:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:54 INFO - 'PWD': '/builds/slave/test', 16:57:54 INFO - 'SHELL': '/bin/bash', 16:57:54 INFO - 'SHLVL': '1', 16:57:54 INFO - 'TERM': 'linux', 16:57:54 INFO - 'TMOUT': '86400', 16:57:54 INFO - 'USER': 'cltbld', 16:57:54 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', 16:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:54 INFO - '_': '/tools/buildbot/bin/python'} 16:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:54 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 16:57:54 INFO - Cleaning up... 16:57:54 INFO - Return code: 0 16:57:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc788b36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25123d0>, '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 0x247ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247e360>, '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': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', '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 16:57:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 16:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 16:57:54 INFO - Using env: {'DISPLAY': ':0', 16:57:54 INFO - 'HOME': '/home/cltbld', 16:57:54 INFO - 'LANG': 'en_US.UTF-8', 16:57:54 INFO - 'LANGUAGE': 'en_US:en', 16:57:54 INFO - 'LOGNAME': 'cltbld', 16:57:54 INFO - 'MAIL': '/var/mail/cltbld', 16:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:54 INFO - 'MOZ_NO_REMOTE': '1', 16:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:54 INFO - 'NO_EM_RESTART': '1', 16:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:54 INFO - 'PWD': '/builds/slave/test', 16:57:54 INFO - 'SHELL': '/bin/bash', 16:57:54 INFO - 'SHLVL': '1', 16:57:54 INFO - 'TERM': 'linux', 16:57:54 INFO - 'TMOUT': '86400', 16:57:54 INFO - 'USER': 'cltbld', 16:57:54 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', 16:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:54 INFO - '_': '/tools/buildbot/bin/python'} 16:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:54 INFO - Downloading/unpacking psutil>=0.7.1 16:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:57:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:56 INFO - Installing collected packages: psutil 16:57:56 INFO - Running setup.py install for psutil 16:57:56 INFO - building 'psutil._psutil_linux' extension 16:57:56 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 16:57:56 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 16:57:56 INFO - building 'psutil._psutil_posix' extension 16:57:56 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 16:57:56 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 16:57:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:56 INFO - Successfully installed psutil 16:57:56 INFO - Cleaning up... 16:57:56 INFO - Return code: 0 16:57:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc788b36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25123d0>, '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 0x247ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247e360>, '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': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', '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 16:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 16:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 16:57:56 INFO - Using env: {'DISPLAY': ':0', 16:57:56 INFO - 'HOME': '/home/cltbld', 16:57:56 INFO - 'LANG': 'en_US.UTF-8', 16:57:56 INFO - 'LANGUAGE': 'en_US:en', 16:57:56 INFO - 'LOGNAME': 'cltbld', 16:57:56 INFO - 'MAIL': '/var/mail/cltbld', 16:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:56 INFO - 'MOZ_NO_REMOTE': '1', 16:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:56 INFO - 'NO_EM_RESTART': '1', 16:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:56 INFO - 'PWD': '/builds/slave/test', 16:57:56 INFO - 'SHELL': '/bin/bash', 16:57:56 INFO - 'SHLVL': '1', 16:57:56 INFO - 'TERM': 'linux', 16:57:56 INFO - 'TMOUT': '86400', 16:57:56 INFO - 'USER': 'cltbld', 16:57:56 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', 16:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:56 INFO - '_': '/tools/buildbot/bin/python'} 16:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:57:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:57:58 INFO - Installing collected packages: mozsystemmonitor 16:57:58 INFO - Running setup.py install for mozsystemmonitor 16:57:58 INFO - Successfully installed mozsystemmonitor 16:57:58 INFO - Cleaning up... 16:57:58 INFO - Return code: 0 16:57:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc788b36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25123d0>, '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 0x247ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247e360>, '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': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', '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 16:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:57:58 INFO - Using env: {'DISPLAY': ':0', 16:57:58 INFO - 'HOME': '/home/cltbld', 16:57:58 INFO - 'LANG': 'en_US.UTF-8', 16:57:58 INFO - 'LANGUAGE': 'en_US:en', 16:57:58 INFO - 'LOGNAME': 'cltbld', 16:57:58 INFO - 'MAIL': '/var/mail/cltbld', 16:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:58 INFO - 'MOZ_NO_REMOTE': '1', 16:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:58 INFO - 'NO_EM_RESTART': '1', 16:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:58 INFO - 'PWD': '/builds/slave/test', 16:57:58 INFO - 'SHELL': '/bin/bash', 16:57:58 INFO - 'SHLVL': '1', 16:57:58 INFO - 'TERM': 'linux', 16:57:58 INFO - 'TMOUT': '86400', 16:57:58 INFO - 'USER': 'cltbld', 16:57:58 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', 16:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:58 INFO - '_': '/tools/buildbot/bin/python'} 16:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:58:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:01 INFO - Downloading docopt-0.6.1.tar.gz 16:58:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:01 INFO - Running setup.py install for blobuploader 16:58:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:58:01 INFO - Running setup.py install for requests 16:58:01 INFO - Running setup.py install for docopt 16:58:02 INFO - Successfully installed blobuploader requests docopt 16:58:02 INFO - Cleaning up... 16:58:02 INFO - Return code: 0 16:58:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc788b36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25123d0>, '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 0x247ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247e360>, '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': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', '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 16:58:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 16:58:02 INFO - Using env: {'DISPLAY': ':0', 16:58:02 INFO - 'HOME': '/home/cltbld', 16:58:02 INFO - 'LANG': 'en_US.UTF-8', 16:58:02 INFO - 'LANGUAGE': 'en_US:en', 16:58:02 INFO - 'LOGNAME': 'cltbld', 16:58:02 INFO - 'MAIL': '/var/mail/cltbld', 16:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:02 INFO - 'MOZ_NO_REMOTE': '1', 16:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:02 INFO - 'NO_EM_RESTART': '1', 16:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:02 INFO - 'PWD': '/builds/slave/test', 16:58:02 INFO - 'SHELL': '/bin/bash', 16:58:02 INFO - 'SHLVL': '1', 16:58:02 INFO - 'TERM': 'linux', 16:58:02 INFO - 'TMOUT': '86400', 16:58:02 INFO - 'USER': 'cltbld', 16:58:02 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', 16:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:02 INFO - '_': '/tools/buildbot/bin/python'} 16:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:02 INFO - Running setup.py (path:/tmp/pip-tocW0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:02 INFO - Running setup.py (path:/tmp/pip-1uqFlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:02 INFO - Running setup.py (path:/tmp/pip-InGInY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:02 INFO - Running setup.py (path:/tmp/pip-rWP9xL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:02 INFO - Running setup.py (path:/tmp/pip-975hhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:02 INFO - Running setup.py (path:/tmp/pip-3t4LbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:02 INFO - Running setup.py (path:/tmp/pip-tjlQP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:02 INFO - Running setup.py (path:/tmp/pip-N1Y3vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:02 INFO - Running setup.py (path:/tmp/pip-XsfmIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:02 INFO - Running setup.py (path:/tmp/pip-fPxepw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:03 INFO - Running setup.py (path:/tmp/pip-d1Owt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:03 INFO - Running setup.py (path:/tmp/pip-ahuou6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:03 INFO - Running setup.py (path:/tmp/pip-Vf11BL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:03 INFO - Running setup.py (path:/tmp/pip-lyWY38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:03 INFO - Running setup.py (path:/tmp/pip-PIJapk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:03 INFO - Running setup.py (path:/tmp/pip-GNNJ2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:03 INFO - Running setup.py (path:/tmp/pip-9x_wKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:03 INFO - Running setup.py install for manifestparser 16:58:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:58:03 INFO - Running setup.py install for mozcrash 16:58:03 INFO - Running setup.py install for mozdebug 16:58:03 INFO - Running setup.py install for mozdevice 16:58:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:58:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:58:03 INFO - Running setup.py install for mozfile 16:58:04 INFO - Running setup.py install for mozhttpd 16:58:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for mozinfo 16:58:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for mozInstall 16:58:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for mozleak 16:58:04 INFO - Running setup.py install for mozlog 16:58:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for moznetwork 16:58:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for mozprocess 16:58:04 INFO - Running setup.py install for mozprofile 16:58:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for mozrunner 16:58:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for mozscreenshot 16:58:05 INFO - Running setup.py install for moztest 16:58:08 INFO - Running setup.py install for mozversion 16:58:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:58:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:08 INFO - Cleaning up... 16:58:08 INFO - Return code: 0 16:58:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc788b36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25123d0>, '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 0x247ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247e360>, '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': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', '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 16:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:58:08 INFO - Using env: {'DISPLAY': ':0', 16:58:08 INFO - 'HOME': '/home/cltbld', 16:58:08 INFO - 'LANG': 'en_US.UTF-8', 16:58:08 INFO - 'LANGUAGE': 'en_US:en', 16:58:08 INFO - 'LOGNAME': 'cltbld', 16:58:08 INFO - 'MAIL': '/var/mail/cltbld', 16:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:08 INFO - 'MOZ_NO_REMOTE': '1', 16:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:08 INFO - 'NO_EM_RESTART': '1', 16:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:08 INFO - 'PWD': '/builds/slave/test', 16:58:08 INFO - 'SHELL': '/bin/bash', 16:58:08 INFO - 'SHLVL': '1', 16:58:08 INFO - 'TERM': 'linux', 16:58:08 INFO - 'TMOUT': '86400', 16:58:08 INFO - 'USER': 'cltbld', 16:58:08 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', 16:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:08 INFO - '_': '/tools/buildbot/bin/python'} 16:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:08 INFO - Running setup.py (path:/tmp/pip-i3abYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:08 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)) 16:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:08 INFO - Running setup.py (path:/tmp/pip-SqzA4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 16:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:08 INFO - Running setup.py (path:/tmp/pip-pH5L4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:08 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)) 16:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:08 INFO - Running setup.py (path:/tmp/pip-TFbszW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 16:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:08 INFO - Running setup.py (path:/tmp/pip-TSw93z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:08 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)) 16:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:08 INFO - Running setup.py (path:/tmp/pip-IEdKJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:08 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)) 16:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:08 INFO - Running setup.py (path:/tmp/pip-Zpgrzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:08 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)) 16:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:08 INFO - Running setup.py (path:/tmp/pip-qc1PAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:09 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)) 16:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:09 INFO - Running setup.py (path:/tmp/pip-B94vdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:09 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)) 16:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:09 INFO - Running setup.py (path:/tmp/pip-tUHzxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 16:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:09 INFO - Running setup.py (path:/tmp/pip-rZqrQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:09 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)) 16:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:09 INFO - Running setup.py (path:/tmp/pip-A84aAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 16:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:09 INFO - Running setup.py (path:/tmp/pip-CS2rBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:09 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)) 16:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:09 INFO - Running setup.py (path:/tmp/pip-RpRfgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 16:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:09 INFO - Running setup.py (path:/tmp/pip-mNDEOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:09 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)) 16:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:09 INFO - Running setup.py (path:/tmp/pip-dnaVSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 16:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:09 INFO - Running setup.py (path:/tmp/pip-fL8Wku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:09 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)) 16:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:58:09 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)) 16:58:09 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:58:09 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:58:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:11 INFO - Downloading blessings-1.5.1.tar.gz 16:58:11 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:11 INFO - Installing collected packages: blessings 16:58:11 INFO - Running setup.py install for blessings 16:58:11 INFO - Successfully installed blessings 16:58:11 INFO - Cleaning up... 16:58:11 INFO - Return code: 0 16:58:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:11 INFO - Reading from file tmpfile_stdout 16:58:11 INFO - Current package versions: 16:58:11 INFO - argparse == 1.2.1 16:58:11 INFO - blessings == 1.5.1 16:58:11 INFO - blobuploader == 1.2.4 16:58:11 INFO - docopt == 0.6.1 16:58:11 INFO - manifestparser == 1.1 16:58:11 INFO - mozInstall == 1.12 16:58:11 INFO - mozcrash == 0.16 16:58:11 INFO - mozdebug == 0.1 16:58:11 INFO - mozdevice == 0.47 16:58:11 INFO - mozfile == 1.2 16:58:11 INFO - mozhttpd == 0.7 16:58:11 INFO - mozinfo == 0.9 16:58:11 INFO - mozleak == 0.1 16:58:11 INFO - mozlog == 3.1 16:58:11 INFO - moznetwork == 0.27 16:58:11 INFO - mozprocess == 0.22 16:58:11 INFO - mozprofile == 0.28 16:58:11 INFO - mozrunner == 6.11 16:58:11 INFO - mozscreenshot == 0.1 16:58:11 INFO - mozsystemmonitor == 0.0 16:58:11 INFO - moztest == 0.7 16:58:11 INFO - mozversion == 1.4 16:58:11 INFO - psutil == 3.1.1 16:58:11 INFO - requests == 1.2.3 16:58:11 INFO - wsgiref == 0.1.2 16:58:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc788b36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25123d0>, '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 0x247ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247e360>, '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': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', '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 16:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:58:11 INFO - Using env: {'DISPLAY': ':0', 16:58:11 INFO - 'HOME': '/home/cltbld', 16:58:11 INFO - 'LANG': 'en_US.UTF-8', 16:58:11 INFO - 'LANGUAGE': 'en_US:en', 16:58:11 INFO - 'LOGNAME': 'cltbld', 16:58:11 INFO - 'MAIL': '/var/mail/cltbld', 16:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:11 INFO - 'MOZ_NO_REMOTE': '1', 16:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:11 INFO - 'NO_EM_RESTART': '1', 16:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:11 INFO - 'PWD': '/builds/slave/test', 16:58:11 INFO - 'SHELL': '/bin/bash', 16:58:11 INFO - 'SHLVL': '1', 16:58:11 INFO - 'TERM': 'linux', 16:58:11 INFO - 'TMOUT': '86400', 16:58:11 INFO - 'USER': 'cltbld', 16:58:11 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', 16:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:11 INFO - '_': '/tools/buildbot/bin/python'} 16:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:58:12 INFO - Cleaning up... 16:58:12 INFO - Return code: 0 16:58:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc788b36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25123d0>, '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 0x247ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247e360>, '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': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', '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 16:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:58:12 INFO - Using env: {'DISPLAY': ':0', 16:58:12 INFO - 'HOME': '/home/cltbld', 16:58:12 INFO - 'LANG': 'en_US.UTF-8', 16:58:12 INFO - 'LANGUAGE': 'en_US:en', 16:58:12 INFO - 'LOGNAME': 'cltbld', 16:58:12 INFO - 'MAIL': '/var/mail/cltbld', 16:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:12 INFO - 'MOZ_NO_REMOTE': '1', 16:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:12 INFO - 'NO_EM_RESTART': '1', 16:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:12 INFO - 'PWD': '/builds/slave/test', 16:58:12 INFO - 'SHELL': '/bin/bash', 16:58:12 INFO - 'SHLVL': '1', 16:58:12 INFO - 'TERM': 'linux', 16:58:12 INFO - 'TMOUT': '86400', 16:58:12 INFO - 'USER': 'cltbld', 16:58:12 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', 16:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:12 INFO - '_': '/tools/buildbot/bin/python'} 16:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:12 INFO - Downloading/unpacking jsonschema 16:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:58:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:58:13 INFO - Downloading/unpacking functools32 (from jsonschema) 16:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:14 INFO - Downloading functools32-3.2.3-2.tar.gz 16:58:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:58:14 INFO - warning: no files found matching '*.txt' 16:58:14 INFO - no previously-included directories found matching 'build' 16:58:14 INFO - no previously-included directories found matching 'dist' 16:58:14 INFO - no previously-included directories found matching '.git*' 16:58:14 INFO - Installing collected packages: jsonschema, functools32 16:58:14 INFO - Running setup.py install for functools32 16:58:14 INFO - warning: no files found matching '*.txt' 16:58:14 INFO - no previously-included directories found matching 'build' 16:58:14 INFO - no previously-included directories found matching 'dist' 16:58:14 INFO - no previously-included directories found matching '.git*' 16:58:14 INFO - Successfully installed jsonschema functools32 16:58:14 INFO - Cleaning up... 16:58:14 INFO - Return code: 0 16:58:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc788b36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25123d0>, '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 0x247ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247e360>, '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': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', '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 16:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8'] in /builds/slave/test/build 16:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 flake8 16:58:14 INFO - Using env: {'DISPLAY': ':0', 16:58:14 INFO - 'HOME': '/home/cltbld', 16:58:14 INFO - 'LANG': 'en_US.UTF-8', 16:58:14 INFO - 'LANGUAGE': 'en_US:en', 16:58:14 INFO - 'LOGNAME': 'cltbld', 16:58:14 INFO - 'MAIL': '/var/mail/cltbld', 16:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:14 INFO - 'MOZ_NO_REMOTE': '1', 16:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:14 INFO - 'NO_EM_RESTART': '1', 16:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:14 INFO - 'PWD': '/builds/slave/test', 16:58:14 INFO - 'SHELL': '/bin/bash', 16:58:14 INFO - 'SHLVL': '1', 16:58:14 INFO - 'TERM': 'linux', 16:58:14 INFO - 'TMOUT': '86400', 16:58:14 INFO - 'USER': 'cltbld', 16:58:14 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', 16:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:14 INFO - '_': '/tools/buildbot/bin/python'} 16:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:14 INFO - Downloading/unpacking flake8 16:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:58:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:58:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:58:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:58:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:58:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:58:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:58:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:58:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:58:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:58:16 INFO - no previously-included directories found matching 'docs/_build' 16:58:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:58:16 INFO - Running setup.py install for pep8 16:58:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:58:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:58:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:58:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:58:17 INFO - no previously-included directories found matching 'docs/_build' 16:58:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:58:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:58:17 INFO - Cleaning up... 16:58:17 INFO - Return code: 0 16:58:17 INFO - Running post-action listener: _resource_record_post_action 16:58:17 INFO - Running post-action listener: _start_resource_monitoring 16:58:17 INFO - Starting resource monitoring. 16:58:17 INFO - ##### 16:58:17 INFO - ##### Running install step. 16:58:17 INFO - ##### 16:58:17 INFO - Running pre-action listener: _resource_record_pre_action 16:58:17 INFO - Running main action method: install 16:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:17 INFO - Reading from file tmpfile_stdout 16:58:17 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:58:17 INFO - Reading from file tmpfile_stdout 16:58:17 INFO - Output received: 16:58:17 INFO - Usage: mozinstall [options] installer 16:58:17 INFO - Options: 16:58:17 INFO - -h, --help show this help message and exit 16:58:17 INFO - -d DEST, --destination=DEST 16:58:17 INFO - Directory to install application into. [default: 16:58:17 INFO - "/builds/slave/test"] 16:58:17 INFO - --app=APP Application being installed. [default: firefox] 16:58:17 INFO - mkdir: /builds/slave/test/build/application 16:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:58:36 INFO - Reading from file tmpfile_stdout 16:58:36 INFO - Output received: 16:58:36 INFO - /builds/slave/test/build/application/firefox/firefox 16:58:36 INFO - Running post-action listener: _resource_record_post_action 16:58:36 INFO - ##### 16:58:36 INFO - ##### Running run-tests step. 16:58:36 INFO - ##### 16:58:36 INFO - Running pre-action listener: _resource_record_pre_action 16:58:36 INFO - Running main action method: run_tests 16:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:36 INFO - Python 2.7.3 16:58:36 INFO - Return code: 0 16:58:36 INFO - grabbing minidump binary from tooltool 16:58:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:36 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25123d0>, '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 0x247ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247e360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:36 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 16:58:36 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 16:58:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:36 INFO - Return code: 0 16:58:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:58:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:58:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:58:37 INFO - Return code: 0 16:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:58:37 INFO - Using env: {'DISPLAY': ':0', 16:58:37 INFO - 'HOME': '/home/cltbld', 16:58:37 INFO - 'LANG': 'en_US.UTF-8', 16:58:37 INFO - 'LANGUAGE': 'en_US:en', 16:58:37 INFO - 'LOGNAME': 'cltbld', 16:58:37 INFO - 'MAIL': '/var/mail/cltbld', 16:58:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:37 INFO - 'MOZ_NO_REMOTE': '1', 16:58:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:37 INFO - 'NO_EM_RESTART': '1', 16:58:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:37 INFO - 'PWD': '/builds/slave/test', 16:58:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:37 INFO - 'SHELL': '/bin/bash', 16:58:37 INFO - 'SHLVL': '1', 16:58:37 INFO - 'TERM': 'linux', 16:58:37 INFO - 'TMOUT': '86400', 16:58:37 INFO - 'USER': 'cltbld', 16:58:37 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173', 16:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:37 INFO - '_': '/tools/buildbot/bin/python'} 16:58:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:58:37 INFO - mozversion application_buildid: 20151221162217 16:58:37 INFO - mozversion application_changeset: 6eed749b538e6fafe83b45a17000716faf39e623 16:58:37 INFO - mozversion application_display_name: Nightly 16:58:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:37 INFO - mozversion application_name: Firefox 16:58:37 INFO - mozversion application_remotingname: firefox 16:58:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:58:37 INFO - mozversion application_vendor: Mozilla 16:58:37 INFO - mozversion application_version: 46.0a1 16:58:37 INFO - mozversion platform_buildid: 20151221162217 16:58:37 INFO - mozversion platform_changeset: 6eed749b538e6fafe83b45a17000716faf39e623 16:58:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:58:37 INFO - mozversion platform_version: 46.0a1 16:58:37 INFO - using testdate: 1450745917 16:58:37 INFO - actual date: 1450745917 16:58:37 INFO - starting webserver on 'localhost:60982' 16:58:37 INFO - SUITE-START | Running 3 tests 16:58:37 INFO - TEST-START | dromaeo_css 16:58:37 INFO - operating with platform_type : linux_ 16:58:37 INFO - Initialising browser for dromaeo_css test... 16:58:37 INFO - TEST-INFO | started process 28789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeu0IE0/profile http://localhost:60982/getInfo.html) 16:59:54 INFO - PROCESS | 28789 | __metrics Screen width/height:1600/1200 16:59:54 INFO - PROCESS | 28789 | colorDepth:24 16:59:54 INFO - PROCESS | 28789 | Browser inner width/height: 1024/697 16:59:54 INFO - PROCESS | 28789 | __metrics 16:59:54 INFO - PROCESS | 28789 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:59:54 INFO - PROCESS | 28789 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:00:00 INFO - TEST-INFO | 28789: exit 0 17:00:00 INFO - Browser initialized. 17:00:00 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:00 INFO - TEST-INFO | started process 28880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeu0IE0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:12 INFO - PROCESS | 28880 | RSS: Main: 150159360 17:00:12 INFO - PROCESS | 28880 | 17:01:03 INFO - PROCESS | 28880 | 1450746063657 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:03:18 INFO - PROCESS | 28880 | Cycle 1(1): loaded http://localhost:60982/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60982/tests/dromaeo/cssquery-ext.html) 17:03:19 INFO - PROCESS | 28880 | RSS: Main: 236199936 17:03:19 INFO - PROCESS | 28880 | 17:06:22 INFO - PROCESS | 28880 | Cycle 1(1): loaded http://localhost:60982/tests/dromaeo/cssquery-ext.html (next: http://localhost:60982/tests/dromaeo/cssquery-jquery.html) 17:06:22 INFO - PROCESS | 28880 | RSS: Main: 223326208 17:06:22 INFO - PROCESS | 28880 | 17:09:24 INFO - PROCESS | 28880 | Cycle 1(1): loaded http://localhost:60982/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60982/tests/dromaeo/cssquery-mootools.html) 17:09:25 INFO - PROCESS | 28880 | RSS: Main: 231063552 17:09:25 INFO - PROCESS | 28880 | 17:12:27 INFO - PROCESS | 28880 | Cycle 1(1): loaded http://localhost:60982/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60982/tests/dromaeo/cssquery-prototype.html) 17:12:27 INFO - PROCESS | 28880 | RSS: Main: 211034112 17:12:27 INFO - PROCESS | 28880 | 17:15:30 INFO - PROCESS | 28880 | Cycle 1(1): loaded http://localhost:60982/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60982/tests/dromaeo/cssquery-yui.html) 17:15:31 INFO - PROCESS | 28880 | RSS: Main: 213426176 17:15:31 INFO - PROCESS | 28880 | 17:18:33 INFO - PROCESS | 28880 | Cycle 1(1): loaded http://localhost:60982/tests/dromaeo/cssquery-yui.html (next: http://localhost:60982/tests/dromaeo/cssquery-dojo.html) 17:18:33 INFO - PROCESS | 28880 | RSS: Main: 257409024 17:18:33 INFO - PROCESS | 28880 | 17:18:33 INFO - PROCESS | 28880 | __start_tp_report 17:18:33 INFO - PROCESS | 28880 | _x_x_mozilla_page_load 17:18:33 INFO - PROCESS | 28880 | _x_x_mozilla_page_load_details 17:18:33 INFO - PROCESS | 28880 | |i|pagename|runs| 17:18:33 INFO - PROCESS | 28880 | |0;dojo.html;2615.28079778061;2683.5572130598453;2683.8523881186525;2698.8245764025337;2712.1456741126544;4503.572160644741;4608.838690645828;4667.043256132493;4673.29900514923;4677.321788340692;4569.6801223914335;4574.862754117382;4676.275177347517;4679.8362057328;4690.90618187636;4272.978635106828;4329.567043295677;4333.1766964276685;4351.891202719926;4376.256036473807;4051.918961620766;4332.046949671083;4348.434703488558;4407.625351845097;4436.046250056237;4119.237940980898;4231.661467082626;4237.258479766028;4333.371661109121;4392.604665580081;4213.5786421357925;4314.956850431487;4317.848875289381;4322.891927701801;4331.5884990925815;4271.1671224111315;4271.615554600101;4277.037666525038;4305.935410968838;4325;4429.822807087713;4544.3637890695;4605.424321959755;4606.378138951232;4624.398828152319;4864.927026094611;4881.145799485112;4998.525140111684;5011.824586139468;5032.47159048302;5045.823396181153;5050.318207042039;5061.6962982221185;5063.215201643751;5099.46455622158;4689.835855745033;4690;4691.906161876777;4693.131770622445;4707.976460117746;4972.229304457743;5023.6985780853265;5062.5858191877305;5100.872478188001;5173.094708426011;4905.411350637946;4910.165271903785;4911.091448082117;4927;4972.353594032753;4980.975095124501;4989.750512474362;4991.850244492671;5000.199968005102;5019.648624596316;4803.567678908915;4886.682365646222;4921.3356196912955;4932.260160975882;4989.5758860496535;4919.311296418504;4934.259861020875;4937.679050861682;4940.283658869444;4984.825531106467;4151.7924103794685;4158.9376159357635;4160.854370097032;4168.541460439349;4198.538160802309;3505.9298814024087;3578.284343131384;3649.1606930406156;3652.908677283089;3678.7240956928335;4340.153670034376;4342.196693611692;4345.739255644671;4352.673549483801;4390.495093064274;5023.472535383732;5028.245763135559;5034.194528875362;5040.571551418097;5075.467075957045;4098.918021639551;4207.074443622399;4207.326827707552;4218.346156345771;4332.740035597874;4463.709858859163;4477.126960242721;4488.192125417456;4507.887302817456;4519.728816271035;4815.6388270879825;4817.542333478384;4820.060088282751;4823.107725070873;4868;4850.102730994778;4865.367502224688;4971.577415919687;4986.077575648516;5058.34241548611;4786.569208771228;4812.759362031955;4828.324034635224;4863.537963893425;4866.732329721899;4960.8759781005765;4961.05739909416;4965.4786247444945;4972.0801651694555;4985.8005679772405;4850.296706977398;4980.551750342486;5065;5082.085224659449;5129.820456284012;4752.405949256343;4777.092352453023;4844.2007068834655;4852.272159176152;4900.950990490192;4789.592884604847;4796.304535842213;4798.49615790351;4802.567768900815;4846.17615005457;4563.429571303587;4674.275487299474;4783.449903261169;4788.473267940593;4802.039592081528;4817.518248175154;4845.127876982177;4885.975570122127;4931.309616653743;4938.160512712776;4783.7129772213775;4810.302506136661;4817.325574419514;4818.10864989978;4865.854024379274 17:18:33 INFO - PROCESS | 28880 | |1;ext.html;508.25286828362306;517.433410415595;517.5368045599189;533.8051611161927;537.7096367961301;27244.04645837396;34689.479657805125;35478.64521354789;35482;35526.64473355272;40298.59701402985;40855;40856.18287634246;40877.795611021975;40949.59050409495;6965.5124141310125;7078.787636370917;7863.567503787275;8029.799255018613;8033.758987230363;10059.64791232307;10305;10305.690829275134;10312.690619281433;10320.277580569364;9909;10009.59961601535;10016.098551130397;10019.549120289568;10020.19838412929;7158.284171582852;7354.374878135365;10026.548805303779;10072.697819065403;10291.022352876465;9744.464054477;9861.60553577856;9862.852057219148;9864.704058878246;9867.60529578816;30061.248468788235;37011.81494092539;37522.624773752184;37578.43632345517;37624.247515049545;2366.9644955325684;2782.6799918009488;2821.562657788046;3071.8003329783714;3328.9334213315597;26579.46841063187;26604.73395266042;26807.195784126314;26855;27419.17742467709;3330.467125259971;3504.4217704078796;3515.9472607910902;3552.6980206682465;3655.872044478457;213119;213632;215214;215851;215954;52191.47808521942;53702.19446708303;56711;57086.714566426905;57152;58064.70967645135;59304.738239397244;59396.7030164855;59420.40579594235;59438.40561594415;13726.65683357924;13728;13760.105593136414;13775.586732398044;13793.655158620913;9762;10098.242631802497;10138.239632027628;10263.640772573073;10286.537105830255;19443.90278048629;19657.311994080137;19666;19775.208991640462;19862;7701.768946931601;7777;7816.53100813953;7868.213178682086;7910.9604451977375;726.7941796647151;786.697121608185;855.149126619018;931.3666706639415;1043.3687618990402;26261.34346641311;26273;26423.339416514358;26505.072322468623;26700.332491687863;900.0954041188694;942.4675058591873;971.3443425687633;1010.4139599032543;1049.333673117576;13756.243406612532;13766.174029558259;14078.507252246121;14168.504102356368;14246.715065698629;251232;255593;255614;256214;256733;45925.54074459212;46357.76821115873;46362.30456543154;46421.07157856824;46434.767826160656;1110.1507346879644;1128.3793913347627;1129.9435028248554;1131.422974283138;1183.331417748969;22687.659685104405;24794.876025619757;25547.23358299254;25680.229593112235;25910.481790364465;36775.632243678294;37185.81407093055;37199.25601487901;37210.62789372072;37234.81382593178;197299;199416;199637;199677;199861;24758.50482990366;25657.871710641328;29078;29374;29445.26386840346;33539.496907545916;33906.49140262849;34187.316253675286;34202.65797341995;34245.143871403416;31267.37465250637;31823;32117.839410803732;32158.51762223615;32477.18807029843;31554.526682099327;31844.52233216457;31989.200269993435;32079.198020049684;32158.196045098124;31846.52230216595;32143.839280803448;32184.678153219105;38805.6119438802;39652.80173599113;28895.56656650194;29422.292433210583;30388.797707179725;30416.39167216599;30417.847910760305;23122.76877231206;23388.883055584614;23593.764062359158;25424.364390890376;27079.59380609332 17:18:33 INFO - PROCESS | 28880 | |2;jquery.html;294.72884945849813;299.1832297826932;302.57790382416516;313.98116113033217;314.8992322456814;14117.435302587885;14618.415263389465;15070.698586028273;15680.529584112466;15685.607859803511;14657.193854338033;15323.463678771217;15817.84182158178;16235.83764162358;16255.674886502264;4948.084604348189;5068.138416469191;5074.061298659742;5078.746062696869;5079.517445842639;5018.874528136789;5045.419776725668;5050.343455350818;5054.292399064134;5055.949440505603;4874.65877388583;5006.849794506153;5012.298278241031;5014.172661510846;5014.749262536859;4996.350474438318;5024.598032157437;5025.773840177201;5047.116754567973;5054.595632349403;4325.589069038437;4402.7578483183415;4415.933760993556;4418.955810441887;4477.306017567283;19067.80932190674;19336.03319834003;19357.322493712654;19588.6493620765;19770.703439448418;1654.3548016273662;1698.5159229619499;1770.8317709817547;1875.5686192175876;1932.0919167991021;8678.088800675965;8762.079981601968;8843.292536597057;9443.763905902339;12594.937025314906;1706.7525208844772;1722.5435259656201;1730.576008877833;1732.9306827726875;1768.6197467544412;41390.37914431286;43992;54217;55816.441835581936;56089.87820243572;8326.916730832736;8925.107489251153;9095.090490950852;9099.044600317004;9224.215941645036;11366.772664546828;11508.884911150948;11510;11524.308541487537;11533.480993355319;6150.846228844225;6218.409251121137;6876.209235937831;7038;7099.432045436352;6872.209695885037;6952.339527744856;6978.092847929838;6997.790066297917;7028.964855175692;3880.825362858678;3959.3269144245546;3970.2456533258587;3972.205558888234;3987.6809855211513;1643.6383995520966;1666.6250093729057;1683.2730975819006;1694.1190580897864;1695.177838748206;820.4420993724325;832.6710949175042;871.333429926107;877.8990416102102;988;14916.552503424915;15394.461193858162;15879.920600396925;16362;16503.422380216874;821.9815697867267;830.4353039932904;836.3476488339105;857.4897935728231;880.6301353431575;8356.456830306011;8363;8541.402101852811;8597.828043439096;8712.433691810013;465081;469780;470376;472454;485489;38007.80996095002;40447.19105617871;64273.35726642767;72939.27060729431;73150;1015.6597539824094;1047.7171163785888;1049.1763965287214;1049.9002594753485;1066.1524088349781;14604.196769177797;14684.118952862862;14871;14887.776683349975;15025.549233523012;32924;33686.45232893528;33743;34213.82893085518;34859.82570087133;34575.73040165322;42269.577304226565;44566.77716611396;46023.079538409715;47056.7647161762;8235.50586964784;8503.617337219715;8713.91286087131;8723.389362744547;8727.432716873383;10075.748106297107;10139.188864890939;11108.722281943015;15666.843331566539;15891.125988070768;13419.731605368033;13550.186988780704;13558.118722283414;13580.981426392862;13621.114627549177;12408.56570020045;12482.313472759086;12848.614541563767;13659.863401366256;13897.583072507841;10666.626668066581;11821.704457388634;12570.120091593866;13327.866721332663;13518.188908665512;8653.653853846028;8694.869576956477;8823.07357727455;8842.15999480074;8862.689805856764;9081.182693557348;9163.22112620408;9191.356605037583;9825.754356141153;14391.78412323795 17:18:33 INFO - PROCESS | 28880 | |3;mootools.html;1398.5314919501966;1428.5857101440583;1467.2370367408948;1573.8268790433058;1724.1637805664259;5936.673482958436;7018.3683468487825;7184.892226616605;7189.317014883578;7206.387457066143;6967.233604303535;7274.454415918814;7285.198628150913;7293.744718934825;7340;1761.779777527809;1801.918913648889;2025.7872923343057;2078.1687325069943;2119.4065661614773;2114.4291041418805;2116.5132019635416;2116.7142435771207;2119.7244358233406;2121.045529511718;2053.425040988526;2056.557840064386;2118.766935637079;2120.812345086749;2121.9151233950624;2115.820155286787;2128.2976617716195;2128.446603882986;2135.5835612055657;2155.622766015941;2121.289368061701;2124.022949443258;2138.369181091566;2138.625740495407;2139.1978008246906;7149.392301654366;7169.641517924083;7216.963915180443;7218.566885986857;7227.602481863495;4305.526392096866;4382.956170438287;4413.183561041217;4416.668749843775;4417.359482874966;2745.546984747514;2795.343094372821;2825.901093461719;2854.9429011419656;2861.184562399706;875.1248751248751;880.9339299552495;902.2331018634175;911.4850109688072;914.5198770645397;9698.175655069257;9892.55483503244;9909;9909.554070066864;9910.355826871302;4116.217918595457;4130.772807495617;4177.060161463646;4182.707210495297;4198.265303571924;8710.825783484295;8718.91281087181;8722.215000649972;8735.257503112307;8737;4297.720648157922;4307.6769242306955;4309.332053531708;4317.978410107929;4320.524742278347;3904.0630248740667;3905.160390515996;3907.081835768592;3911.706622003361;3913.5890731472787;3085.3212293295437;3099.612548431446;3149.4960806270888;3166.920826979298;3407.0800883761244;1123.8819923907872;1124.966251012471;1127.3686735428187;1150.976980460403;1156.612534800851;853.2363534636589;933.3233405780754;1098.4892025208317;1153.117864833403;1154.509333533245;6419.550631455847;6535.150430444107;6578.76974305897;6592;6604.438622717027;550.6118186678463;563.6280055163572;569.3225062175998;576.7145263094711;712.989305160423;5147.974260128675;5208.322918020633;5221.660592061504;5225.738713064332;5230.215467679878;8317.667293308321;8706.347023973227;8785.604647790737;8807.07525709804;8830.072842351588;8613.397062205711;8666;8680.392372533988;8700.477971321741;8708.216260536583;6725.596464212065;6741.460683145337;6867.107276054081;6873.862522749517;6924;6348.3651634838;6396.648184349905;6400.97584386496;6427.710753016032;6433.678316084083;7645.273698998586;7741.922580774345;7802.063752349527;7814.492058016211;7824.413169012233;7800.6099695016155;8075.798105047185;8086.272235498834;8092.959535202286;8106.513609183467;5816.76732930678;6284.4344009039405;6388.87222255543;6436.485081193587;6450.193725784277;5782.335031471434;5954.821355359173;6473.643949582818;6665.100211471583;6781.660916954034;6422.518311126591;6601.108850305147;6652.866942661023;6766.594004359754;6775.661216939232;6443.871122577429;6489.967550162408;6559.212894452697;6578.638174900427;6675.299093595297;6263.561550691408;6344.1118243445035;6357.1735674362035;6357.919153743782;6369.9363006371195;5963.224780778471;5997.970010149921;5998.220231369894;6010.54920880927;6013.368596297326;5957;5958.374370691015;5962.373950735284;5964.671943043;5967.045272756338 17:18:33 INFO - PROCESS | 28880 | |4;prototype.html;290.78191356482637;291.04682165906655;291.2790842664406;291.4506155896136;300.6527460782797;5221.634485586011;5342.412334643191;5364.383095943967;5410.729463526823;5413.485718856712;5093.312402825617;5148.279240906276;5191.377034755825;5316.787328506855;5330.893382132355;4126.339785634292;4134.875953721393;4136.048708796979;4146.66826653867;4151.418801367811;3911.7261791674596;4124.319487284594;4153.376993450991;4155.293600087993;4166.062635906927;3964.583718709537;4008.1582867597695;4103.753774773523;4117.423560701504;4129.855455059073;4094.9181016379653;4097.610726980932;4106.67146628269;4114.855980040684;4117.382392641098;3605.7475976681644;3609.476625889258;3613.1509095362567;3616.72874534411;3618.6019537850816;5153.943441594464;5155.40712818027;5166.638335316529;5168.457311982225;5170.663906846043;4526.615237704799;4661.463931647836;4665.510121437234;4666.786635474767;4750.097481478508;5577.525910297589;5611.551075913958;5612.747426365823;5618.15727640853;5620.690862002588;3784.6972242220554;3788.2234142000825;3788.905277368088;3791.241751649681;3793.1275806564645;5826.679532625704;5889.852753681193;5921.082232254007;5923.614965027259;5924.822255332347;3868.8259028343227;3957.1689945111275;3958.891510377099;3971.0469487322835;3976.940345894814;4001.7598944063448;4001.959980400217;4004.0790618157403;4006.0385507477995;4010.3984402339297;4647.883802904955;4648.790804413809;4656.464506581787;4656.557627025427;4660.207764680013;5618.2415373924;5621.100623900156;5629.887402251932;5632.549396048306;5632.662040277596;1365.8253901644578;1385.49429458247;1401;1401.0682895874334;1420.254366457618;922.8385032619265;926.3098991251561;933.3233405780891;936.5504557812288;936.5879013234155;4801.735904525284;4924.852254432372;4931.654784165074;4933.136701077297;4934.679245849008;5761.88476230473;5768.3366412862215;5780.306363236438;5792.913106303409;5800.50695690871;4803.495632958559;4853.490383509751;4926.9014619707405;4949.57928576075;4976.601871850244;3133.2010337363827;3163.620365556148;3173.6826317368077;3174.238182836149;3175.4601717707583;5585.8603534911135;5590.664560126324;5592.916106258409;5595.677793715644;5597.580181486404;5909.379515150933;6009.429104235178;6042.214512113397;6043.486303664238;6052.636841789506;5588.608797384144;5591.8881622368135;5601.719914004283;5611.3266408031295;5611.765411609439;5877.382874798084;5914.940850591611;5920.200772895604;5926.407359264039;5929;5783.566232532493;5784.855378615568;5794.5364370851075;5796.42035796417;5798;5461.918071228855;5615.859603509782;5617.775288988395;5621.79131486716;5624.634398764068;3967.980160099181;3997.120633460634;4017.397390391348;4019.5578486367062;4021.215862906822;5894.0274854650215;5900.822975310747;5907.3501914790195;5909.995300798789;5911.556633252438;5577.0797818359515;5613.961417137843;5697.829065128053;5699.914501282401;5702.857428564319;5653.575981801299;5654.180143879197;5670.09278515452;5672.7730890763905;5675.858103547444;5535;5552.7223638818705;5555.72221388937;5561.833145005495;5562.2490963721;5709.0865461525955;5710.5146062585145;5714.685692286798;5717.113847353667;5721.141828725558;5419.105847535113;5508.283923089973;5550.52820510245;5582.720863956704;5591.552675785846 17:18:33 INFO - PROCESS | 28880 | |5;yui.html;751.1286907187662;784.6704384158653;787.1027029186728;800.7077416742891;817.9345652347813;12368.938155309233;12560.999999999989;12578.559750408738;12579.748405031894;12602.432890519925;13563.254021028839;13641.386137623806;13664.180149191056;13689.17864928105;13700.451981920736;651.4234902111618;658.9703463344161;807.6284908941893;823.8105235795771;824.2293455618985;808.7331180710352;817.5217497763815;823.8805373220879;824.2746383182791;824.6660102658433;854.5940678177878;859.8280343931208;859.9828003439927;860.4794099569764;860.9913900861005;675.3584095109641;680.1328306409367;838.3209600223777;851.0255757158051;856.3705676327894;625.527726566444;625.6308777821107;626.1109224900606;626.4831514000967;629.1129507394597;11698.94150529242;11723.472443739967;11723.531058757639;11736.941315293454;11744.706382340424;10376.377417354983;10757.462126893624;10788.46057697112;10793.946030269877;10958.123350131971;8611.61247743853;8907.242884354837;8991.730248092503;8994.325425593106;9200.32680389777;3081.938361232785;3110.7666924980717;3140.764442666786;3158.5104308831937;3175.5712978747806;39379;40251.19497610031;40458.79770601157;40616.39075413871;40754.59245407538;8881.40471502949;8914.598843052077;8983.550822458981;9005.729828105168;9029.729108126767;15263.084214946917;15328.386864525517;15352.616184595252;15366.692666146615;15367.462138825087;6202.782902598387;6281.089242059876;6300.495960323255;6309.842253943596;6559.278479367265;3573.7855728656364;3613.4941108244866;3634.436662317345;3683.4474828775897;3704.370257056307;2663.6537250157744;2675.39803544201;2693.905713300025;2701.405690748032;2702.878370473294;465.92545192768995;466.5357968821045;470.5553252176729;485.5629933060274;485.82510296293304;398.63325740318976;426.2561829607355;480.00623131821266;519.4675457655933;532.521871434001;6803.319668033256;7044.295570442915;7044.6125463099;7112.608806515588;7173.3185347392955;438.01009718037466;514.0361821584529;523.8742701751628;532.8508017755034;545.3265217456438;3176.682331766851;3406.4549672052353;3434.261633748756;3503.982480087583;3695.1685870678884;46939.06121877543;47391;47418.76290618594;47432;47434;42855.57144428516;42982.78508607437;43273.56726432696;43620;43640.3453948191;38943.22113557713;40353;40496.98757531026;40938.701436348754;40945.38581921274;6911.343422374866;7171.713131474683;7199.640017998974;7205.586342287758;7317;30465.54301685432;30841.537376938915;31178.220544485663;31238.687613124486;31309.373812523165;38388;38966.41550376803;39271;39420.60579394169;39517.80241098776;9300.708677450017;9602.375845570015;9609;9634.470104144339;9804.480020786097;10508.474576271308;10633.361998280128;10653.9467302663;10661.89338106609;10891.0198082173;10102.09081182697;10289.536970836181;10318.742031449274;10483.213758967955;10754.677359679223;9923.950380248052;9933.155681766842;10007.699769006942;10023.148032417326;10024.097831195228;9790.951045244728;9891.950540247253;10006.649767258112;10091.495425228855;10248.282620216512;7753.806154846174;8075.232852878967;8199.71301004462;8453.535055571756;8694.608862581956;7976.401769867167;8149.79625509367;8410.747677569683;8522.78693032679;8698.956505217433 17:18:33 INFO - PROCESS | 28880 | __end_tp_report 17:18:33 INFO - PROCESS | 28880 | __start_cc_report 17:18:33 INFO - PROCESS | 28880 | _x_x_mozilla_cycle_collect,1002 17:18:33 INFO - PROCESS | 28880 | __end_cc_report 17:18:33 INFO - PROCESS | 28880 | __startTimestamp1450747113966__endTimestamp 17:18:33 INFO - PROCESS | 28880 | 17:18:33 INFO - PROCESS | 28880 | ------- Summary: start ------- 17:18:33 INFO - PROCESS | 28880 | Number of tests: 6 17:18:33 INFO - PROCESS | 28880 | 17:18:33 INFO - PROCESS | 28880 | [#0] dojo.html Cycles:165 Average:4608.93 Median:4788.47 stddev:482.79 (10.1%) stddev-sans-first:458.24 17:18:33 INFO - PROCESS | 28880 | Values: 2615.3 2683.6 2683.9 2698.8 2712.1 4503.6 4608.8 4667.0 4673.3 4677.3 4569.7 4574.9 4676.3 4679.8 4690.9 4273.0 4329.6 4333.2 4351.9 4376.3 4051.9 4332.0 4348.4 4407.6 4436.0 4119.2 4231.7 4237.3 4333.4 4392.6 4213.6 4315.0 4317.8 4322.9 4331.6 4271.2 4271.6 4277.0 4305.9 4325.0 4429.8 4544.4 4605.4 4606.4 4624.4 4864.9 4881.1 4998.5 5011.8 5032.5 5045.8 5050.3 5061.7 5063.2 5099.5 4689.8 4690.0 4691.9 4693.1 4708.0 4972.2 5023.7 5062.6 5100.9 5173.1 4905.4 4910.2 4911.1 4927.0 4972.4 4981.0 4989.8 4991.9 5000.2 5019.6 4803.6 4886.7 4921.3 4932.3 4989.6 4919.3 4934.3 4937.7 4940.3 4984.8 4151.8 4158.9 4160.9 4168.5 4198.5 3505.9 3578.3 3649.2 3652.9 3678.7 4340.2 4342.2 4345.7 4352.7 4390.5 5023.5 5028.2 5034.2 5040.6 5075.5 4098.9 4207.1 4207.3 4218.3 4332.7 4463.7 4477.1 4488.2 4507.9 4519.7 4815.6 4817.5 4820.1 4823.1 4868.0 4850.1 4865.4 4971.6 4986.1 5058.3 4786.6 4812.8 4828.3 4863.5 4866.7 4960.9 4961.1 4965.5 4972.1 4985.8 4850.3 4980.6 5065.0 5082.1 5129.8 4752.4 4777.1 4844.2 4852.3 4901.0 4789.6 4796.3 4798.5 4802.6 4846.2 4563.4 4674.3 4783.4 4788.5 4802.0 4817.5 4845.1 4886.0 4931.3 4938.2 4783.7 4810.3 4817.3 4818.1 4865.9 17:18:33 INFO - PROCESS | 28880 | 17:18:33 INFO - PROCESS | 28880 | [#1] ext.html Cycles:180 Average:38677.79 Median:31410.95 stddev:58220.16 (185.3%) stddev-sans-first:58312.94 17:18:33 INFO - PROCESS | 28880 | Values: 508.3 517.4 517.5 533.8 537.7 27244.0 34689.5 35478.6 35482.0 35526.6 40298.6 40855.0 40856.2 40877.8 40949.6 6965.5 7078.8 7863.6 8029.8 8033.8 10059.6 10305.0 10305.7 10312.7 10320.3 9909.0 10009.6 10016.1 10019.5 10020.2 7158.3 7354.4 10026.5 10072.7 10291.0 9744.5 9861.6 9862.9 9864.7 9867.6 30061.2 37011.8 37522.6 37578.4 37624.2 2367.0 2782.7 2821.6 3071.8 3328.9 26579.5 26604.7 26807.2 26855.0 27419.2 3330.5 3504.4 3515.9 3552.7 3655.9 213119.0 213632.0 215214.0 215851.0 215954.0 52191.5 53702.2 56711.0 57086.7 57152.0 58064.7 59304.7 59396.7 59420.4 59438.4 13726.7 13728.0 13760.1 13775.6 13793.7 9762.0 10098.2 10138.2 10263.6 10286.5 19443.9 19657.3 19666.0 19775.2 19862.0 7701.8 7777.0 7816.5 7868.2 7911.0 726.8 786.7 855.1 931.4 1043.4 26261.3 26273.0 26423.3 26505.1 26700.3 900.1 942.5 971.3 1010.4 1049.3 13756.2 13766.2 14078.5 14168.5 14246.7 251232.0 255593.0 255614.0 256214.0 256733.0 45925.5 46357.8 46362.3 46421.1 46434.8 1110.2 1128.4 1129.9 1131.4 1183.3 22687.7 24794.9 25547.2 25680.2 25910.5 36775.6 37185.8 37199.3 37210.6 37234.8 197299.0 199416.0 199637.0 199677.0 199861.0 24758.5 25657.9 29078.0 29374.0 29445.3 33539.5 33906.5 34187.3 34202.7 34245.1 31267.4 31823.0 32117.8 32158.5 32477.2 31554.5 31844.5 31989.2 32079.2 32158.2 31846.5 32143.8 32184.7 38805.6 39652.8 28895.6 29422.3 30388.8 30416.4 30417.8 23122.8 23388.9 23593.8 25424.4 27079.6 17:18:33 INFO - PROCESS | 28880 | 17:18:33 INFO - PROCESS | 28880 | [#2] jquery.html Cycles:180 Average:25179.46 Median:41829.98 stddev:77069.01 (184.2%) stddev-sans-first:77262.55 17:18:33 INFO - PROCESS | 28880 | Values: 294.7 299.2 302.6 314.0 314.9 14117.4 14618.4 15070.7 15680.5 15685.6 14657.2 15323.5 15817.8 16235.8 16255.7 4948.1 5068.1 5074.1 5078.7 5079.5 5018.9 5045.4 5050.3 5054.3 5055.9 4874.7 5006.8 5012.3 5014.2 5014.7 4996.4 5024.6 5025.8 5047.1 5054.6 4325.6 4402.8 4415.9 4419.0 4477.3 19067.8 19336.0 19357.3 19588.6 19770.7 1654.4 1698.5 1770.8 1875.6 1932.1 8678.1 8762.1 8843.3 9443.8 12594.9 1706.8 1722.5 1730.6 1732.9 1768.6 41390.4 43992.0 54217.0 55816.4 56089.9 8326.9 8925.1 9095.1 9099.0 9224.2 11366.8 11508.9 11510.0 11524.3 11533.5 6150.8 6218.4 6876.2 7038.0 7099.4 6872.2 6952.3 6978.1 6997.8 7029.0 3880.8 3959.3 3970.2 3972.2 3987.7 1643.6 1666.6 1683.3 1694.1 1695.2 820.4 832.7 871.3 877.9 988.0 14916.6 15394.5 15879.9 16362.0 16503.4 822.0 830.4 836.3 857.5 880.6 8356.5 8363.0 8541.4 8597.8 8712.4 465081.0 469780.0 470376.0 472454.0 485489.0 38007.8 40447.2 64273.4 72939.3 73150.0 1015.7 1047.7 1049.2 1049.9 1066.2 14604.2 14684.1 14871.0 14887.8 15025.5 32924.0 33686.5 33743.0 34213.8 34859.8 34575.7 42269.6 44566.8 46023.1 47056.8 8235.5 8503.6 8713.9 8723.4 8727.4 10075.7 10139.2 11108.7 15666.8 15891.1 13419.7 13550.2 13558.1 13581.0 13621.1 12408.6 12482.3 12848.6 13659.9 13897.6 10666.6 11821.7 12570.1 13327.9 13518.2 8653.7 8694.9 8823.1 8842.2 8862.7 9081.2 9163.2 9191.4 9825.8 14391.8 17:18:33 INFO - PROCESS | 28880 | 17:18:33 INFO - PROCESS | 28880 | [#3] mootools.html Cycles:180 Average:5015.23 Median:6138.47 stddev:2630.74 (42.9%) stddev-sans-first:2624.07 17:18:33 INFO - PROCESS | 28880 | Values: 1398.5 1428.6 1467.2 1573.8 1724.2 5936.7 7018.4 7184.9 7189.3 7206.4 6967.2 7274.5 7285.2 7293.7 7340.0 1761.8 1801.9 2025.8 2078.2 2119.4 2114.4 2116.5 2116.7 2119.7 2121.0 2053.4 2056.6 2118.8 2120.8 2121.9 2115.8 2128.3 2128.4 2135.6 2155.6 2121.3 2124.0 2138.4 2138.6 2139.2 7149.4 7169.6 7217.0 7218.6 7227.6 4305.5 4383.0 4413.2 4416.7 4417.4 2745.5 2795.3 2825.9 2854.9 2861.2 875.1 880.9 902.2 911.5 914.5 9698.2 9892.6 9909.0 9909.6 9910.4 4116.2 4130.8 4177.1 4182.7 4198.3 8710.8 8718.9 8722.2 8735.3 8737.0 4297.7 4307.7 4309.3 4318.0 4320.5 3904.1 3905.2 3907.1 3911.7 3913.6 3085.3 3099.6 3149.5 3166.9 3407.1 1123.9 1125.0 1127.4 1151.0 1156.6 853.2 933.3 1098.5 1153.1 1154.5 6419.6 6535.2 6578.8 6592.0 6604.4 550.6 563.6 569.3 576.7 713.0 5148.0 5208.3 5221.7 5225.7 5230.2 8317.7 8706.3 8785.6 8807.1 8830.1 8613.4 8666.0 8680.4 8700.5 8708.2 6725.6 6741.5 6867.1 6873.9 6924.0 6348.4 6396.6 6401.0 6427.7 6433.7 7645.3 7741.9 7802.1 7814.5 7824.4 7800.6 8075.8 8086.3 8093.0 8106.5 5816.8 6284.4 6388.9 6436.5 6450.2 5782.3 5954.8 6473.6 6665.1 6781.7 6422.5 6601.1 6652.9 6766.6 6775.7 6443.9 6490.0 6559.2 6578.6 6675.3 6263.6 6344.1 6357.2 6357.9 6369.9 5963.2 5998.0 5998.2 6010.5 6013.4 5957.0 5958.4 5962.4 5964.7 5967.0 17:18:33 INFO - PROCESS | 28880 | 17:18:33 INFO - PROCESS | 28880 | [#4] prototype.html Cycles:180 Average:4662.13 Median:5336.65 stddev:1395.30 (26.1%) stddev-sans-first:1360.09 17:18:33 INFO - PROCESS | 28880 | Values: 290.8 291.0 291.3 291.5 300.7 5221.6 5342.4 5364.4 5410.7 5413.5 5093.3 5148.3 5191.4 5316.8 5330.9 4126.3 4134.9 4136.0 4146.7 4151.4 3911.7 4124.3 4153.4 4155.3 4166.1 3964.6 4008.2 4103.8 4117.4 4129.9 4094.9 4097.6 4106.7 4114.9 4117.4 3605.7 3609.5 3613.2 3616.7 3618.6 5153.9 5155.4 5166.6 5168.5 5170.7 4526.6 4661.5 4665.5 4666.8 4750.1 5577.5 5611.6 5612.7 5618.2 5620.7 3784.7 3788.2 3788.9 3791.2 3793.1 5826.7 5889.9 5921.1 5923.6 5924.8 3868.8 3957.2 3958.9 3971.0 3976.9 4001.8 4002.0 4004.1 4006.0 4010.4 4647.9 4648.8 4656.5 4656.6 4660.2 5618.2 5621.1 5629.9 5632.5 5632.7 1365.8 1385.5 1401.0 1401.1 1420.3 922.8 926.3 933.3 936.6 936.6 4801.7 4924.9 4931.7 4933.1 4934.7 5761.9 5768.3 5780.3 5792.9 5800.5 4803.5 4853.5 4926.9 4949.6 4976.6 3133.2 3163.6 3173.7 3174.2 3175.5 5585.9 5590.7 5592.9 5595.7 5597.6 5909.4 6009.4 6042.2 6043.5 6052.6 5588.6 5591.9 5601.7 5611.3 5611.8 5877.4 5914.9 5920.2 5926.4 5929.0 5783.6 5784.9 5794.5 5796.4 5798.0 5461.9 5615.9 5617.8 5621.8 5624.6 3968.0 3997.1 4017.4 4019.6 4021.2 5894.0 5900.8 5907.4 5910.0 5911.6 5577.1 5614.0 5697.8 5699.9 5702.9 5653.6 5654.2 5670.1 5672.8 5675.9 5535.0 5552.7 5555.7 5561.8 5562.2 5709.1 5710.5 5714.7 5717.1 5721.1 5419.1 5508.3 5550.5 5582.7 5591.6 17:18:33 INFO - PROCESS | 28880 | 17:18:33 INFO - PROCESS | 28880 | [#5] yui.html Cycles:180 Average:11943.81 Median:23702.80 stddev:13526.34 (57.1%) stddev-sans-first:13538.17 17:18:33 INFO - PROCESS | 28880 | Values: 751.1 784.7 787.1 800.7 817.9 12368.9 12561.0 12578.6 12579.7 12602.4 13563.3 13641.4 13664.2 13689.2 13700.5 651.4 659.0 807.6 823.8 824.2 808.7 817.5 823.9 824.3 824.7 854.6 859.8 860.0 860.5 861.0 675.4 680.1 838.3 851.0 856.4 625.5 625.6 626.1 626.5 629.1 11698.9 11723.5 11723.5 11736.9 11744.7 10376.4 10757.5 10788.5 10793.9 10958.1 8611.6 8907.2 8991.7 8994.3 9200.3 3081.9 3110.8 3140.8 3158.5 3175.6 39379.0 40251.2 40458.8 40616.4 40754.6 8881.4 8914.6 8983.6 9005.7 9029.7 15263.1 15328.4 15352.6 15366.7 15367.5 6202.8 6281.1 6300.5 6309.8 6559.3 3573.8 3613.5 3634.4 3683.4 3704.4 2663.7 2675.4 2693.9 2701.4 2702.9 465.9 466.5 470.6 485.6 485.8 398.6 426.3 480.0 519.5 532.5 6803.3 7044.3 7044.6 7112.6 7173.3 438.0 514.0 523.9 532.9 545.3 3176.7 3406.5 3434.3 3504.0 3695.2 46939.1 47391.0 47418.8 47432.0 47434.0 42855.6 42982.8 43273.6 43620.0 43640.3 38943.2 40353.0 40497.0 40938.7 40945.4 6911.3 7171.7 7199.6 7205.6 7317.0 30465.5 30841.5 31178.2 31238.7 31309.4 38388.0 38966.4 39271.0 39420.6 39517.8 9300.7 9602.4 9609.0 9634.5 9804.5 10508.5 10633.4 10653.9 10661.9 10891.0 10102.1 10289.5 10318.7 10483.2 10754.7 9924.0 9933.2 10007.7 10023.1 10024.1 9791.0 9892.0 10006.6 10091.5 10248.3 7753.8 8075.2 8199.7 8453.5 8694.6 7976.4 8149.8 8410.7 8522.8 8699.0 17:18:33 INFO - PROCESS | 28880 | -------- Summary: end -------- 17:18:33 INFO - PROCESS | 28880 | 17:18:35 INFO - TEST-INFO | 28880: exit 0 17:18:35 INFO - TEST-OK | dromaeo_css | took 1197993ms 17:18:35 INFO - TEST-START | kraken 17:18:35 INFO - operating with platform_type : linux_ 17:18:35 INFO - Initialising browser for kraken test... 17:18:35 INFO - TEST-INFO | started process 29074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuf0xWx/profile http://localhost:60982/getInfo.html) 17:18:49 INFO - PROCESS | 29074 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 17:18:49 INFO - PROCESS | 29074 | __metrics Screen width/height:1600/1200 17:18:49 INFO - PROCESS | 29074 | colorDepth:24 17:18:49 INFO - PROCESS | 29074 | Browser inner width/height: 1024/697 17:18:49 INFO - PROCESS | 29074 | __metrics 17:18:49 INFO - PROCESS | 29074 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:18:49 INFO - PROCESS | 29074 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:18:49 ERROR - PROCESS | 29074 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 17:18:55 INFO - TEST-INFO | 29074: exit 0 17:18:55 INFO - Browser initialized. 17:18:55 INFO - Running cycle 1/1 for kraken test... 17:18:55 INFO - TEST-INFO | started process 29155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuf0xWx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:06 INFO - PROCESS | 29155 | RSS: Main: 150216704 17:19:06 INFO - PROCESS | 29155 | 17:19:09 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60982/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:10 INFO - PROCESS | 29155 | RSS: Main: 184172544 17:19:10 INFO - PROCESS | 29155 | 17:19:12 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60982/tests/kraken/driver.html?testName=audio-dft) 17:19:13 INFO - PROCESS | 29155 | RSS: Main: 172322816 17:19:13 INFO - PROCESS | 29155 | 17:19:16 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60982/tests/kraken/driver.html?testName=audio-fft) 17:19:17 INFO - PROCESS | 29155 | RSS: Main: 161570816 17:19:17 INFO - PROCESS | 29155 | 17:19:19 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60982/tests/kraken/driver.html?testName=audio-oscillator) 17:19:19 INFO - PROCESS | 29155 | RSS: Main: 162426880 17:19:19 INFO - PROCESS | 29155 | 17:19:21 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60982/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:22 INFO - PROCESS | 29155 | RSS: Main: 163827712 17:19:22 INFO - PROCESS | 29155 | 17:19:25 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60982/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:26 INFO - PROCESS | 29155 | RSS: Main: 165408768 17:19:26 INFO - PROCESS | 29155 | 17:19:29 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60982/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:30 INFO - PROCESS | 29155 | RSS: Main: 165060608 17:19:30 INFO - PROCESS | 29155 | 17:19:32 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60982/tests/kraken/driver.html?testName=json-parse-financial) 17:19:33 INFO - PROCESS | 29155 | RSS: Main: 164667392 17:19:33 INFO - PROCESS | 29155 | 17:19:35 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60982/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:19:35 INFO - PROCESS | 29155 | RSS: Main: 173023232 17:19:35 INFO - PROCESS | 29155 | 17:19:37 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60982/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:19:38 INFO - PROCESS | 29155 | RSS: Main: 172605440 17:19:38 INFO - PROCESS | 29155 | 17:19:40 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60982/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:19:40 INFO - PROCESS | 29155 | RSS: Main: 184098816 17:19:40 INFO - PROCESS | 29155 | 17:19:43 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60982/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:19:44 INFO - PROCESS | 29155 | RSS: Main: 191692800 17:19:44 INFO - PROCESS | 29155 | 17:19:46 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60982/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:19:47 INFO - PROCESS | 29155 | RSS: Main: 188297216 17:19:47 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | Cycle 1(1): loaded http://localhost:60982/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60982/tests/kraken/driver.html?testName=ai-astar) 17:19:49 INFO - PROCESS | 29155 | RSS: Main: 246120448 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | __start_tp_report 17:19:49 INFO - PROCESS | 29155 | _x_x_mozilla_page_load 17:19:49 INFO - PROCESS | 29155 | _x_x_mozilla_page_load_details 17:19:49 INFO - PROCESS | 29155 | |i|pagename|runs| 17:19:49 INFO - PROCESS | 29155 | |0;ai-astar;111;113;105;110;111;111;100;110;111;111 17:19:49 INFO - PROCESS | 29155 | |1;audio-beat-detection;154;129;152;168;131;153;157;138;173;137 17:19:49 INFO - PROCESS | 29155 | |2;audio-dft;161;162;160;160;161;161;162;161;161;163 17:19:49 INFO - PROCESS | 29155 | |3;audio-fft;73;72;84;89;71;72;73;95;90;71 17:19:49 INFO - PROCESS | 29155 | |4;audio-oscillator;94;95;138;94;94;95;130;94;94;132 17:19:49 INFO - PROCESS | 29155 | |5;imaging-gaussian-blur;110;109;109;110;109;109;109;109;110;109 17:19:49 INFO - PROCESS | 29155 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;147 17:19:49 INFO - PROCESS | 29155 | |7;imaging-desaturate;96;95;95;95;96;96;95;95;95;95 17:19:49 INFO - PROCESS | 29155 | |8;json-parse-financial;73;72;70;70;70;70;71;79;68;68 17:19:49 INFO - PROCESS | 29155 | |9;json-stringify-tinderbox;67;68;68;68;68;68;68;68;68;67 17:19:49 INFO - PROCESS | 29155 | |10;stanford-crypto-aes;81;90;83;81;81;81;82;83;83;84 17:19:49 INFO - PROCESS | 29155 | |11;stanford-crypto-ccm;120;127;119;125;127;119;121;123;121;119 17:19:49 INFO - PROCESS | 29155 | |12;stanford-crypto-pbkdf2;135;145;164;145;148;134;142;144;144;134 17:19:49 INFO - PROCESS | 29155 | |13;stanford-crypto-sha256-iterative;68;69;68;68;67;69;68;67;69;74 17:19:49 INFO - PROCESS | 29155 | __end_tp_report 17:19:49 INFO - PROCESS | 29155 | __start_cc_report 17:19:49 INFO - PROCESS | 29155 | _x_x_mozilla_cycle_collect,991 17:19:49 INFO - PROCESS | 29155 | __end_cc_report 17:19:49 INFO - PROCESS | 29155 | __startTimestamp1450747189276__endTimestamp 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | ------- Summary: start ------- 17:19:49 INFO - PROCESS | 29155 | Number of tests: 14 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.86 (3.5%) stddev-sans-first:4.04 17:19:49 INFO - PROCESS | 29155 | Values: 111.0 113.0 105.0 110.0 111.0 111.0 100.0 110.0 111.0 111.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:153.50 stddev:15.05 (9.8%) stddev-sans-first:15.87 17:19:49 INFO - PROCESS | 29155 | Values: 154.0 129.0 152.0 168.0 131.0 153.0 157.0 138.0 173.0 137.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 17:19:49 INFO - PROCESS | 29155 | Values: 161.0 162.0 160.0 160.0 161.0 161.0 162.0 161.0 161.0 163.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#3] audio-fft Cycles:10 Average:79.00 Median:78.50 stddev:9.43 (12.0%) stddev-sans-first:9.75 17:19:49 INFO - PROCESS | 29155 | Values: 73.0 72.0 84.0 89.0 71.0 72.0 73.0 95.0 90.0 71.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.00 stddev:18.97 (20.2%) stddev-sans-first:19.62 17:19:49 INFO - PROCESS | 29155 | Values: 94.0 95.0 138.0 94.0 94.0 95.0 130.0 94.0 94.0 132.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:19:49 INFO - PROCESS | 29155 | Values: 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 17:19:49 INFO - PROCESS | 29155 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:19:49 INFO - PROCESS | 29155 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#8] json-parse-financial Cycles:10 Average:71.10 Median:70.50 stddev:3.18 (4.5%) stddev-sans-first:3.30 17:19:49 INFO - PROCESS | 29155 | Values: 73.0 72.0 70.0 70.0 70.0 70.0 71.0 79.0 68.0 68.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 17:19:49 INFO - PROCESS | 29155 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 67.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:2.73 (3.3%) stddev-sans-first:2.80 17:19:49 INFO - PROCESS | 29155 | Values: 81.0 90.0 83.0 81.0 81.0 81.0 82.0 83.0 83.0 84.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:122.00 stddev:3.21 (2.6%) stddev-sans-first:3.32 17:19:49 INFO - PROCESS | 29155 | Values: 120.0 127.0 119.0 125.0 127.0 119.0 121.0 123.0 121.0 119.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:144.50 stddev:8.82 (6.1%) stddev-sans-first:8.80 17:19:49 INFO - PROCESS | 29155 | Values: 135.0 145.0 164.0 145.0 148.0 134.0 142.0 144.0 144.0 134.0 17:19:49 INFO - PROCESS | 29155 | 17:19:49 INFO - PROCESS | 29155 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:2.00 (2.9%) stddev-sans-first:2.11 17:19:49 INFO - PROCESS | 29155 | Values: 68.0 69.0 68.0 68.0 67.0 69.0 68.0 67.0 69.0 74.0 17:19:49 INFO - PROCESS | 29155 | -------- Summary: end -------- 17:19:49 INFO - PROCESS | 29155 | 17:19:52 INFO - TEST-INFO | 29155: exit 0 17:19:52 INFO - TEST-OK | kraken | took 77538ms 17:19:52 INFO - TEST-START | v8_7 17:19:52 INFO - operating with platform_type : linux_ 17:19:52 INFO - Initialising browser for v8_7 test... 17:19:52 INFO - TEST-INFO | started process 29405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBaQaUj/profile http://localhost:60982/getInfo.html) 17:20:06 INFO - PROCESS | 29405 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 17:20:06 INFO - PROCESS | 29405 | __metrics Screen width/height:1600/1200 17:20:06 INFO - PROCESS | 29405 | colorDepth:24 17:20:06 INFO - PROCESS | 29405 | Browser inner width/height: 1024/697 17:20:06 INFO - PROCESS | 29405 | __metrics 17:20:07 INFO - PROCESS | 29405 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:20:07 INFO - PROCESS | 29405 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:20:12 INFO - TEST-INFO | 29405: exit 0 17:20:12 INFO - Browser initialized. 17:20:12 INFO - Running cycle 1/1 for v8_7 test... 17:20:12 INFO - TEST-INFO | started process 29487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBaQaUj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:20:24 INFO - PROCESS | 29487 | RSS: Main: 150032384 17:20:24 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | Cycle 1(1): loaded http://localhost:60982/tests/v8_7/run.html (next: http://localhost:60982/tests/v8_7/run.html) 17:20:46 INFO - PROCESS | 29487 | RSS: Main: 446447616 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | __start_tp_report 17:20:46 INFO - PROCESS | 29487 | _x_x_mozilla_page_load 17:20:46 INFO - PROCESS | 29487 | _x_x_mozilla_page_load_details 17:20:46 INFO - PROCESS | 29487 | |i|pagename|runs| 17:20:46 INFO - PROCESS | 29487 | |0;Richards;165.78249336870027 17:20:46 INFO - PROCESS | 29487 | |1;DeltaBlue;186.28912071535024 17:20:46 INFO - PROCESS | 29487 | |2;Encrypt;278.31895352073474 17:20:46 INFO - PROCESS | 29487 | |3;Decrypt;5133.333333333333 17:20:46 INFO - PROCESS | 29487 | |4;RayTrace;1982.1782178217823 17:20:46 INFO - PROCESS | 29487 | |5;Earley;789.8894154818325 17:20:46 INFO - PROCESS | 29487 | |6;Boyer;12219.512195121952 17:20:46 INFO - PROCESS | 29487 | |7;RegExp;27027.027027027027 17:20:46 INFO - PROCESS | 29487 | |8;Splay;593.3609958506224 17:20:46 INFO - PROCESS | 29487 | |9;NavierStokes;4868.9320388349515 17:20:46 INFO - PROCESS | 29487 | __end_tp_report 17:20:46 INFO - PROCESS | 29487 | __startTimestamp1450747246693__endTimestamp 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | ------- Summary: start ------- 17:20:46 INFO - PROCESS | 29487 | Number of tests: 10 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 17:20:46 INFO - PROCESS | 29487 | Values: 165.8 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | [#1] DeltaBlue Cycles:1 Average:186.29 Median:186.29 stddev:0.00 (0.0%) 17:20:46 INFO - PROCESS | 29487 | Values: 186.3 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 17:20:46 INFO - PROCESS | 29487 | Values: 278.3 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 17:20:46 INFO - PROCESS | 29487 | Values: 5133.3 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | [#4] RayTrace Cycles:1 Average:1982.18 Median:1982.18 stddev:0.00 (0.0%) 17:20:46 INFO - PROCESS | 29487 | Values: 1982.2 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 17:20:46 INFO - PROCESS | 29487 | Values: 789.9 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 17:20:46 INFO - PROCESS | 29487 | Values: 12219.5 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 17:20:46 INFO - PROCESS | 29487 | Values: 27027.0 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | [#8] Splay Cycles:1 Average:593.36 Median:593.36 stddev:0.00 (0.0%) 17:20:46 INFO - PROCESS | 29487 | Values: 593.4 17:20:46 INFO - PROCESS | 29487 | 17:20:46 INFO - PROCESS | 29487 | [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 17:20:46 INFO - PROCESS | 29487 | Values: 4868.9 17:20:46 INFO - PROCESS | 29487 | -------- Summary: end -------- 17:20:46 INFO - PROCESS | 29487 | 17:20:48 INFO - TEST-INFO | 29487: exit 0 17:20:48 INFO - TEST-OK | v8_7 | took 55248ms 17:20:48 INFO - SUITE-END | took 1330s 17:20:48 INFO - Completed test suite (00:22:11) 17:20:48 INFO - Working with test: dromaeo_css 17:20:48 INFO - Generating results file: dromaeo_css 17:20:48 INFO - Working with test: kraken 17:20:48 INFO - Generating results file: kraken 17:20:48 INFO - javascript benchmark 17:20:48 INFO - Working with test: v8_7 17:20:48 INFO - Generating results file: v8_7 17:20:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:20:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 17:20:48 INFO - process_Request line: dromaeo_css 6224.30 graph.html#tests=[[72,132,35]] 17:20:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:20:48 INFO - process_Request line: kraken 1511.60 graph.html#tests=[[232,132,35]] 17:20:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:20:48 INFO - process_Request line: v8_7 19839.61 graph.html#tests=[[230,132,35]] 17:20:48 INFO - RETURN: dromaeo_css: 6224.30 17:20:48 INFO - RETURN: kraken: 1511.60 17:20:48 INFO - RETURN: v8_7: 19839.61 17:20:48 INFO - javascript benchmark 17:20:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2615.28079778061, 2683.5572130598453, 2683.8523881186525, 2698.8245764025337, 2712.1456741126544, 4503.572160644741, 4608.838690645828, 4667.043256132493, 4673.29900514923, 4677.321788340692, 4569.6801223914335, 4574.862754117382, 4676.275177347517, 4679.8362057328, 4690.90618187636, 4272.978635106828, 4329.567043295677, 4333.1766964276685, 4351.891202719926, 4376.256036473807, 4051.918961620766, 4332.046949671083, 4348.434703488558, 4407.625351845097, 4436.046250056237, 4119.237940980898, 4231.661467082626, 4237.258479766028, 4333.371661109121, 4392.604665580081, 4213.5786421357925, 4314.956850431487, 4317.848875289381, 4322.891927701801, 4331.5884990925815, 4271.1671224111315, 4271.615554600101, 4277.037666525038, 4305.935410968838, 4325.0, 4429.822807087713, 4544.3637890695, 4605.424321959755, 4606.378138951232, 4624.398828152319, 4864.927026094611, 4881.145799485112, 4998.525140111684, 5011.824586139468, 5032.47159048302, 5045.823396181153, 5050.318207042039, 5061.6962982221185, 5063.215201643751, 5099.46455622158, 4689.835855745033, 4690.0, 4691.906161876777, 4693.131770622445, 4707.976460117746, 4972.229304457743, 5023.6985780853265, 5062.5858191877305, 5100.872478188001, 5173.094708426011, 4905.411350637946, 4910.165271903785, 4911.091448082117, 4927.0, 4972.353594032753, 4980.975095124501, 4989.750512474362, 4991.850244492671, 5000.199968005102, 5019.648624596316, 4803.567678908915, 4886.682365646222, 4921.3356196912955, 4932.260160975882, 4989.5758860496535, 4919.311296418504, 4934.259861020875, 4937.679050861682, 4940.283658869444, 4984.825531106467, 4151.7924103794685, 4158.9376159357635, 4160.854370097032, 4168.541460439349, 4198.538160802309, 3505.9298814024087, 3578.284343131384, 3649.1606930406156, 3652.908677283089, 3678.7240956928335, 4340.153670034376, 4342.196693611692, 4345.739255644671, 4352.673549483801, 4390.495093064274, 5023.472535383732, 5028.245763135559, 5034.194528875362, 5040.571551418097, 5075.467075957045, 4098.918021639551, 4207.074443622399, 4207.326827707552, 4218.346156345771, 4332.740035597874, 4463.709858859163, 4477.126960242721, 4488.192125417456, 4507.887302817456, 4519.728816271035, 4815.6388270879825, 4817.542333478384, 4820.060088282751, 4823.107725070873, 4868.0, 4850.102730994778, 4865.367502224688, 4971.577415919687, 4986.077575648516, 5058.34241548611, 4786.569208771228, 4812.759362031955, 4828.324034635224, 4863.537963893425, 4866.732329721899, 4960.8759781005765, 4961.05739909416, 4965.4786247444945, 4972.0801651694555, 4985.8005679772405, 4850.296706977398, 4980.551750342486, 5065.0, 5082.085224659449, 5129.820456284012, 4752.405949256343, 4777.092352453023, 4844.2007068834655, 4852.272159176152, 4900.950990490192, 4789.592884604847, 4796.304535842213, 4798.49615790351, 4802.567768900815, 4846.17615005457, 4563.429571303587, 4674.275487299474, 4783.449903261169, 4788.473267940593, 4802.039592081528, 4817.518248175154, 4845.127876982177, 4885.975570122127, 4931.309616653743, 4938.160512712776, 4783.7129772213775, 4810.302506136661, 4817.325574419514, 4818.10864989978, 4865.854024379274], "unit": "score", "name": "dojo.html", "value": 4578.783622118925}, {"lowerIsBetter": false, "replicates": [508.25286828362306, 517.433410415595, 517.5368045599189, 533.8051611161927, 537.7096367961301, 27244.04645837396, 34689.479657805125, 35478.64521354789, 35482.0, 35526.64473355272, 40298.59701402985, 40855.0, 40856.18287634246, 40877.795611021975, 40949.59050409495, 6965.5124141310125, 7078.787636370917, 7863.567503787275, 8029.799255018613, 8033.758987230363, 10059.64791232307, 10305.0, 10305.690829275134, 10312.690619281433, 10320.277580569364, 9909.0, 10009.59961601535, 10016.098551130397, 10019.549120289568, 10020.19838412929, 7158.284171582852, 7354.374878135365, 10026.548805303779, 10072.697819065403, 10291.022352876465, 9744.464054477, 9861.60553577856, 9862.852057219148, 9864.704058878246, 9867.60529578816, 30061.248468788235, 37011.81494092539, 37522.624773752184, 37578.43632345517, 37624.247515049545, 2366.9644955325684, 2782.6799918009488, 2821.562657788046, 3071.8003329783714, 3328.9334213315597, 26579.46841063187, 26604.73395266042, 26807.195784126314, 26855.0, 27419.17742467709, 3330.467125259971, 3504.4217704078796, 3515.9472607910902, 3552.6980206682465, 3655.872044478457, 213119.0, 213632.0, 215214.0, 215851.0, 215954.0, 52191.47808521942, 53702.19446708303, 56711.0, 57086.714566426905, 57152.0, 58064.70967645135, 59304.738239397244, 59396.7030164855, 59420.40579594235, 59438.40561594415, 13726.65683357924, 13728.0, 13760.105593136414, 13775.586732398044, 13793.655158620913, 9762.0, 10098.242631802497, 10138.239632027628, 10263.640772573073, 10286.537105830255, 19443.90278048629, 19657.311994080137, 19666.0, 19775.208991640462, 19862.0, 7701.768946931601, 7777.0, 7816.53100813953, 7868.213178682086, 7910.9604451977375, 726.7941796647151, 786.697121608185, 855.149126619018, 931.3666706639415, 1043.3687618990402, 26261.34346641311, 26273.0, 26423.339416514358, 26505.072322468623, 26700.332491687863, 900.0954041188694, 942.4675058591873, 971.3443425687633, 1010.4139599032543, 1049.333673117576, 13756.243406612532, 13766.174029558259, 14078.507252246121, 14168.504102356368, 14246.715065698629, 251232.0, 255593.0, 255614.0, 256214.0, 256733.0, 45925.54074459212, 46357.76821115873, 46362.30456543154, 46421.07157856824, 46434.767826160656, 1110.1507346879644, 1128.3793913347627, 1129.9435028248554, 1131.422974283138, 1183.331417748969, 22687.659685104405, 24794.876025619757, 25547.23358299254, 25680.229593112235, 25910.481790364465, 36775.632243678294, 37185.81407093055, 37199.25601487901, 37210.62789372072, 37234.81382593178, 197299.0, 199416.0, 199637.0, 199677.0, 199861.0, 24758.50482990366, 25657.871710641328, 29078.0, 29374.0, 29445.26386840346, 33539.496907545916, 33906.49140262849, 34187.316253675286, 34202.65797341995, 34245.143871403416, 31267.37465250637, 31823.0, 32117.839410803732, 32158.51762223615, 32477.18807029843, 31554.526682099327, 31844.52233216457, 31989.200269993435, 32079.198020049684, 32158.196045098124, 31846.52230216595, 32143.839280803448, 32184.678153219105, 38805.6119438802, 39652.80173599113, 28895.56656650194, 29422.292433210583, 30388.797707179725, 30416.39167216599, 30417.847910760305, 23122.76877231206, 23388.883055584614, 23593.764062359158, 25424.364390890376, 27079.59380609332], "unit": "score", "name": "ext.html", "value": 16833.855609292525}, {"lowerIsBetter": false, "replicates": [294.72884945849813, 299.1832297826932, 302.57790382416516, 313.98116113033217, 314.8992322456814, 14117.435302587885, 14618.415263389465, 15070.698586028273, 15680.529584112466, 15685.607859803511, 14657.193854338033, 15323.463678771217, 15817.84182158178, 16235.83764162358, 16255.674886502264, 4948.084604348189, 5068.138416469191, 5074.061298659742, 5078.746062696869, 5079.517445842639, 5018.874528136789, 5045.419776725668, 5050.343455350818, 5054.292399064134, 5055.949440505603, 4874.65877388583, 5006.849794506153, 5012.298278241031, 5014.172661510846, 5014.749262536859, 4996.350474438318, 5024.598032157437, 5025.773840177201, 5047.116754567973, 5054.595632349403, 4325.589069038437, 4402.7578483183415, 4415.933760993556, 4418.955810441887, 4477.306017567283, 19067.80932190674, 19336.03319834003, 19357.322493712654, 19588.6493620765, 19770.703439448418, 1654.3548016273662, 1698.5159229619499, 1770.8317709817547, 1875.5686192175876, 1932.0919167991021, 8678.088800675965, 8762.079981601968, 8843.292536597057, 9443.763905902339, 12594.937025314906, 1706.7525208844772, 1722.5435259656201, 1730.576008877833, 1732.9306827726875, 1768.6197467544412, 41390.37914431286, 43992.0, 54217.0, 55816.441835581936, 56089.87820243572, 8326.916730832736, 8925.107489251153, 9095.090490950852, 9099.044600317004, 9224.215941645036, 11366.772664546828, 11508.884911150948, 11510.0, 11524.308541487537, 11533.480993355319, 6150.846228844225, 6218.409251121137, 6876.209235937831, 7038.0, 7099.432045436352, 6872.209695885037, 6952.339527744856, 6978.092847929838, 6997.790066297917, 7028.964855175692, 3880.825362858678, 3959.3269144245546, 3970.2456533258587, 3972.205558888234, 3987.6809855211513, 1643.6383995520966, 1666.6250093729057, 1683.2730975819006, 1694.1190580897864, 1695.177838748206, 820.4420993724325, 832.6710949175042, 871.333429926107, 877.8990416102102, 988.0, 14916.552503424915, 15394.461193858162, 15879.920600396925, 16362.0, 16503.422380216874, 821.9815697867267, 830.4353039932904, 836.3476488339105, 857.4897935728231, 880.6301353431575, 8356.456830306011, 8363.0, 8541.402101852811, 8597.828043439096, 8712.433691810013, 465081.0, 469780.0, 470376.0, 472454.0, 485489.0, 38007.80996095002, 40447.19105617871, 64273.35726642767, 72939.27060729431, 73150.0, 1015.6597539824094, 1047.7171163785888, 1049.1763965287214, 1049.9002594753485, 1066.1524088349781, 14604.196769177797, 14684.118952862862, 14871.0, 14887.776683349975, 15025.549233523012, 32924.0, 33686.45232893528, 33743.0, 34213.82893085518, 34859.82570087133, 34575.73040165322, 42269.577304226565, 44566.77716611396, 46023.079538409715, 47056.7647161762, 8235.50586964784, 8503.617337219715, 8713.91286087131, 8723.389362744547, 8727.432716873383, 10075.748106297107, 10139.188864890939, 11108.722281943015, 15666.843331566539, 15891.125988070768, 13419.731605368033, 13550.186988780704, 13558.118722283414, 13580.981426392862, 13621.114627549177, 12408.56570020045, 12482.313472759086, 12848.614541563767, 13659.863401366256, 13897.583072507841, 10666.626668066581, 11821.704457388634, 12570.120091593866, 13327.866721332663, 13518.188908665512, 8653.653853846028, 8694.869576956477, 8823.07357727455, 8842.15999480074, 8862.689805856764, 9081.182693557348, 9163.22112620408, 9191.356605037583, 9825.754356141153, 14391.78412323795], "unit": "score", "name": "jquery.html", "value": 7940.276176803568}, {"lowerIsBetter": false, "replicates": [1398.5314919501966, 1428.5857101440583, 1467.2370367408948, 1573.8268790433058, 1724.1637805664259, 5936.673482958436, 7018.3683468487825, 7184.892226616605, 7189.317014883578, 7206.387457066143, 6967.233604303535, 7274.454415918814, 7285.198628150913, 7293.744718934825, 7340.0, 1761.779777527809, 1801.918913648889, 2025.7872923343057, 2078.1687325069943, 2119.4065661614773, 2114.4291041418805, 2116.5132019635416, 2116.7142435771207, 2119.7244358233406, 2121.045529511718, 2053.425040988526, 2056.557840064386, 2118.766935637079, 2120.812345086749, 2121.9151233950624, 2115.820155286787, 2128.2976617716195, 2128.446603882986, 2135.5835612055657, 2155.622766015941, 2121.289368061701, 2124.022949443258, 2138.369181091566, 2138.625740495407, 2139.1978008246906, 7149.392301654366, 7169.641517924083, 7216.963915180443, 7218.566885986857, 7227.602481863495, 4305.526392096866, 4382.956170438287, 4413.183561041217, 4416.668749843775, 4417.359482874966, 2745.546984747514, 2795.343094372821, 2825.901093461719, 2854.9429011419656, 2861.184562399706, 875.1248751248751, 880.9339299552495, 902.2331018634175, 911.4850109688072, 914.5198770645397, 9698.175655069257, 9892.55483503244, 9909.0, 9909.554070066864, 9910.355826871302, 4116.217918595457, 4130.772807495617, 4177.060161463646, 4182.707210495297, 4198.265303571924, 8710.825783484295, 8718.91281087181, 8722.215000649972, 8735.257503112307, 8737.0, 4297.720648157922, 4307.6769242306955, 4309.332053531708, 4317.978410107929, 4320.524742278347, 3904.0630248740667, 3905.160390515996, 3907.081835768592, 3911.706622003361, 3913.5890731472787, 3085.3212293295437, 3099.612548431446, 3149.4960806270888, 3166.920826979298, 3407.0800883761244, 1123.8819923907872, 1124.966251012471, 1127.3686735428187, 1150.976980460403, 1156.612534800851, 853.2363534636589, 933.3233405780754, 1098.4892025208317, 1153.117864833403, 1154.509333533245, 6419.550631455847, 6535.150430444107, 6578.76974305897, 6592.0, 6604.438622717027, 550.6118186678463, 563.6280055163572, 569.3225062175998, 576.7145263094711, 712.989305160423, 5147.974260128675, 5208.322918020633, 5221.660592061504, 5225.738713064332, 5230.215467679878, 8317.667293308321, 8706.347023973227, 8785.604647790737, 8807.07525709804, 8830.072842351588, 8613.397062205711, 8666.0, 8680.392372533988, 8700.477971321741, 8708.216260536583, 6725.596464212065, 6741.460683145337, 6867.107276054081, 6873.862522749517, 6924.0, 6348.3651634838, 6396.648184349905, 6400.97584386496, 6427.710753016032, 6433.678316084083, 7645.273698998586, 7741.922580774345, 7802.063752349527, 7814.492058016211, 7824.413169012233, 7800.6099695016155, 8075.798105047185, 8086.272235498834, 8092.959535202286, 8106.513609183467, 5816.76732930678, 6284.4344009039405, 6388.87222255543, 6436.485081193587, 6450.193725784277, 5782.335031471434, 5954.821355359173, 6473.643949582818, 6665.100211471583, 6781.660916954034, 6422.518311126591, 6601.108850305147, 6652.866942661023, 6766.594004359754, 6775.661216939232, 6443.871122577429, 6489.967550162408, 6559.212894452697, 6578.638174900427, 6675.299093595297, 6263.561550691408, 6344.1118243445035, 6357.1735674362035, 6357.919153743782, 6369.9363006371195, 5963.224780778471, 5997.970010149921, 5998.220231369894, 6010.54920880927, 6013.368596297326, 5957.0, 5958.374370691015, 5962.373950735284, 5964.671943043, 5967.045272756338], "unit": "score", "name": "mootools.html", "value": 4070.51294556367}, {"lowerIsBetter": false, "replicates": [290.78191356482637, 291.04682165906655, 291.2790842664406, 291.4506155896136, 300.6527460782797, 5221.634485586011, 5342.412334643191, 5364.383095943967, 5410.729463526823, 5413.485718856712, 5093.312402825617, 5148.279240906276, 5191.377034755825, 5316.787328506855, 5330.893382132355, 4126.339785634292, 4134.875953721393, 4136.048708796979, 4146.66826653867, 4151.418801367811, 3911.7261791674596, 4124.319487284594, 4153.376993450991, 4155.293600087993, 4166.062635906927, 3964.583718709537, 4008.1582867597695, 4103.753774773523, 4117.423560701504, 4129.855455059073, 4094.9181016379653, 4097.610726980932, 4106.67146628269, 4114.855980040684, 4117.382392641098, 3605.7475976681644, 3609.476625889258, 3613.1509095362567, 3616.72874534411, 3618.6019537850816, 5153.943441594464, 5155.40712818027, 5166.638335316529, 5168.457311982225, 5170.663906846043, 4526.615237704799, 4661.463931647836, 4665.510121437234, 4666.786635474767, 4750.097481478508, 5577.525910297589, 5611.551075913958, 5612.747426365823, 5618.15727640853, 5620.690862002588, 3784.6972242220554, 3788.2234142000825, 3788.905277368088, 3791.241751649681, 3793.1275806564645, 5826.679532625704, 5889.852753681193, 5921.082232254007, 5923.614965027259, 5924.822255332347, 3868.8259028343227, 3957.1689945111275, 3958.891510377099, 3971.0469487322835, 3976.940345894814, 4001.7598944063448, 4001.959980400217, 4004.0790618157403, 4006.0385507477995, 4010.3984402339297, 4647.883802904955, 4648.790804413809, 4656.464506581787, 4656.557627025427, 4660.207764680013, 5618.2415373924, 5621.100623900156, 5629.887402251932, 5632.549396048306, 5632.662040277596, 1365.8253901644578, 1385.49429458247, 1401.0, 1401.0682895874334, 1420.254366457618, 922.8385032619265, 926.3098991251561, 933.3233405780891, 936.5504557812288, 936.5879013234155, 4801.735904525284, 4924.852254432372, 4931.654784165074, 4933.136701077297, 4934.679245849008, 5761.88476230473, 5768.3366412862215, 5780.306363236438, 5792.913106303409, 5800.50695690871, 4803.495632958559, 4853.490383509751, 4926.9014619707405, 4949.57928576075, 4976.601871850244, 3133.2010337363827, 3163.620365556148, 3173.6826317368077, 3174.238182836149, 3175.4601717707583, 5585.8603534911135, 5590.664560126324, 5592.916106258409, 5595.677793715644, 5597.580181486404, 5909.379515150933, 6009.429104235178, 6042.214512113397, 6043.486303664238, 6052.636841789506, 5588.608797384144, 5591.8881622368135, 5601.719914004283, 5611.3266408031295, 5611.765411609439, 5877.382874798084, 5914.940850591611, 5920.200772895604, 5926.407359264039, 5929.0, 5783.566232532493, 5784.855378615568, 5794.5364370851075, 5796.42035796417, 5798.0, 5461.918071228855, 5615.859603509782, 5617.775288988395, 5621.79131486716, 5624.634398764068, 3967.980160099181, 3997.120633460634, 4017.397390391348, 4019.5578486367062, 4021.215862906822, 5894.0274854650215, 5900.822975310747, 5907.3501914790195, 5909.995300798789, 5911.556633252438, 5577.0797818359515, 5613.961417137843, 5697.829065128053, 5699.914501282401, 5702.857428564319, 5653.575981801299, 5654.180143879197, 5670.09278515452, 5672.7730890763905, 5675.858103547444, 5535.0, 5552.7223638818705, 5555.72221388937, 5561.833145005495, 5562.2490963721, 5709.0865461525955, 5710.5146062585145, 5714.685692286798, 5717.113847353667, 5721.141828725558, 5419.105847535113, 5508.283923089973, 5550.52820510245, 5582.720863956704, 5591.552675785846], "unit": "score", "name": "prototype.html", "value": 4205.539656231247}, {"lowerIsBetter": false, "replicates": [751.1286907187662, 784.6704384158653, 787.1027029186728, 800.7077416742891, 817.9345652347813, 12368.938155309233, 12560.999999999989, 12578.559750408738, 12579.748405031894, 12602.432890519925, 13563.254021028839, 13641.386137623806, 13664.180149191056, 13689.17864928105, 13700.451981920736, 651.4234902111618, 658.9703463344161, 807.6284908941893, 823.8105235795771, 824.2293455618985, 808.7331180710352, 817.5217497763815, 823.8805373220879, 824.2746383182791, 824.6660102658433, 854.5940678177878, 859.8280343931208, 859.9828003439927, 860.4794099569764, 860.9913900861005, 675.3584095109641, 680.1328306409367, 838.3209600223777, 851.0255757158051, 856.3705676327894, 625.527726566444, 625.6308777821107, 626.1109224900606, 626.4831514000967, 629.1129507394597, 11698.94150529242, 11723.472443739967, 11723.531058757639, 11736.941315293454, 11744.706382340424, 10376.377417354983, 10757.462126893624, 10788.46057697112, 10793.946030269877, 10958.123350131971, 8611.61247743853, 8907.242884354837, 8991.730248092503, 8994.325425593106, 9200.32680389777, 3081.938361232785, 3110.7666924980717, 3140.764442666786, 3158.5104308831937, 3175.5712978747806, 39379.0, 40251.19497610031, 40458.79770601157, 40616.39075413871, 40754.59245407538, 8881.40471502949, 8914.598843052077, 8983.550822458981, 9005.729828105168, 9029.729108126767, 15263.084214946917, 15328.386864525517, 15352.616184595252, 15366.692666146615, 15367.462138825087, 6202.782902598387, 6281.089242059876, 6300.495960323255, 6309.842253943596, 6559.278479367265, 3573.7855728656364, 3613.4941108244866, 3634.436662317345, 3683.4474828775897, 3704.370257056307, 2663.6537250157744, 2675.39803544201, 2693.905713300025, 2701.405690748032, 2702.878370473294, 465.92545192768995, 466.5357968821045, 470.5553252176729, 485.5629933060274, 485.82510296293304, 398.63325740318976, 426.2561829607355, 480.00623131821266, 519.4675457655933, 532.521871434001, 6803.319668033256, 7044.295570442915, 7044.6125463099, 7112.608806515588, 7173.3185347392955, 438.01009718037466, 514.0361821584529, 523.8742701751628, 532.8508017755034, 545.3265217456438, 3176.682331766851, 3406.4549672052353, 3434.261633748756, 3503.982480087583, 3695.1685870678884, 46939.06121877543, 47391.0, 47418.76290618594, 47432.0, 47434.0, 42855.57144428516, 42982.78508607437, 43273.56726432696, 43620.0, 43640.3453948191, 38943.22113557713, 40353.0, 40496.98757531026, 40938.701436348754, 40945.38581921274, 6911.343422374866, 7171.713131474683, 7199.640017998974, 7205.586342287758, 7317.0, 30465.54301685432, 30841.537376938915, 31178.220544485663, 31238.687613124486, 31309.373812523165, 38388.0, 38966.41550376803, 39271.0, 39420.60579394169, 39517.80241098776, 9300.708677450017, 9602.375845570015, 9609.0, 9634.470104144339, 9804.480020786097, 10508.474576271308, 10633.361998280128, 10653.9467302663, 10661.89338106609, 10891.0198082173, 10102.09081182697, 10289.536970836181, 10318.742031449274, 10483.213758967955, 10754.677359679223, 9923.950380248052, 9933.155681766842, 10007.699769006942, 10023.148032417326, 10024.097831195228, 9790.951045244728, 9891.950540247253, 10006.649767258112, 10091.495425228855, 10248.282620216512, 7753.806154846174, 8075.232852878967, 8199.71301004462, 8453.535055571756, 8694.608862581956, 7976.401769867167, 8149.79625509367, 8410.747677569683, 8522.78693032679, 8698.956505217433], "unit": "score", "name": "yui.html", "value": 5549.563384031227}], "name": "dromaeo_css", "value": 6224.301955658848}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 105.0, 110.0, 111.0, 111.0, 100.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 152.0, 168.0, 131.0, 153.0, 157.0, 138.0, 173.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 84.0, 89.0, 71.0, 72.0, 73.0, 95.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 138.0, 94.0, 94.0, 95.0, 130.0, 94.0, 94.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 70.0, 70.0, 70.0, 70.0, 71.0, 79.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [81.0, 90.0, 83.0, 81.0, 81.0, 81.0, 82.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [120.0, 127.0, 119.0, 125.0, 127.0, 119.0, 121.0, 123.0, 121.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [135.0, 145.0, 164.0, 145.0, 148.0, 134.0, 142.0, 144.0, 144.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 67.0, 69.0, 68.0, 67.0, 69.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1511.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [186.28912071535024], "unit": "score", "name": "DeltaBlue", "value": 354.92142400000006}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1982.1782178217823], "unit": "score", "name": "RayTrace", "value": 373.32112387612375}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [593.3609958506224], "unit": "score", "name": "Splay", "value": 137.337979020979}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "NavierStokes", "value": 304.7896311066801}], "name": "v8_7", "value": 19839.609598984953}]} 17:20:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19839.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1511.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6224.30"}}} 17:20:49 INFO - Return code: 0 17:20:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:20:49 ERROR - # TBPL SUCCESS # 17:20:49 INFO - Running post-action listener: _resource_record_post_action 17:20:49 INFO - Running post-run listener: _resource_record_post_run 17:20:50 INFO - Total resource usage - Wall time: 1351s; CPU: 14.0%; Read bytes: 53248; Write bytes: 550273024; Read time: 2164; Write time: 9791512 17:20:50 INFO - install - Wall time: 19s; CPU: 29.0%; Read bytes: 0; Write bytes: 101974016; Read time: 0; Write time: 847644 17:20:50 INFO - run-tests - Wall time: 1333s; CPU: 13.0%; Read bytes: 53248; Write bytes: 448299008; Read time: 2164; Write time: 8943868 17:20:50 INFO - Running post-run listener: _upload_blobber_files 17:20:50 INFO - Blob upload gear active. 17:20:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:20: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 17:20: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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:20: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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:20:50 INFO - (blobuploader) - INFO - Open directory for files ... 17:20:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:20:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:20:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:51 INFO - (blobuploader) - INFO - Done attempting. 17:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:20:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:52 INFO - (blobuploader) - INFO - Done attempting. 17:20:52 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:52 INFO - Return code: 0 17:20:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:20:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/042d9510f45d9f91eccab1047508b6c2bb7e071c4bd9e2021e6c5947601fdb1bf2dd08325b7de5a6c7016c63877d4277c1663759e1ab734c2b77b520e7753175", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d842f05170f99250b02311a0368bf02f792ce4e065224ff40905fee42d4c929b956fa42d4db98ed5284118f409285d517830db8acf10e621fa14e07dfb4d397a"} 17:20:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:20:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:20:52 INFO - Contents: 17:20:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/042d9510f45d9f91eccab1047508b6c2bb7e071c4bd9e2021e6c5947601fdb1bf2dd08325b7de5a6c7016c63877d4277c1663759e1ab734c2b77b520e7753175", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d842f05170f99250b02311a0368bf02f792ce4e065224ff40905fee42d4c929b956fa42d4db98ed5284118f409285d517830db8acf10e621fa14e07dfb4d397a"} 17:20:52 INFO - Copying logs to upload dir... 17:20:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1406.533173 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 26 secs) (at 2015-12-21 17:20:52.221206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 17:20:52.224398) ========= 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=256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/042d9510f45d9f91eccab1047508b6c2bb7e071c4bd9e2021e6c5947601fdb1bf2dd08325b7de5a6c7016c63877d4277c1663759e1ab734c2b77b520e7753175", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d842f05170f99250b02311a0368bf02f792ce4e065224ff40905fee42d4c929b956fa42d4db98ed5284118f409285d517830db8acf10e621fa14e07dfb4d397a"} build_url:https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009758 build_url: 'https://queue.taskcluster.net/v1/task/lf5Mj0c-TUuGuIk2pHJeBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/042d9510f45d9f91eccab1047508b6c2bb7e071c4bd9e2021e6c5947601fdb1bf2dd08325b7de5a6c7016c63877d4277c1663759e1ab734c2b77b520e7753175", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d842f05170f99250b02311a0368bf02f792ce4e065224ff40905fee42d4c929b956fa42d4db98ed5284118f409285d517830db8acf10e621fa14e07dfb4d397a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 17:20:52.247221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 17:20:52.247548) ========= 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=256b35f542ca8bede9e27f1f00000291-1450744025.881317-1200926173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 17:20:52.332926) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 17:20:52.333257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 17:20:52.333580) ========= ========= Total master_lag: 0.30 =========