builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1452674909.1 results: success (0) buildid: 20160113000030 builduid: 3f9a95b578244c56851130e352f0166b revision: 154482173e4021b606157b8b4e085e01dc75673f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.104157) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.104626) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.104921) ========= 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=cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006350 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.146045) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.146350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.207086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.207350) ========= 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=cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.290140) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.290421) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.290813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.291085) ========= 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=cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 00:48:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.4M=0s 2016-01-13 00:48:31 (85.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163162 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.467760) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.468088) ========= 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=cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014082 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.517956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:29.518326) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 154482173e4021b606157b8b4e085e01dc75673f --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 154482173e4021b606157b8b4e085e01dc75673f --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=cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 00:48:31,265 truncating revision to first 12 chars 2016-01-13 00:48:31,265 Setting DEBUG logging. 2016-01-13 00:48:31,265 attempt 1/10 2016-01-13 00:48:31,265 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/154482173e40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 00:48:31,675 unpacking tar archive at: fx-team-154482173e40/testing/mozharness/ program finished with exit code 0 elapsedTime=0.702625 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:30.233711) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:30.233987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:30.244163) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:30.244410) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 00:48:30.244803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-01-13 00:48:30.245087) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--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=cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:48:32 INFO - MultiFileLogger online at 20160113 00:48:32 in /builds/slave/test 00:48:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:48:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:48:32 INFO - {'append_to_log': False, 00:48:32 INFO - 'base_work_dir': '/builds/slave/test', 00:48:32 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:48:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:48:32 INFO - 'branch': 'Fx-Team-Non-PGO', 00:48:32 INFO - 'buildbot_json_path': 'buildprops.json', 00:48:32 INFO - 'config_files': ('talos/linux_config.py',), 00:48:32 INFO - 'default_actions': ('clobber', 00:48:32 INFO - 'read-buildbot-config', 00:48:32 INFO - 'download-and-extract', 00:48:32 INFO - 'populate-webroot', 00:48:32 INFO - 'create-virtualenv', 00:48:32 INFO - 'install', 00:48:32 INFO - 'run-tests'), 00:48:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:48:32 INFO - 'download_minidump_stackwalk': True, 00:48:32 INFO - 'download_symbols': 'ondemand', 00:48:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:48:32 INFO - 'tooltool.py': '/tools/tooltool.py', 00:48:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:48:32 INFO - '/tools/misc-python/virtualenv.py')}, 00:48:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:48:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:48:32 INFO - 'installer_path': 'installer.exe', 00:48:32 INFO - 'log_level': 'info', 00:48:32 INFO - 'log_name': 'talos', 00:48:32 INFO - 'log_to_console': True, 00:48:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:48:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:48:32 INFO - 'opt_config_files': (), 00:48:32 INFO - 'pip_index': False, 00:48:32 INFO - 'sps_profile': False, 00:48:32 INFO - 'sps_profile_interval': 0, 00:48:32 INFO - 'suite': 'dromaeojs-e10s', 00:48:32 INFO - 'system_bits': '32', 00:48:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:48:32 INFO - 'title': 'talos-linux64-ix-054', 00:48:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:48:32 INFO - 'use_talos_json': True, 00:48:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:48:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:48:32 INFO - 'work_dir': 'build'} 00:48:32 INFO - ##### 00:48:32 INFO - ##### Running clobber step. 00:48:32 INFO - ##### 00:48:32 INFO - Running pre-action listener: _resource_record_pre_action 00:48:32 INFO - Running main action method: clobber 00:48:32 INFO - rmtree: /builds/slave/test/build 00:48:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:48:33 INFO - Running post-action listener: _resource_record_post_action 00:48:33 INFO - ##### 00:48:33 INFO - ##### Running read-buildbot-config step. 00:48:33 INFO - ##### 00:48:33 INFO - Running pre-action listener: _resource_record_pre_action 00:48:33 INFO - Running main action method: read_buildbot_config 00:48:33 INFO - Using buildbot properties: 00:48:33 INFO - { 00:48:33 INFO - "project": "", 00:48:33 INFO - "product": "firefox", 00:48:33 INFO - "script_repo_revision": "production", 00:48:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:48:33 INFO - "repository": "", 00:48:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 00:48:33 INFO - "buildid": "20160113000030", 00:48:33 INFO - "pgo_build": "False", 00:48:33 INFO - "basedir": "/builds/slave/test", 00:48:33 INFO - "buildnumber": 680, 00:48:33 INFO - "slavename": "talos-linux64-ix-054", 00:48:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:48:33 INFO - "platform": "ubuntu64_hw", 00:48:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:48:33 INFO - "branch": "fx-team", 00:48:33 INFO - "repo_path": "integration/fx-team", 00:48:33 INFO - "revision": "154482173e4021b606157b8b4e085e01dc75673f", 00:48:33 INFO - "stage_platform": "linux64", 00:48:33 INFO - "builduid": "3f9a95b578244c56851130e352f0166b", 00:48:33 INFO - "slavebuilddir": "test" 00:48:33 INFO - } 00:48:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:48:33 INFO - Running post-action listener: _resource_record_post_action 00:48:33 INFO - ##### 00:48:33 INFO - ##### Running download-and-extract step. 00:48:33 INFO - ##### 00:48:33 INFO - Running pre-action listener: _resource_record_pre_action 00:48:33 INFO - Running main action method: download_and_extract 00:48:33 INFO - mkdir: /builds/slave/test/build/tests 00:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:48:33 INFO - https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:48:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/test_packages.json 00:48:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/test_packages.json 00:48:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:48:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:48:42 INFO - Downloaded 1302 bytes. 00:48:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:48:42 INFO - Using the following test package requirements: 00:48:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:48:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:42 INFO - u'jsshell-linux-x86_64.zip'], 00:48:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:48:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:48:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:48:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:48:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:48:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:48:42 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')]} 00:48:42 INFO - https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:48:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:48:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/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 00:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/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 00:48:56 INFO - Downloaded 22758864 bytes. 00:48:56 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 00:48:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:48:56 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 00:48:57 INFO - Return code: 0 00:48:57 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 00:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:48:57 INFO - https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:48:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:48:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/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 00:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/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 00:49:00 INFO - Downloaded 22758864 bytes. 00:49:00 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 00:49:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:49:00 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 00:49:01 INFO - Return code: 0 00:49:01 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')]} 00:49:01 INFO - https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:49:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/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 00:49:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/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 00:49:03 INFO - Downloaded 11132285 bytes. 00:49:03 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 00:49:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:03 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 00:49:03 INFO - Return code: 0 00:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:49:03 INFO - https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:49:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:49:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:49:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/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 00:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7rHME9qS7yo4amAmAryKw/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 00:49:06 INFO - Downloaded 53852310 bytes. 00:49:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:49:06 INFO - mkdir: /builds/slave/test/properties 00:49:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:49:06 INFO - Writing to file /builds/slave/test/properties/build_url 00:49:06 INFO - Contents: 00:49:06 INFO - build_url:https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:49:06 INFO - Running post-action listener: _resource_record_post_action 00:49:06 INFO - Running post-action listener: set_extra_try_arguments 00:49:06 INFO - ##### 00:49:06 INFO - ##### Running populate-webroot step. 00:49:06 INFO - ##### 00:49:06 INFO - Running pre-action listener: _resource_record_pre_action 00:49:06 INFO - Running main action method: populate_webroot 00:49:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:49:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:49:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:49:06 INFO - '--tppagecycles', 00:49:06 INFO - '7'], 00:49:06 INFO - 'tests': ['tsvgm']}}, 00:49:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:49:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:49:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:49:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:49:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:49:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:49:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:06 INFO - 'talos_options': ['--e10s'], 00:49:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:06 INFO - 'tests': ['damp', 'tps']}, 00:49:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:06 INFO - 'talos_options': ['--e10s'], 00:49:06 INFO - 'tests': ['damp', 'tps']}, 00:49:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:49:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:49:06 INFO - 'other': {'tests': ['a11yr', 00:49:06 INFO - 'ts_paint', 00:49:06 INFO - 'tpaint', 00:49:06 INFO - 'sessionrestore', 00:49:06 INFO - 'sessionrestore_no_auto_restore']}, 00:49:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:49:06 INFO - 'tests': ['a11yr', 00:49:06 INFO - 'ts_paint', 00:49:06 INFO - 'tpaint', 00:49:06 INFO - 'sessionrestore', 00:49:06 INFO - 'sessionrestore_no_auto_restore']}, 00:49:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:49:06 INFO - 'tests': ['a11yr', 00:49:06 INFO - 'ts_paint', 00:49:06 INFO - 'tpaint', 00:49:06 INFO - 'sessionrestore', 00:49:06 INFO - 'sessionrestore_no_auto_restore']}, 00:49:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:49:06 INFO - 'tests': ['a11yr', 00:49:06 INFO - 'ts_paint', 00:49:06 INFO - 'tpaint', 00:49:06 INFO - 'sessionrestore', 00:49:06 INFO - 'sessionrestore_no_auto_restore']}, 00:49:06 INFO - 'other_l64': {'tests': ['a11yr', 00:49:06 INFO - 'ts_paint', 00:49:06 INFO - 'tpaint', 00:49:06 INFO - 'sessionrestore', 00:49:06 INFO - 'sessionrestore_no_auto_restore']}, 00:49:06 INFO - 'other_nol64': {'tests': ['a11yr', 00:49:06 INFO - 'ts_paint', 00:49:06 INFO - 'tpaint', 00:49:06 INFO - 'sessionrestore', 00:49:06 INFO - 'sessionrestore_no_auto_restore']}, 00:49:06 INFO - 'svgr': {'tests': ['tsvgx', 00:49:06 INFO - 'tsvgr_opacity', 00:49:06 INFO - 'tart', 00:49:06 INFO - 'tscrollx', 00:49:06 INFO - 'cart']}, 00:49:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:49:06 INFO - 'tests': ['tsvgx', 00:49:06 INFO - 'tsvgr_opacity', 00:49:06 INFO - 'tart', 00:49:06 INFO - 'tscrollx', 00:49:06 INFO - 'cart']}, 00:49:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:06 INFO - 'tests': ['tp5o']}, 00:49:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:06 INFO - 'talos_options': ['--e10s'], 00:49:06 INFO - 'tests': ['tp5o']}, 00:49:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:06 INFO - 'talos_options': ['--xperf_path', 00:49:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:06 INFO - 'tests': ['tp5n']}, 00:49:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:06 INFO - 'talos_options': ['--e10s', 00:49:06 INFO - '--xperf_path', 00:49:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:06 INFO - 'tests': ['tp5n']}}, 00:49:06 INFO - 'talos.zip': {'path': '', 00:49:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:49:06 INFO - Running post-action listener: _resource_record_post_action 00:49:06 INFO - ##### 00:49:06 INFO - ##### Running create-virtualenv step. 00:49:06 INFO - ##### 00:49:06 INFO - Running pre-action listener: _resource_record_pre_action 00:49:06 INFO - Running main action method: create_virtualenv 00:49:06 INFO - Creating virtualenv /builds/slave/test/build/venv 00:49:06 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 00:49:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:49:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:49:06 INFO - Using real prefix '/usr' 00:49:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:49:07 INFO - Installing distribute.............................................................................................................................................................................................done. 00:49:09 INFO - Installing pip.................done. 00:49:09 INFO - Return code: 0 00:49:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:49:09 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')]} 00:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:09 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')]} 00:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:09 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 0x7fe753520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c623d0>, '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 0x1bcded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bce360>, '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': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', '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 00:49:09 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 00:49:09 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 00:49:09 INFO - Using env: {'DISPLAY': ':0', 00:49:09 INFO - 'HOME': '/home/cltbld', 00:49:09 INFO - 'LANG': 'en_US.UTF-8', 00:49:09 INFO - 'LANGUAGE': 'en_US:en', 00:49:09 INFO - 'LOGNAME': 'cltbld', 00:49:09 INFO - 'MAIL': '/var/mail/cltbld', 00:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:09 INFO - 'MOZ_NO_REMOTE': '1', 00:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:09 INFO - 'NO_EM_RESTART': '1', 00:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:09 INFO - 'PWD': '/builds/slave/test', 00:49:09 INFO - 'SHELL': '/bin/bash', 00:49:09 INFO - 'SHLVL': '1', 00:49:09 INFO - 'TERM': 'linux', 00:49:09 INFO - 'TMOUT': '86400', 00:49:09 INFO - 'USER': 'cltbld', 00:49:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', 00:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:09 INFO - '_': '/tools/buildbot/bin/python'} 00:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:09 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 00:49:09 INFO - Cleaning up... 00:49:09 INFO - Return code: 0 00:49:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:49:09 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')]} 00:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:09 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')]} 00:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:09 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 0x7fe753520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c623d0>, '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 0x1bcded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bce360>, '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': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', '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 00:49:09 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 00:49:09 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 00:49:09 INFO - Using env: {'DISPLAY': ':0', 00:49:09 INFO - 'HOME': '/home/cltbld', 00:49:09 INFO - 'LANG': 'en_US.UTF-8', 00:49:09 INFO - 'LANGUAGE': 'en_US:en', 00:49:09 INFO - 'LOGNAME': 'cltbld', 00:49:09 INFO - 'MAIL': '/var/mail/cltbld', 00:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:09 INFO - 'MOZ_NO_REMOTE': '1', 00:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:09 INFO - 'NO_EM_RESTART': '1', 00:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:09 INFO - 'PWD': '/builds/slave/test', 00:49:09 INFO - 'SHELL': '/bin/bash', 00:49:09 INFO - 'SHLVL': '1', 00:49:09 INFO - 'TERM': 'linux', 00:49:09 INFO - 'TMOUT': '86400', 00:49:09 INFO - 'USER': 'cltbld', 00:49:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', 00:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:09 INFO - '_': '/tools/buildbot/bin/python'} 00:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:09 INFO - Downloading/unpacking psutil>=0.7.1 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:11 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:49:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:49:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:11 INFO - Installing collected packages: psutil 00:49:11 INFO - Running setup.py install for psutil 00:49:11 INFO - building 'psutil._psutil_linux' extension 00:49:11 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 00:49:11 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 00:49:11 INFO - building 'psutil._psutil_posix' extension 00:49:11 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 00:49:11 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 00:49:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:11 INFO - Successfully installed psutil 00:49:11 INFO - Cleaning up... 00:49:11 INFO - Return code: 0 00:49:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:49: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')]} 00:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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', '--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 0x7fe753520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c623d0>, '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 0x1bcded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bce360>, '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': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', '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 00:49:11 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 00:49:11 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 00:49:11 INFO - Using env: {'DISPLAY': ':0', 00:49:11 INFO - 'HOME': '/home/cltbld', 00:49:11 INFO - 'LANG': 'en_US.UTF-8', 00:49:11 INFO - 'LANGUAGE': 'en_US:en', 00:49:11 INFO - 'LOGNAME': 'cltbld', 00:49:11 INFO - 'MAIL': '/var/mail/cltbld', 00:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:11 INFO - 'MOZ_NO_REMOTE': '1', 00:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:11 INFO - 'NO_EM_RESTART': '1', 00:49:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:11 INFO - 'PWD': '/builds/slave/test', 00:49:11 INFO - 'SHELL': '/bin/bash', 00:49:11 INFO - 'SHLVL': '1', 00:49:11 INFO - 'TERM': 'linux', 00:49:11 INFO - 'TMOUT': '86400', 00:49:11 INFO - 'USER': 'cltbld', 00:49:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', 00:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:11 INFO - '_': '/tools/buildbot/bin/python'} 00:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:49:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:49:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:49:13 INFO - Installing collected packages: mozsystemmonitor 00:49:13 INFO - Running setup.py install for mozsystemmonitor 00:49:13 INFO - Successfully installed mozsystemmonitor 00:49:13 INFO - Cleaning up... 00:49:13 INFO - Return code: 0 00:49:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:49:13 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')]} 00:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:13 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')]} 00:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:13 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 0x7fe753520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c623d0>, '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 0x1bcded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bce360>, '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': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', '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 00:49:13 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 00:49:13 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 00:49:13 INFO - Using env: {'DISPLAY': ':0', 00:49:13 INFO - 'HOME': '/home/cltbld', 00:49:13 INFO - 'LANG': 'en_US.UTF-8', 00:49:13 INFO - 'LANGUAGE': 'en_US:en', 00:49:13 INFO - 'LOGNAME': 'cltbld', 00:49:13 INFO - 'MAIL': '/var/mail/cltbld', 00:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:13 INFO - 'MOZ_NO_REMOTE': '1', 00:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:13 INFO - 'NO_EM_RESTART': '1', 00:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:13 INFO - 'PWD': '/builds/slave/test', 00:49:13 INFO - 'SHELL': '/bin/bash', 00:49:13 INFO - 'SHLVL': '1', 00:49:13 INFO - 'TERM': 'linux', 00:49:13 INFO - 'TMOUT': '86400', 00:49:13 INFO - 'USER': 'cltbld', 00:49:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', 00:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:13 INFO - '_': '/tools/buildbot/bin/python'} 00:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:14 INFO - Downloading/unpacking blobuploader==1.2.4 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:15 INFO - Downloading blobuploader-1.2.4.tar.gz 00:49:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:49:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:49:15 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 00:49:15 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 00:49:15 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 00:49:15 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 00:49:15 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 00:49:15 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 00:49:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:49:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:16 INFO - Downloading docopt-0.6.1.tar.gz 00:49:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:49:16 INFO - Installing collected packages: blobuploader, requests, docopt 00:49:16 INFO - Running setup.py install for blobuploader 00:49:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:49:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:49:16 INFO - Running setup.py install for requests 00:49:17 INFO - Running setup.py install for docopt 00:49:17 INFO - Successfully installed blobuploader requests docopt 00:49:17 INFO - Cleaning up... 00:49:17 INFO - Return code: 0 00:49:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:49:17 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')]} 00:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:17 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')]} 00:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:17 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 0x7fe753520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c623d0>, '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 0x1bcded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bce360>, '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': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', '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 00:49:17 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 00:49:17 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 00:49:17 INFO - Using env: {'DISPLAY': ':0', 00:49:17 INFO - 'HOME': '/home/cltbld', 00:49:17 INFO - 'LANG': 'en_US.UTF-8', 00:49:17 INFO - 'LANGUAGE': 'en_US:en', 00:49:17 INFO - 'LOGNAME': 'cltbld', 00:49:17 INFO - 'MAIL': '/var/mail/cltbld', 00:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:17 INFO - 'MOZ_NO_REMOTE': '1', 00:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:17 INFO - 'NO_EM_RESTART': '1', 00:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:17 INFO - 'PWD': '/builds/slave/test', 00:49:17 INFO - 'SHELL': '/bin/bash', 00:49:17 INFO - 'SHLVL': '1', 00:49:17 INFO - 'TERM': 'linux', 00:49:17 INFO - 'TMOUT': '86400', 00:49:17 INFO - 'USER': 'cltbld', 00:49:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', 00:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:17 INFO - '_': '/tools/buildbot/bin/python'} 00:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:49:17 INFO - Running setup.py (path:/tmp/pip-P66QJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:49:17 INFO - Running setup.py (path:/tmp/pip-TIh62U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:49:17 INFO - Running setup.py (path:/tmp/pip-dhmPQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:49:17 INFO - Running setup.py (path:/tmp/pip-D56O0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:49:17 INFO - Running setup.py (path:/tmp/pip-rCWe9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:49:17 INFO - Running setup.py (path:/tmp/pip-XCLboO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:49:17 INFO - Running setup.py (path:/tmp/pip-J2_JR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:49:17 INFO - Running setup.py (path:/tmp/pip-tvj5f5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:49:17 INFO - Running setup.py (path:/tmp/pip-6bkDNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:49:18 INFO - Running setup.py (path:/tmp/pip-hmkFlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:49:18 INFO - Running setup.py (path:/tmp/pip-n_hgUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:49:18 INFO - Running setup.py (path:/tmp/pip-OoKhZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:49:18 INFO - Running setup.py (path:/tmp/pip-kTdWd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:49:18 INFO - Running setup.py (path:/tmp/pip-8AxsTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:18 INFO - Running setup.py (path:/tmp/pip-rbgpj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:49:18 INFO - Running setup.py (path:/tmp/pip-sPCY0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:49:18 INFO - Running setup.py (path:/tmp/pip-fuc3yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:49:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:49:18 INFO - Running setup.py install for manifestparser 00:49:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:49:18 INFO - Running setup.py install for mozcrash 00:49:18 INFO - Running setup.py install for mozdebug 00:49:18 INFO - Running setup.py install for mozdevice 00:49:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Running setup.py install for mozfile 00:49:19 INFO - Running setup.py install for mozhttpd 00:49:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Running setup.py install for mozinfo 00:49:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Running setup.py install for mozInstall 00:49:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Running setup.py install for mozleak 00:49:19 INFO - Running setup.py install for mozlog 00:49:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Running setup.py install for moznetwork 00:49:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Running setup.py install for mozprocess 00:49:19 INFO - Running setup.py install for mozprofile 00:49:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:49:19 INFO - Running setup.py install for mozrunner 00:49:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:49:20 INFO - Running setup.py install for mozscreenshot 00:49:20 INFO - Running setup.py install for moztest 00:49:20 INFO - Running setup.py install for mozversion 00:49:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:49:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:49:20 INFO - Cleaning up... 00:49:20 INFO - Return code: 0 00:49:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:49:20 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')]} 00:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:20 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')]} 00:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:20 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 0x7fe753520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c623d0>, '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 0x1bcded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bce360>, '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': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', '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 00:49:20 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 00:49:20 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 00:49:20 INFO - Using env: {'DISPLAY': ':0', 00:49:20 INFO - 'HOME': '/home/cltbld', 00:49:20 INFO - 'LANG': 'en_US.UTF-8', 00:49:20 INFO - 'LANGUAGE': 'en_US:en', 00:49:20 INFO - 'LOGNAME': 'cltbld', 00:49:20 INFO - 'MAIL': '/var/mail/cltbld', 00:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:20 INFO - 'MOZ_NO_REMOTE': '1', 00:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:20 INFO - 'NO_EM_RESTART': '1', 00:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:20 INFO - 'PWD': '/builds/slave/test', 00:49:20 INFO - 'SHELL': '/bin/bash', 00:49:20 INFO - 'SHLVL': '1', 00:49:20 INFO - 'TERM': 'linux', 00:49:20 INFO - 'TMOUT': '86400', 00:49:20 INFO - 'USER': 'cltbld', 00:49:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', 00:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:20 INFO - '_': '/tools/buildbot/bin/python'} 00:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:49:20 INFO - Running setup.py (path:/tmp/pip-8b2RUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:49:20 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)) 00:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:49:20 INFO - Running setup.py (path:/tmp/pip-fc0w38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:49:20 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)) 00:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:49:20 INFO - Running setup.py (path:/tmp/pip-QqXHMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:49:20 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)) 00:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:49:20 INFO - Running setup.py (path:/tmp/pip-iBLQTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:49:20 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)) 00:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:49:20 INFO - Running setup.py (path:/tmp/pip-Tkx55w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:49:20 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)) 00:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:49:20 INFO - Running setup.py (path:/tmp/pip-9XhN7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:49:21 INFO - Running setup.py (path:/tmp/pip-Wn9VHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:49:21 INFO - Running setup.py (path:/tmp/pip-ckJfub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:49:21 INFO - Running setup.py (path:/tmp/pip-CPpyIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:49:21 INFO - Running setup.py (path:/tmp/pip-vW4k6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:49:21 INFO - Running setup.py (path:/tmp/pip-CMpuko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:49:21 INFO - Running setup.py (path:/tmp/pip-OOWOCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:49:21 INFO - Running setup.py (path:/tmp/pip-_QREsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:49:21 INFO - Running setup.py (path:/tmp/pip-xCGiJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:21 INFO - Running setup.py (path:/tmp/pip-KtD_r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:49:21 INFO - Running setup.py (path:/tmp/pip-eorEOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:49:21 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)) 00:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:49:21 INFO - Running setup.py (path:/tmp/pip-3y5qnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 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)) 00:49:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:49:21 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 00:49:21 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 00:49:21 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 00:49:21 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 00:49:21 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 00:49:21 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 00:49:23 INFO - Downloading blessings-1.5.1.tar.gz 00:49:23 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 00:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:49:23 INFO - Installing collected packages: blessings 00:49:23 INFO - Running setup.py install for blessings 00:49:23 INFO - Successfully installed blessings 00:49:23 INFO - Cleaning up... 00:49:23 INFO - Return code: 0 00:49:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:49:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:49:24 INFO - Reading from file tmpfile_stdout 00:49:24 INFO - Current package versions: 00:49:24 INFO - argparse == 1.2.1 00:49:24 INFO - blessings == 1.5.1 00:49:24 INFO - blobuploader == 1.2.4 00:49:24 INFO - docopt == 0.6.1 00:49:24 INFO - manifestparser == 1.1 00:49:24 INFO - mozInstall == 1.12 00:49:24 INFO - mozcrash == 0.16 00:49:24 INFO - mozdebug == 0.1 00:49:24 INFO - mozdevice == 0.47 00:49:24 INFO - mozfile == 1.2 00:49:24 INFO - mozhttpd == 0.7 00:49:24 INFO - mozinfo == 0.9 00:49:24 INFO - mozleak == 0.1 00:49:24 INFO - mozlog == 3.1 00:49:24 INFO - moznetwork == 0.27 00:49:24 INFO - mozprocess == 0.22 00:49:24 INFO - mozprofile == 0.28 00:49:24 INFO - mozrunner == 6.11 00:49:24 INFO - mozscreenshot == 0.1 00:49:24 INFO - mozsystemmonitor == 0.0 00:49:24 INFO - moztest == 0.7 00:49:24 INFO - mozversion == 1.4 00:49:24 INFO - psutil == 3.1.1 00:49:24 INFO - requests == 1.2.3 00:49:24 INFO - wsgiref == 0.1.2 00:49:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:49:24 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')]} 00:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:24 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')]} 00:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:24 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 0x7fe753520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c623d0>, '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 0x1bcded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bce360>, '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': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', '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 00:49:24 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 00:49:24 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 00:49:24 INFO - Using env: {'DISPLAY': ':0', 00:49:24 INFO - 'HOME': '/home/cltbld', 00:49:24 INFO - 'LANG': 'en_US.UTF-8', 00:49:24 INFO - 'LANGUAGE': 'en_US:en', 00:49:24 INFO - 'LOGNAME': 'cltbld', 00:49:24 INFO - 'MAIL': '/var/mail/cltbld', 00:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:24 INFO - 'MOZ_NO_REMOTE': '1', 00:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:24 INFO - 'NO_EM_RESTART': '1', 00:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:24 INFO - 'PWD': '/builds/slave/test', 00:49:24 INFO - 'SHELL': '/bin/bash', 00:49:24 INFO - 'SHLVL': '1', 00:49:24 INFO - 'TERM': 'linux', 00:49:24 INFO - 'TMOUT': '86400', 00:49:24 INFO - 'USER': 'cltbld', 00:49:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', 00:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:24 INFO - '_': '/tools/buildbot/bin/python'} 00:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:24 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)) 00:49:24 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)) 00:49:24 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)) 00:49:24 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)) 00:49:24 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)) 00:49:24 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)) 00:49:24 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)) 00:49:24 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)) 00:49:24 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)) 00:49:24 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)) 00:49:24 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)) 00:49:24 INFO - Cleaning up... 00:49:24 INFO - Return code: 0 00:49:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:49:24 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')]} 00:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:24 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')]} 00:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:24 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 0x7fe753520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c623d0>, '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 0x1bcded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bce360>, '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': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', '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 00:49:24 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 00:49:24 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 00:49:24 INFO - Using env: {'DISPLAY': ':0', 00:49:24 INFO - 'HOME': '/home/cltbld', 00:49:24 INFO - 'LANG': 'en_US.UTF-8', 00:49:24 INFO - 'LANGUAGE': 'en_US:en', 00:49:24 INFO - 'LOGNAME': 'cltbld', 00:49:24 INFO - 'MAIL': '/var/mail/cltbld', 00:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:24 INFO - 'MOZ_NO_REMOTE': '1', 00:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:24 INFO - 'NO_EM_RESTART': '1', 00:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:24 INFO - 'PWD': '/builds/slave/test', 00:49:24 INFO - 'SHELL': '/bin/bash', 00:49:24 INFO - 'SHLVL': '1', 00:49:24 INFO - 'TERM': 'linux', 00:49:24 INFO - 'TMOUT': '86400', 00:49:24 INFO - 'USER': 'cltbld', 00:49:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', 00:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:24 INFO - '_': '/tools/buildbot/bin/python'} 00:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:24 INFO - Downloading/unpacking jsonschema 00:49:24 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 00:49:24 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 00:49:24 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 00:49:24 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 00:49:24 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 00:49:24 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 00:49:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:49:26 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 00:49:26 INFO - Downloading/unpacking functools32 (from jsonschema) 00:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:26 INFO - Downloading functools32-3.2.3-2.tar.gz 00:49:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:49:26 INFO - warning: no files found matching '*.txt' 00:49:26 INFO - no previously-included directories found matching 'build' 00:49:26 INFO - no previously-included directories found matching 'dist' 00:49:26 INFO - no previously-included directories found matching '.git*' 00:49:26 INFO - Installing collected packages: jsonschema, functools32 00:49:26 INFO - Running setup.py install for functools32 00:49:26 INFO - warning: no files found matching '*.txt' 00:49:26 INFO - no previously-included directories found matching 'build' 00:49:26 INFO - no previously-included directories found matching 'dist' 00:49:26 INFO - no previously-included directories found matching '.git*' 00:49:26 INFO - Successfully installed jsonschema functools32 00:49:26 INFO - Cleaning up... 00:49:26 INFO - Return code: 0 00:49:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:49: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')]} 00:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:26 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 0x7fe753520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c623d0>, '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 0x1bcded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bce360>, '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': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', '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 00:49:26 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 00:49:26 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 00:49:26 INFO - Using env: {'DISPLAY': ':0', 00:49:26 INFO - 'HOME': '/home/cltbld', 00:49:26 INFO - 'LANG': 'en_US.UTF-8', 00:49:26 INFO - 'LANGUAGE': 'en_US:en', 00:49:26 INFO - 'LOGNAME': 'cltbld', 00:49:26 INFO - 'MAIL': '/var/mail/cltbld', 00:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:26 INFO - 'MOZ_NO_REMOTE': '1', 00:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:26 INFO - 'NO_EM_RESTART': '1', 00:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:26 INFO - 'PWD': '/builds/slave/test', 00:49:26 INFO - 'SHELL': '/bin/bash', 00:49:26 INFO - 'SHLVL': '1', 00:49:26 INFO - 'TERM': 'linux', 00:49:26 INFO - 'TMOUT': '86400', 00:49:26 INFO - 'USER': 'cltbld', 00:49:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', 00:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:26 INFO - '_': '/tools/buildbot/bin/python'} 00:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:26 INFO - Downloading/unpacking flake8 00:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:49:28 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 00:49:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:49:28 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 00:49:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 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 00:49:28 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 00:49:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:49:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:49:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:49:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:49:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:49:29 INFO - no previously-included directories found matching 'docs/_build' 00:49:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:49:29 INFO - Running setup.py install for pep8 00:49:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:49:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:49:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:49:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:49:29 INFO - no previously-included directories found matching 'docs/_build' 00:49:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:49:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:49:29 INFO - Cleaning up... 00:49:29 INFO - Return code: 0 00:49:29 INFO - Running post-action listener: _resource_record_post_action 00:49:29 INFO - Running post-action listener: _start_resource_monitoring 00:49:29 INFO - Starting resource monitoring. 00:49:29 INFO - ##### 00:49:29 INFO - ##### Running install step. 00:49:29 INFO - ##### 00:49:29 INFO - Running pre-action listener: _resource_record_pre_action 00:49:29 INFO - Running main action method: install 00:49:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:49:29 INFO - Reading from file tmpfile_stdout 00:49:29 INFO - Detecting whether we're running mozinstall >=1.0... 00:49:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:49:29 INFO - Reading from file tmpfile_stdout 00:49:29 INFO - Output received: 00:49:29 INFO - Usage: mozinstall [options] installer 00:49:29 INFO - Options: 00:49:29 INFO - -h, --help show this help message and exit 00:49:29 INFO - -d DEST, --destination=DEST 00:49:29 INFO - Directory to install application into. [default: 00:49:29 INFO - "/builds/slave/test"] 00:49:29 INFO - --app=APP Application being installed. [default: firefox] 00:49:29 INFO - mkdir: /builds/slave/test/build/application 00:49:29 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'] 00:49:29 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 00:49:45 INFO - Reading from file tmpfile_stdout 00:49:45 INFO - Output received: 00:49:45 INFO - /builds/slave/test/build/application/firefox/firefox 00:49:45 INFO - Running post-action listener: _resource_record_post_action 00:49:45 INFO - ##### 00:49:45 INFO - ##### Running run-tests step. 00:49:45 INFO - ##### 00:49:45 INFO - Running pre-action listener: _resource_record_pre_action 00:49:45 INFO - Running main action method: run_tests 00:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:49:45 INFO - Python 2.7.3 00:49:45 INFO - Return code: 0 00:49:45 INFO - grabbing minidump binary from tooltool 00:49:45 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')]} 00:49:45 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 0x1c623d0>, '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 0x1bcded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bce360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:49:45 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 00:49:45 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 00:49:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:49:45 INFO - Return code: 0 00:49:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:49:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:49:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:49:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:49:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:49:46 INFO - Return code: 0 00:49:46 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:49:46 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:49:46 INFO - Using env: {'DISPLAY': ':0', 00:49:46 INFO - 'HOME': '/home/cltbld', 00:49:46 INFO - 'LANG': 'en_US.UTF-8', 00:49:46 INFO - 'LANGUAGE': 'en_US:en', 00:49:46 INFO - 'LOGNAME': 'cltbld', 00:49:46 INFO - 'MAIL': '/var/mail/cltbld', 00:49:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:49:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:46 INFO - 'MOZ_NO_REMOTE': '1', 00:49:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:46 INFO - 'NO_EM_RESTART': '1', 00:49:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:46 INFO - 'PWD': '/builds/slave/test', 00:49:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:49:46 INFO - 'SHELL': '/bin/bash', 00:49:46 INFO - 'SHLVL': '1', 00:49:46 INFO - 'TERM': 'linux', 00:49:46 INFO - 'TMOUT': '86400', 00:49:46 INFO - 'USER': 'cltbld', 00:49:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537', 00:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:46 INFO - '_': '/tools/buildbot/bin/python'} 00:49:46 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:49:46 INFO - mozversion application_buildid: 20160113000030 00:49:46 INFO - mozversion application_changeset: 154482173e4021b606157b8b4e085e01dc75673f 00:49:46 INFO - mozversion application_display_name: Nightly 00:49:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:49:46 INFO - mozversion application_name: Firefox 00:49:46 INFO - mozversion application_remotingname: firefox 00:49:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:49:46 INFO - mozversion application_vendor: Mozilla 00:49:46 INFO - mozversion application_version: 46.0a1 00:49:46 INFO - mozversion platform_buildid: 20160113000030 00:49:46 INFO - mozversion platform_changeset: 154482173e4021b606157b8b4e085e01dc75673f 00:49:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:49:46 INFO - mozversion platform_version: 46.0a1 00:49:46 INFO - using testdate: 1452674986 00:49:46 INFO - actual date: 1452674986 00:49:46 INFO - starting webserver on 'localhost:44726' 00:49:46 INFO - SUITE-START | Running 3 tests 00:49:46 INFO - TEST-START | dromaeo_css 00:49:46 INFO - operating with platform_type : linux_ 00:49:46 INFO - Initialising browser for dromaeo_css test... 00:49:46 INFO - TEST-INFO | started process 6426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJRDCg/profile http://localhost:44726/getInfo.html) 00:49:50 INFO - PROCESS | 6426 | 00:49:50 INFO - PROCESS | 6426 | (process:6510): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:49:51 INFO - PROCESS | 6426 | __metrics Screen width/height:1600/1200 00:49:51 INFO - PROCESS | 6426 | colorDepth:24 00:49:51 INFO - PROCESS | 6426 | Browser inner width/height: 1024/697 00:49:51 INFO - PROCESS | 6426 | __metrics 00:49:51 INFO - PROCESS | 6426 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:49:52 INFO - TEST-INFO | 6426: exit 0 00:49:52 INFO - Browser initialized. 00:49:52 INFO - Running cycle 1/1 for dromaeo_css test... 00:49:52 INFO - TEST-INFO | started process 6559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJRDCg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:49:54 INFO - PROCESS | 6559 | 00:49:54 INFO - PROCESS | 6559 | (process:6616): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:50:04 INFO - PROCESS | 6559 | RSS: Main: 150175744 00:50:04 INFO - PROCESS | 6559 | 00:50:54 INFO - PROCESS | 6559 | 1452675054490 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] 00:53:05 INFO - PROCESS | 6559 | Cycle 1(1): loaded http://localhost:44726/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44726/tests/dromaeo/cssquery-ext.html) 00:53:06 INFO - PROCESS | 6559 | RSS: Main: 152756224 00:53:06 INFO - PROCESS | 6559 | 00:56:08 INFO - PROCESS | 6559 | Cycle 1(1): loaded http://localhost:44726/tests/dromaeo/cssquery-ext.html (next: http://localhost:44726/tests/dromaeo/cssquery-jquery.html) 00:56:09 INFO - PROCESS | 6559 | RSS: Main: 151506944 00:56:09 INFO - PROCESS | 6559 | 00:59:11 INFO - PROCESS | 6559 | Cycle 1(1): loaded http://localhost:44726/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44726/tests/dromaeo/cssquery-mootools.html) 00:59:11 INFO - PROCESS | 6559 | RSS: Main: 151126016 00:59:11 INFO - PROCESS | 6559 | 01:02:13 INFO - PROCESS | 6559 | Cycle 1(1): loaded http://localhost:44726/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44726/tests/dromaeo/cssquery-prototype.html) 01:02:14 INFO - PROCESS | 6559 | RSS: Main: 150691840 01:02:14 INFO - PROCESS | 6559 | 01:05:16 INFO - PROCESS | 6559 | Cycle 1(1): loaded http://localhost:44726/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44726/tests/dromaeo/cssquery-yui.html) 01:05:17 INFO - PROCESS | 6559 | RSS: Main: 151707648 01:05:17 INFO - PROCESS | 6559 | 01:08:20 INFO - PROCESS | 6559 | Cycle 1(1): loaded http://localhost:44726/tests/dromaeo/cssquery-yui.html (next: http://localhost:44726/tests/dromaeo/cssquery-dojo.html) 01:08:20 INFO - PROCESS | 6559 | RSS: Main: 153149440 01:08:20 INFO - PROCESS | 6559 | 01:08:20 INFO - PROCESS | 6559 | __start_tp_report 01:08:20 INFO - PROCESS | 6559 | _x_x_mozilla_page_load 01:08:20 INFO - PROCESS | 6559 | _x_x_mozilla_page_load_details 01:08:20 INFO - PROCESS | 6559 | |i|pagename|runs| 01:08:20 INFO - PROCESS | 6559 | |0;dojo.html;2615.0847203478775;2628.947421051579;2632.894684212633;2648.6291919131327;2663.09454785373;4482.0587676587875;4491.618212451942;4516.006478574708;4524.298733696274;4562.927711987681;4472.575105364993;4493.5731105545;4527.660425468087;4591.4260717410325;4597.81608735651;4162.250794856925;4213.47331583552;4262.7655478948645;4292.6780491463105;4303.031817840992;4115.485564304462;4171.144915292358;4174.749515029108;4218.093109981353;4237.555056719031;4011.8796436106963;4109.712320137592;4230.661547076226;4260.723053001545;4267.679924005696;4179.26862799009;4241.957580424218;4270.274053410928;4275.401443797839;4282.379055037002;4153.480814898137;4184.184084103601;4184.958150418487;4190.874273771761;4223.577642235782;4439.356293337481;4464.799084041226;4507.774611269456;4518.638508919312;4541.34150548172;4859.198232291667;4880.560749532559;4881.780319885578;4907.8773030674165;4930.605551555903;4906.1168989581865;4912.901741965176;4919.040787046527;4927.901441971177;4960.727160006199;4430.71200371978;4520.570545798144;4550.726956382561;4584.472785629629;4652.674312798072;5061.316722242524;5069.898602027939;5089.949100508948;5103.336566246364;5147.716875571805;4864.537868902448;4868.075065737498;4872.4153101628035;4881.804727810848;4893.21708526634;4734.597559207437;4863.294822250754;4863.902721945541;4905.092557876804;4964.106460837084;4783.808647654055;4786.7845946932475;4795.832145874878;4806.423229212517;4845.41854977405;4660.813567457331;4723.338732577442;4751.738654374042;4764.666473346832;4782.569568738831;3953.2686453006286;4042.555318914917;4086.7139300248696;4087.509498860156;4125.422440858282;3581.7492775505466;3604.116991337139;3625.691816195653;3628.3287591795074;3645.8906232813056;4116.300228961084;4186.602272784142;4232.830686772495;4254.404383386328;4254.85108021224;4838.056578967067;4895.7062576245535;4900.166971614834;4912.312276281324;4943.703377797344;4175.791210439526;4214.662826973835;4220.282551966112;4223.028703398174;4264.594863487963;4162.646175075092;4240;4309.806058727365;4328.177646247203;4341.261985462479;4626.23667094939;4641.559051890065;4645.024544845553;4654.022655242302;4665.46347170073;4866.05112003156;4896.2655601660035;4905.435874874435;4912.1158191525865;4956.702597844141;4563.406757121553;4590.908181836411;4656.743879086683;4659.324397962208;4688.882777930443;4842.201036829025;4874.780634871368;4897.755112244302;4907.33750943618;4944.975275123601;4945.653804233669;4964.429090654477;4982.402111746614;4996.800127994839;5028.622853285945;4604.769761511978;4690.742009189391;4705.788239529161;4764.166270902509;4840.1529732296;4724.881877953078;4726.71639701619;4741.525847415231;4748.074125545623;4786.2581299898575;4601.769911504478;4617.930731039104;4625.653076019379;4626.306054091779;4670.766461676971;4664.113818374498;4754.0491901619125;4825.806967721252;4852.636052296021;4888.755562221803;4607.677462577587;4656.5110663379855;4659.20793465105;4659.673822832369;4705.647076469347 01:08:20 INFO - PROCESS | 6559 | |1;ext.html;517.8084108879715;554.7047643751839;557.919101730249;559.784482974055;565.9122835960428;32252.83873580632;32826.343473130524;32847.343053138924;32862;32870.342593148125;36185.819070904676;36613.816930915375;36620.26759464809;36632.26735465289;36780;7618;7817;7857.41069419793;7863.13505514393;7868.25251601097;7561.319481246686;7674.923250767477;7709.38324934004;7832.882506762375;7882.80292992674;7816.5700886451505;7907.2488113629115;7914.683412663487;7923.0888447828665;7924.524528528307;7801.453898227126;7880.054393472791;7881.645325960317;7899.842003159962;7918.129005809356;7758.185390533969;7810;7848.13670496245;7900.170482099355;7919.485233459806;36516.0870978225;36710.449343259876;37046.62953370459;37063.629363706284;37157.07107322312;2666.4533770576986;2764.7235276472393;2811.493931092423;3178.7457003439667;3384.2385463270566;27820.86089569539;27935.301617459725;28176.859115704494;28408.289792755346;28410.147695569165;3296.653851345622;3313.37045961269;3334.916627084318;3395.847186876572;3401.540791993074;215199;215572;216745;217031;217462.91268543713;38337.42493862594;38634.227315453536;50931.745341273054;53144.46855531395;53983.19025214625;46281;46380.768096159976;46403.76798115988;46734;46793.06413871703;12366.814497782541;12435.502579896884;12516.81224781629;12530;12536.122471427096;8923.330750193762;8948.776280592907;8989.910100899038;8995.595198215966;9150.81698366029;18243.17905694247;18539.81460185381;18637.81362186388;18646.160922758507;18732.344367947055;7515.812104697427;7754.7673569793;7784.688612455551;7794.454388192886;7860.842783144305;805.2430715127762;821.6179476543316;847.2459511035183;932.5896605493562;939.8449255872705;24718.752812472005;25299.98800048014;25463.36341591438;25516.872415637805;25752.74247257541;942.495764765847;952.9332946693803;954.236610711428;958.9712308630752;985.280745056113;13512.527061552995;13676.65808354799;13748.65628359299;13891.652708682364;14014.159150451005;267234;270408;271672;273541;274985;45806.31290530645;45970.31044534335;45991.31013034807;46170.307445388346;46288.76855615768;1186.3652945674023;1204.7355143714115;1209.0810983652486;1214.481897627965;1215.477344741752;24502.63246051346;26317.34206644849;26367.868160659073;26535.867320663274;26713.732862671903;38338;38611.6138838608;38803.223935521695;38903.22193556056;38938.80530597329;258593;260110;261056;262405;263429;26552.601710973966;27781.16656500308;27867.721322786514;27953.161405157876;28057.43885122327;37406.2518749618;37856.621433786415;38426.23147537089;38842.6115738839;38882.80558597189;31350.216244594067;32586.34827303488;32653.510197346583;32734;33180.50229246515;29120.27199320034;29251.7074829249;29281;29313.560296595995;29451.11646650604;29159.708402915698;32429;32577.511337330434;32871;33129.83435082809;25049.499010020063;26045.609315860656;26830.463390731686;26950.191494255203;27068.32329191786;20517;20946.895265523573;21011;21019;21197.36407907765 01:08:20 INFO - PROCESS | 6559 | |2;jquery.html;341.13862497194583;345.83572802918616;348.44597090625905;350.2260005388092;357.1891805601287;14302.499412520563;14450.421983120676;14915.403383864646;15077.92461037696;15668.138252396113;13271.203727776316;13547.458101675946;13779.517716879911;13787.379567919443;13807.309634518284;4366.978165109178;4510.819567217307;4787.473377928425;5018.623603229754;5036.7481625918745;4247.384129301249;4931.778069986859;4968.031233909389;4969.826056088038;4975.179095449246;4810.807567697288;4976;5008.198688209887;5023.095842748304;5046.7224302663335;4749.382580264543;4921.089598424285;4927.753612319388;4958.231474121517;5238.397584277819;5051.06555287273;5061.190209566488;5066.214736715815;5075.670081444694;5083.05963396769;11426.71433214168;16052.51842444717;17264.223109960083;18156.364527241483;18211.63576728471;1649.9010059396355;1672.774175486306;1728.2482120277718;1777.520069581206;1810.4116162247321;8587.398882078258;8798.824023519557;9318.534073296309;10030.749231269278;12233.755324893453;1657.6601796631662;1678.6978343898093;1694.3392077089945;1774.9201285942163;1809.1406581873637;47352.5264747355;48548.029039419365;49861.75069124668;50199;50840;9522.476263805556;9695.951520242354;9806.852897206547;9850.064243896819;9896.505174741234;12500.374981250901;12520.87479125197;12526.311052892179;12541.811872821914;12558.81161782574;5821.912671309934;6191.81424557264;6257.624542527463;6387.329330420332;6408.423241908251;5639.859003524863;5678.4605462480995;5685.317761868602;5739.512141467939;5759.913601295984;3999.5800440953863;4044.6157615027114;4181.163767246502;4209.726367786084;4234.78826058702;1701.6086300151035;1702.7020271452693;1706.7354560043213;1762.691528982423;1792.587704827897;746.9663865126082;844.7127976488024;852.5992783391796;942.4167398770132;949.4018768176005;14190.787138192729;14270.714585708436;14361.210133442552;14976.62558436026;15459.458918937784;820.8604537228686;837.1419295222446;854.6666799948025;869.1265278395299;934.5654270763991;7958.283754462126;8655.437396569203;8675.652973880975;8762.430442021248;8819.603117859711;418639;420911;448029;476458;482880;53276.73361633167;63495;64144;64202;68369.3163068373;1099.301943266032;1103.939283339424;1109.5561775289787;1122.9831552526718;1127.4982632728356;13556.93221533886;13641.317934103454;13653.180809151483;13804.516841910485;14093.224872632103;30811.38377232398;31286.374272514877;31325.373492529565;31547.684523154476;31718.365632686757;37201.627983719816;38482;38990.6100938987;39827.60172398239;41108.177836443705;6286.748530058747;6536.3790439910035;6603.669816509059;6732.461403087644;6930.584164950119;9539.952300238454;9894.554745036634;10084.495775211064;10445.582176712845;10660.040596346056;8024.638891250024;8382;8490.617922193393;8528.147185281423;8640.438371505832;8639.222469977733;8674.132586741276;8958.596863141043;9036.728898133066;9251.167394934488;8542.316614670935;8712.91287087121;8766.21104100634;8824.779380515538;8827.514486703292;6457.483401327976;6840.555363901331;6931.826704332432;7024.121984751906;7081.327273908971;7522.623868806647;7965.283124518821;8294.29498492635;8383.916160838313;8858.379913406257 01:08:20 INFO - PROCESS | 6559 | |3;mootools.html;1396.6997095624442;1419.0917812599935;1547.2573164880857;1718.5016345259876;1757.8857374270672;6378.585391949531;6457.321981191978;7255.09311336083;7436.628168591569;7466.701331946716;6746.898796518044;6925.168979722441;6970.128733908262;7031.367176954073;7031.648417579114;2166.4042388343173;2218.6561083032075;2219.2454565447742;2221.3224966385246;2224.077008041661;2165.32874808809;2178.9128434862587;2180.029886700411;2196.6814811852273;2198.2745693921047;2155.299527653511;2164.2425151197112;2168.728908886389;2172.196287373666;2189.9452513687206;2172.1202912820177;2193.846430749848;2209.381373215502;2211.0381983837083;2213.944651383712;2122.9150833966623;2153.2678889177755;2161.848670593059;2162.0919213930188;2168.6530155175096;7284.817879553;7318.9634051829935;7327.963360183218;7328.596927169004;7337.3029562191505;4199.4120823084795;4241.088166044285;4249.617534421917;4262.381954616594;4279.122779830159;2786.902458413966;2797.188815243597;2846.6868644449096;2874.2814296425895;2876;844.2359664503634;908.5684299957534;911.1844898815589;1778.7598674179078;1782.875198736089;9548.236141108695;9666.565004574812;9673.37123086997;9680.75798105046;9704.175145112675;3883.708721845873;3949.289127956938;4023.879283621496;4038.2932986727205;4069.308217603015;8001.239882211181;8039.35685145187;8048.5975701215875;8066.475679080841;8074.757757267292;4349.630281426051;4392.297232442857;4408.603225709701;4423.181711383404;4424.292113261863;3362.596488421405;3453.188500702333;3897.376419772879;4033.1328764315813;4055.9797201013807;3298.802071875695;3324.2354258520677;3353.3796247694254;3362.36115138123;3362.4451965425433;966.8888077870994;969.345691658128;972.2659392159017;974.8635191073255;977.9755506112261;1085.831696087092;1086.6522712732008;1096.555894862582;1142.9199956003167;1170.5610396101463;6708.127943367331;6761.966190169116;6763.628000459924;6993.580385176906;6994.370506654425;1016.8423894296396;1028.9897101029044;1031.9587216511406;1035.440861934562;1042.8383600541777;5090.847274581768;5349.063913815066;5352.518273355417;5368.275282836845;5378.91931621026;8496.70261540843;8592.957035214784;8706.608202630898;8827.16141966512;8939.240164585954;8779.780505487286;8902.287816974627;8909.821803563893;8925.464472131693;8932.8660070099;6884.793456196322;6896.3103689631635;7060.646967651597;7106.786796396116;7120.501564890408;6774.153230846145;6783.626900520519;6796.388325050769;6803.489738269748;6834.8633027340165;7925.445218834857;7951.403644726553;7989.081255655674;8075.87886181696;8156.184381561797;7949;8160.97987751531;8612.655493780429;8652.783680407789;8734.301255899385;5224.138017227267;5379.004884096455;6366.522510811615;6436;6450.258220304725;6587.4071333580205;6707.0945422369305;6733.932660673527;6754.662266886734;6757.3242675732035;6400.423961843457;6453.185551470637;6522.543421960418;6612.107365505595;6672.432843208382;6300.338464461349;6405.807825765048;6419.101325814297;6473.708683109177;6500.28496865335;6410.871782564416;6431.903521447089;6462.418382345423;6466.51501137426;6475.643839588868;5966.552508561962;6062.151298818081;6081.148639190428;6081.939180608314;6088;6036.939630603638;6043.637381757108;6048.395160483917;6072.726727297194;6077.20996270482 01:08:20 INFO - PROCESS | 6559 | |4;prototype.html;294.75093545953666;303.40683962852626;307.27176591478184;307.37909422965595;307.873771753581;5479.287692599962;5514.862128446791;5550.1674748787755;5620.803271885485;5621.718914054291;5484.095124304495;5500.972495137528;5507;5517.613767036309;5526.115821468566;4008.8997775055564;4241.384999175133;4243.8090285937205;4244.320908654616;4255.276602977494;4105.2815757242515;4143.70994030418;4229.55589663084;4259.382389553512;4271.530131685512;4203.810828512725;4228.830846766141;4231.682623803227;4232.915341693164;4237.194932962742;4188.199074398038;4234.364845273219;4235.0682849773;4242;4243.04531480416;3727.7576957497945;3732.682721968609;3740.719446041531;3744.0826997385816;3746.981265093657;5179.326687530634;5302.469753024705;5303.363596368422;5308.495692909168;5315.946840531584;4787.61699064074;4799.784009719571;4802.711837289774;4805.087033463666;4812.542808433193;5771.50942169916;5775.913361299584;5777;5778.335491418498;5781.479666830005;3924.823382947774;3942.172143849795;3944.053427177457;3949.980250098731;3952.604739526053;5881.941180588182;6070.57505974582;6093.512518998514;6126.9387306127255;6136.539759518054;4003.8798836034966;4037.555868854424;4039.6162364575316;4041.5958404159937;4041.7372870763306;4091.345384738487;4104.97375656086;4109.260333140004;4109.753414795122;4110.362893751473;4756.548127927841;4758.500357462486;4762.928556071662;4767.642426818003;4778.665493415428;5516.558675305966;5539.944600554023;5699.230603868507;5702.515286200636;5787.5080618147085;1402.4530433131088;1403.2142000479764;1403.3334166271143;1403.5719105672663;1419.3541938417995;976.3360914578155;985.142925654685;990.8365119755304;994.1152374386802;1004.3973615830589;4929.901401971941;4947.109520286383;4970.279309500174;4978;4995.775190116454;5996.700164991733;6006.909896351558;6020.819375418744;6020.939790602126;6033.4871535919065;5023.14606516893;5023.824166154167;5029.270755740397;5032.295478632995;5037.29477873098;3179.7774155809334;3217.4208642444582;3251.9837400813317;3254.1864533866533;3256.9348613028083;5678.829635110953;5690.061139911951;5694.316681998187;5704.201411802351;5714.0571805652435;6192.8761424771255;6202.72087756052;6207.34822843604;6208.286047104641;6210.50315974721;5554.944450555605;5656.123300888369;5661.34894487131;5674.716264186774;5687.77248910039;5951.851203719942;5952.345242023461;5995.760169593342;6002.519798416029;6005.339412664691;5867.911981320369;5870.53035757147;5870.882582348415;5874.118882167709;5875.676837773793;5665.348484924287;5671.517920976763;5683.06229472149;5687.829365119053;5691.3170419549915;3937.4684417603257;3986.740861843971;4003.419504171937;4004;4037.39439084128;5900.64596124234;5985.191999080243;6000.039993601003;6014.0678194879865;6055.424734650202;5801.245838041028;5802.970985145047;5841.912371314519;5856.648601083949;5859.355470898113;5793.94206057934;5828.970855145697;5839.065749480063;5852.853678658068;5858.47273745365;5581.972090139686;5637.379888212376;5663.66018038919;5665.178549110438;5665.433456654301;5892.1161825726485;5897.144913987362;5898.705064746831;5899.085641725539;5899.852503687443;5692.459216374438;5718.971405143114;5725.227094342211;5729.68486733217;5730.341010783646 01:08:20 INFO - PROCESS | 6559 | |5;yui.html;797.9840403191936;801.5871826009607;801.9558924259163;816.452976505741;825.4345773145392;11431.428428578569;11550.711232219177;11568.47941842617;11590.65228043159;11604.361760103191;10533.473326333671;10691.572337106525;10711.410872402015;10729.78540429191;10735.087517560996;773.5552057566907;794.519315813933;798.0901771979948;798.7204478432532;799.9040115186157;802.0375549340786;806.5080301016376;809.0857331215718;809.7044578728751;810.7365106340434;832.4256263178418;834.9123342049088;839.8026463781007;840.9117042710519;841.5497708725833;819.7581713394563;821.8972628421477;823.2960818500156;823.5799742131557;823.7158180427773;612.4640939178219;616.8827922694674;617.1760699466219;617.5491890919609;619.5013014523307;12560.497580096786;12617.558385456558;12617.87382126176;12624.431900564497;12644.304563249018;10971.286866353741;11144.164187685956;11166.274192177483;11219.439028048564;11309.038731707815;9469.384490008197;9561.808763824685;9584.616615335379;9609.423434593948;9674.9516252419;3233.87064517419;3250.349930013983;3254.6094468663673;3306.9173270668184;3347.8995630131135;37145.62854371449;39626.60373396258;40946.181076378605;40988.18023639511;41262;9331.34680572367;9448.149666530046;9610.135087842127;9631.133198012072;9655.420674759536;15885.046897186206;15953.04281743099;15970.281337339848;15972;16023.878328516892;6486.902696459557;6654.168228971379;6742.325767423316;6850.554713943678;6954.165500139914;3556.822158892045;3649.927001459956;3657.213699054663;3709.703223742094;3730.1793605406765;2591.6371707960902;2603.765661090511;2605.895764169412;2609.712931577525;2610.6345111684377;465.95573420524994;470.6470147389458;478.18469509486243;479.07777528257964;481.60989598425385;577.2092233639856;588.5262363797099;591.125134800489;604.6613896218132;619.8481372063783;8149.796255093552;8271.13153118926;8624.223819856243;8625;8845.51349675774;545.4899668809676;614.8217017065001;623.1089541955048;633.1737083106498;637.2130418932707;3649.616790236987;3730.5523337199165;3736.1220113273357;3777.2823163598828;3782.6217378262504;45865;46765.064698705835;46775.29837052447;46794.76602616965;46827.29759053617;42195.7890210547;42772.358414623806;42908.57091429046;43295.134097317874;43375;35508.7024762821;38318.23363532769;38926.2214755709;41375.93120343971;41845.58154418478;7319.63401829917;7925.801854953672;7998.160193179865;8210.63052162642;8339.583020848811;30448.086557403312;30830.38339233158;31315.217119572193;31394;31416.685833141375;35304.293914122085;35732.64267357293;35858.64141358657;37314;38519.614803851604;9658.806823863342;9707.854382184414;9743.269254805777;9782.119609235204;10073.899261007296;11167.441627918734;11170.664880053611;11197.944010280222;11345.376004319842;11412.600558980728;9429.764255893657;9823.115919567274;9872.654457093968;9893.851592226267;10147.086762191439;10125.240606954361;10216.591336346462;10316.226283028953;10378.584856605652;10483.737906552396;9915.355501892642;10094.343867648578;10236.795264094826;10241.692749217535;10253.07722304996;8611.31109511225;8713.956430217808;8809.911900881165;9007.054259302678;9237.07629237071;8822.898424909998;9218.21645160169;9249.491277979776;9255.074492550692;9390.389624674648 01:08:20 INFO - PROCESS | 6559 | __end_tp_report 01:08:20 INFO - PROCESS | 6559 | __start_cc_report 01:08:20 INFO - PROCESS | 6559 | _x_x_mozilla_cycle_collect,320 01:08:20 INFO - PROCESS | 6559 | __end_cc_report 01:08:20 INFO - PROCESS | 6559 | __startTimestamp1452676100377__endTimestamp 01:08:20 INFO - PROCESS | 6559 | 01:08:20 INFO - PROCESS | 6559 | ------- Summary: start ------- 01:08:20 INFO - PROCESS | 6559 | Number of tests: 6 01:08:20 INFO - PROCESS | 6559 | 01:08:20 INFO - PROCESS | 6559 | [#0] dojo.html Cycles:165 Average:4510.96 Median:4626.31 stddev:470.35 (10.2%) stddev-sans-first:447.67 01:08:20 INFO - PROCESS | 6559 | Values: 2615.1 2628.9 2632.9 2648.6 2663.1 4482.1 4491.6 4516.0 4524.3 4562.9 4472.6 4493.6 4527.7 4591.4 4597.8 4162.3 4213.5 4262.8 4292.7 4303.0 4115.5 4171.1 4174.7 4218.1 4237.6 4011.9 4109.7 4230.7 4260.7 4267.7 4179.3 4242.0 4270.3 4275.4 4282.4 4153.5 4184.2 4185.0 4190.9 4223.6 4439.4 4464.8 4507.8 4518.6 4541.3 4859.2 4880.6 4881.8 4907.9 4930.6 4906.1 4912.9 4919.0 4927.9 4960.7 4430.7 4520.6 4550.7 4584.5 4652.7 5061.3 5069.9 5089.9 5103.3 5147.7 4864.5 4868.1 4872.4 4881.8 4893.2 4734.6 4863.3 4863.9 4905.1 4964.1 4783.8 4786.8 4795.8 4806.4 4845.4 4660.8 4723.3 4751.7 4764.7 4782.6 3953.3 4042.6 4086.7 4087.5 4125.4 3581.7 3604.1 3625.7 3628.3 3645.9 4116.3 4186.6 4232.8 4254.4 4254.9 4838.1 4895.7 4900.2 4912.3 4943.7 4175.8 4214.7 4220.3 4223.0 4264.6 4162.6 4240.0 4309.8 4328.2 4341.3 4626.2 4641.6 4645.0 4654.0 4665.5 4866.1 4896.3 4905.4 4912.1 4956.7 4563.4 4590.9 4656.7 4659.3 4688.9 4842.2 4874.8 4897.8 4907.3 4945.0 4945.7 4964.4 4982.4 4996.8 5028.6 4604.8 4690.7 4705.8 4764.2 4840.2 4724.9 4726.7 4741.5 4748.1 4786.3 4601.8 4617.9 4625.7 4626.3 4670.8 4664.1 4754.0 4825.8 4852.6 4888.8 4607.7 4656.5 4659.2 4659.7 4705.6 01:08:20 INFO - PROCESS | 6559 | 01:08:20 INFO - PROCESS | 6559 | [#1] ext.html Cycles:180 Average:39745.42 Median:18257.71 stddev:65438.31 (358.4%) stddev-sans-first:65555.60 01:08:20 INFO - PROCESS | 6559 | Values: 517.8 554.7 557.9 559.8 565.9 32252.8 32826.3 32847.3 32862.0 32870.3 36185.8 36613.8 36620.3 36632.3 36780.0 7618.0 7817.0 7857.4 7863.1 7868.3 7561.3 7674.9 7709.4 7832.9 7882.8 7816.6 7907.2 7914.7 7923.1 7924.5 7801.5 7880.1 7881.6 7899.8 7918.1 7758.2 7810.0 7848.1 7900.2 7919.5 36516.1 36710.4 37046.6 37063.6 37157.1 2666.5 2764.7 2811.5 3178.7 3384.2 27820.9 27935.3 28176.9 28408.3 28410.1 3296.7 3313.4 3334.9 3395.8 3401.5 215199.0 215572.0 216745.0 217031.0 217462.9 38337.4 38634.2 50931.7 53144.5 53983.2 46281.0 46380.8 46403.8 46734.0 46793.1 12366.8 12435.5 12516.8 12530.0 12536.1 8923.3 8948.8 8989.9 8995.6 9150.8 18243.2 18539.8 18637.8 18646.2 18732.3 7515.8 7754.8 7784.7 7794.5 7860.8 805.2 821.6 847.2 932.6 939.8 24718.8 25300.0 25463.4 25516.9 25752.7 942.5 952.9 954.2 959.0 985.3 13512.5 13676.7 13748.7 13891.7 14014.2 267234.0 270408.0 271672.0 273541.0 274985.0 45806.3 45970.3 45991.3 46170.3 46288.8 1186.4 1204.7 1209.1 1214.5 1215.5 24502.6 26317.3 26367.9 26535.9 26713.7 38338.0 38611.6 38803.2 38903.2 38938.8 258593.0 260110.0 261056.0 262405.0 263429.0 26552.6 27781.2 27867.7 27953.2 28057.4 37406.3 37856.6 38426.2 38842.6 38882.8 31350.2 32586.3 32653.5 32734.0 33180.5 29120.3 29251.7 29281.0 29313.6 29451.1 29159.7 32429.0 32577.5 32871.0 33129.8 25049.5 26045.6 26830.5 26950.2 27068.3 20517.0 20946.9 21011.0 21019.0 21197.4 01:08:20 INFO - PROCESS | 6559 | 01:08:20 INFO - PROCESS | 6559 | [#2] jquery.html Cycles:180 Average:23682.19 Median:4945.00 stddev:73537.83 (1487.1%) stddev-sans-first:73723.23 01:08:20 INFO - PROCESS | 6559 | Values: 341.1 345.8 348.4 350.2 357.2 14302.5 14450.4 14915.4 15077.9 15668.1 13271.2 13547.5 13779.5 13787.4 13807.3 4367.0 4510.8 4787.5 5018.6 5036.7 4247.4 4931.8 4968.0 4969.8 4975.2 4810.8 4976.0 5008.2 5023.1 5046.7 4749.4 4921.1 4927.8 4958.2 5238.4 5051.1 5061.2 5066.2 5075.7 5083.1 11426.7 16052.5 17264.2 18156.4 18211.6 1649.9 1672.8 1728.2 1777.5 1810.4 8587.4 8798.8 9318.5 10030.7 12233.8 1657.7 1678.7 1694.3 1774.9 1809.1 47352.5 48548.0 49861.8 50199.0 50840.0 9522.5 9696.0 9806.9 9850.1 9896.5 12500.4 12520.9 12526.3 12541.8 12558.8 5821.9 6191.8 6257.6 6387.3 6408.4 5639.9 5678.5 5685.3 5739.5 5759.9 3999.6 4044.6 4181.2 4209.7 4234.8 1701.6 1702.7 1706.7 1762.7 1792.6 747.0 844.7 852.6 942.4 949.4 14190.8 14270.7 14361.2 14976.6 15459.5 820.9 837.1 854.7 869.1 934.6 7958.3 8655.4 8675.7 8762.4 8819.6 418639.0 420911.0 448029.0 476458.0 482880.0 53276.7 63495.0 64144.0 64202.0 68369.3 1099.3 1103.9 1109.6 1123.0 1127.5 13556.9 13641.3 13653.2 13804.5 14093.2 30811.4 31286.4 31325.4 31547.7 31718.4 37201.6 38482.0 38990.6 39827.6 41108.2 6286.7 6536.4 6603.7 6732.5 6930.6 9540.0 9894.6 10084.5 10445.6 10660.0 8024.6 8382.0 8490.6 8528.1 8640.4 8639.2 8674.1 8958.6 9036.7 9251.2 8542.3 8712.9 8766.2 8824.8 8827.5 6457.5 6840.6 6931.8 7024.1 7081.3 7522.6 7965.3 8294.3 8383.9 8858.4 01:08:20 INFO - PROCESS | 6559 | 01:08:20 INFO - PROCESS | 6559 | [#3] mootools.html Cycles:180 Average:5071.88 Median:6372.55 stddev:2597.54 (40.8%) stddev-sans-first:2590.14 01:08:20 INFO - PROCESS | 6559 | Values: 1396.7 1419.1 1547.3 1718.5 1757.9 6378.6 6457.3 7255.1 7436.6 7466.7 6746.9 6925.2 6970.1 7031.4 7031.6 2166.4 2218.7 2219.2 2221.3 2224.1 2165.3 2178.9 2180.0 2196.7 2198.3 2155.3 2164.2 2168.7 2172.2 2189.9 2172.1 2193.8 2209.4 2211.0 2213.9 2122.9 2153.3 2161.8 2162.1 2168.7 7284.8 7319.0 7328.0 7328.6 7337.3 4199.4 4241.1 4249.6 4262.4 4279.1 2786.9 2797.2 2846.7 2874.3 2876.0 844.2 908.6 911.2 1778.8 1782.9 9548.2 9666.6 9673.4 9680.8 9704.2 3883.7 3949.3 4023.9 4038.3 4069.3 8001.2 8039.4 8048.6 8066.5 8074.8 4349.6 4392.3 4408.6 4423.2 4424.3 3362.6 3453.2 3897.4 4033.1 4056.0 3298.8 3324.2 3353.4 3362.4 3362.4 966.9 969.3 972.3 974.9 978.0 1085.8 1086.7 1096.6 1142.9 1170.6 6708.1 6762.0 6763.6 6993.6 6994.4 1016.8 1029.0 1032.0 1035.4 1042.8 5090.8 5349.1 5352.5 5368.3 5378.9 8496.7 8593.0 8706.6 8827.2 8939.2 8779.8 8902.3 8909.8 8925.5 8932.9 6884.8 6896.3 7060.6 7106.8 7120.5 6774.2 6783.6 6796.4 6803.5 6834.9 7925.4 7951.4 7989.1 8075.9 8156.2 7949.0 8161.0 8612.7 8652.8 8734.3 5224.1 5379.0 6366.5 6436.0 6450.3 6587.4 6707.1 6733.9 6754.7 6757.3 6400.4 6453.2 6522.5 6612.1 6672.4 6300.3 6405.8 6419.1 6473.7 6500.3 6410.9 6431.9 6462.4 6466.5 6475.6 5966.6 6062.2 6081.1 6081.9 6088.0 6036.9 6043.6 6048.4 6072.7 6077.2 01:08:20 INFO - PROCESS | 6559 | 01:08:20 INFO - PROCESS | 6559 | [#4] prototype.html Cycles:180 Average:4778.06 Median:5515.71 stddev:1427.51 (25.9%) stddev-sans-first:1391.29 01:08:20 INFO - PROCESS | 6559 | Values: 294.8 303.4 307.3 307.4 307.9 5479.3 5514.9 5550.2 5620.8 5621.7 5484.1 5501.0 5507.0 5517.6 5526.1 4008.9 4241.4 4243.8 4244.3 4255.3 4105.3 4143.7 4229.6 4259.4 4271.5 4203.8 4228.8 4231.7 4232.9 4237.2 4188.2 4234.4 4235.1 4242.0 4243.0 3727.8 3732.7 3740.7 3744.1 3747.0 5179.3 5302.5 5303.4 5308.5 5315.9 4787.6 4799.8 4802.7 4805.1 4812.5 5771.5 5775.9 5777.0 5778.3 5781.5 3924.8 3942.2 3944.1 3950.0 3952.6 5881.9 6070.6 6093.5 6126.9 6136.5 4003.9 4037.6 4039.6 4041.6 4041.7 4091.3 4105.0 4109.3 4109.8 4110.4 4756.5 4758.5 4762.9 4767.6 4778.7 5516.6 5539.9 5699.2 5702.5 5787.5 1402.5 1403.2 1403.3 1403.6 1419.4 976.3 985.1 990.8 994.1 1004.4 4929.9 4947.1 4970.3 4978.0 4995.8 5996.7 6006.9 6020.8 6020.9 6033.5 5023.1 5023.8 5029.3 5032.3 5037.3 3179.8 3217.4 3252.0 3254.2 3256.9 5678.8 5690.1 5694.3 5704.2 5714.1 6192.9 6202.7 6207.3 6208.3 6210.5 5554.9 5656.1 5661.3 5674.7 5687.8 5951.9 5952.3 5995.8 6002.5 6005.3 5867.9 5870.5 5870.9 5874.1 5875.7 5665.3 5671.5 5683.1 5687.8 5691.3 3937.5 3986.7 4003.4 4004.0 4037.4 5900.6 5985.2 6000.0 6014.1 6055.4 5801.2 5803.0 5841.9 5856.6 5859.4 5793.9 5829.0 5839.1 5852.9 5858.5 5582.0 5637.4 5663.7 5665.2 5665.4 5892.1 5897.1 5898.7 5899.1 5899.9 5692.5 5719.0 5725.2 5729.7 5730.3 01:08:20 INFO - PROCESS | 6559 | 01:08:20 INFO - PROCESS | 6559 | [#5] yui.html Cycles:180 Average:11934.96 Median:46811.03 stddev:13184.88 (28.2%) stddev-sans-first:13195.34 01:08:20 INFO - PROCESS | 6559 | Values: 798.0 801.6 802.0 816.5 825.4 11431.4 11550.7 11568.5 11590.7 11604.4 10533.5 10691.6 10711.4 10729.8 10735.1 773.6 794.5 798.1 798.7 799.9 802.0 806.5 809.1 809.7 810.7 832.4 834.9 839.8 840.9 841.5 819.8 821.9 823.3 823.6 823.7 612.5 616.9 617.2 617.5 619.5 12560.5 12617.6 12617.9 12624.4 12644.3 10971.3 11144.2 11166.3 11219.4 11309.0 9469.4 9561.8 9584.6 9609.4 9675.0 3233.9 3250.3 3254.6 3306.9 3347.9 37145.6 39626.6 40946.2 40988.2 41262.0 9331.3 9448.1 9610.1 9631.1 9655.4 15885.0 15953.0 15970.3 15972.0 16023.9 6486.9 6654.2 6742.3 6850.6 6954.2 3556.8 3649.9 3657.2 3709.7 3730.2 2591.6 2603.8 2605.9 2609.7 2610.6 466.0 470.6 478.2 479.1 481.6 577.2 588.5 591.1 604.7 619.8 8149.8 8271.1 8624.2 8625.0 8845.5 545.5 614.8 623.1 633.2 637.2 3649.6 3730.6 3736.1 3777.3 3782.6 45865.0 46765.1 46775.3 46794.8 46827.3 42195.8 42772.4 42908.6 43295.1 43375.0 35508.7 38318.2 38926.2 41375.9 41845.6 7319.6 7925.8 7998.2 8210.6 8339.6 30448.1 30830.4 31315.2 31394.0 31416.7 35304.3 35732.6 35858.6 37314.0 38519.6 9658.8 9707.9 9743.3 9782.1 10073.9 11167.4 11170.7 11197.9 11345.4 11412.6 9429.8 9823.1 9872.7 9893.9 10147.1 10125.2 10216.6 10316.2 10378.6 10483.7 9915.4 10094.3 10236.8 10241.7 10253.1 8611.3 8714.0 8809.9 9007.1 9237.1 8822.9 9218.2 9249.5 9255.1 9390.4 01:08:20 INFO - PROCESS | 6559 | -------- Summary: end -------- 01:08:20 INFO - PROCESS | 6559 | 01:08:21 INFO - TEST-INFO | 6559: exit 0 01:08:21 INFO - TEST-OK | dromaeo_css | took 1114427ms 01:08:21 INFO - TEST-START | kraken 01:08:21 INFO - operating with platform_type : linux_ 01:08:21 INFO - Initialising browser for kraken test... 01:08:21 INFO - TEST-INFO | started process 6799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl5_OhJ/profile http://localhost:44726/getInfo.html) 01:08:24 INFO - PROCESS | 6799 | 01:08:24 INFO - PROCESS | 6799 | (process:6876): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:08:25 INFO - PROCESS | 6799 | __metrics Screen width/height:1600/1200 01:08:25 INFO - PROCESS | 6799 | colorDepth:24 01:08:25 INFO - PROCESS | 6799 | Browser inner width/height: 1024/697 01:08:25 INFO - PROCESS | 6799 | __metrics 01:08:26 INFO - PROCESS | 6799 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:08:26 INFO - TEST-INFO | 6799: exit 0 01:08:26 INFO - Browser initialized. 01:08:26 INFO - Running cycle 1/1 for kraken test... 01:08:26 INFO - TEST-INFO | started process 6925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl5_OhJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:08:28 INFO - PROCESS | 6925 | 01:08:28 INFO - PROCESS | 6925 | (process:6981): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:08:38 INFO - PROCESS | 6925 | RSS: Main: 149979136 01:08:38 INFO - PROCESS | 6925 | 01:08:41 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44726/tests/kraken/driver.html?testName=audio-beat-detection) 01:08:42 INFO - PROCESS | 6925 | RSS: Main: 149725184 01:08:42 INFO - PROCESS | 6925 | 01:08:44 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44726/tests/kraken/driver.html?testName=audio-dft) 01:08:45 INFO - PROCESS | 6925 | RSS: Main: 149753856 01:08:45 INFO - PROCESS | 6925 | 01:08:48 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44726/tests/kraken/driver.html?testName=audio-fft) 01:08:49 INFO - PROCESS | 6925 | RSS: Main: 145846272 01:08:49 INFO - PROCESS | 6925 | 01:08:51 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44726/tests/kraken/driver.html?testName=audio-oscillator) 01:08:51 INFO - PROCESS | 6925 | RSS: Main: 146378752 01:08:51 INFO - PROCESS | 6925 | 01:08:54 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44726/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:08:54 INFO - PROCESS | 6925 | RSS: Main: 147001344 01:08:54 INFO - PROCESS | 6925 | 01:08:57 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44726/tests/kraken/driver.html?testName=imaging-darkroom) 01:08:58 INFO - PROCESS | 6925 | RSS: Main: 147271680 01:08:58 INFO - PROCESS | 6925 | 01:09:01 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44726/tests/kraken/driver.html?testName=imaging-desaturate) 01:09:02 INFO - PROCESS | 6925 | RSS: Main: 146198528 01:09:02 INFO - PROCESS | 6925 | 01:09:05 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44726/tests/kraken/driver.html?testName=json-parse-financial) 01:09:05 INFO - PROCESS | 6925 | RSS: Main: 146493440 01:09:05 INFO - PROCESS | 6925 | 01:09:07 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44726/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:09:08 INFO - PROCESS | 6925 | RSS: Main: 148324352 01:09:08 INFO - PROCESS | 6925 | 01:09:10 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44726/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:09:10 INFO - PROCESS | 6925 | RSS: Main: 147771392 01:09:10 INFO - PROCESS | 6925 | 01:09:12 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44726/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:09:13 INFO - PROCESS | 6925 | RSS: Main: 148430848 01:09:13 INFO - PROCESS | 6925 | 01:09:16 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:09:16 INFO - PROCESS | 6925 | RSS: Main: 148922368 01:09:16 INFO - PROCESS | 6925 | 01:09:19 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:09:19 INFO - PROCESS | 6925 | RSS: Main: 148021248 01:09:19 INFO - PROCESS | 6925 | 01:09:21 INFO - PROCESS | 6925 | Cycle 1(1): loaded http://localhost:44726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44726/tests/kraken/driver.html?testName=ai-astar) 01:09:22 INFO - PROCESS | 6925 | RSS: Main: 148688896 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | __start_tp_report 01:09:22 INFO - PROCESS | 6925 | _x_x_mozilla_page_load 01:09:22 INFO - PROCESS | 6925 | _x_x_mozilla_page_load_details 01:09:22 INFO - PROCESS | 6925 | |i|pagename|runs| 01:09:22 INFO - PROCESS | 6925 | |0;ai-astar;115;110;114;113;115;125;113;114;114;115 01:09:22 INFO - PROCESS | 6925 | |1;audio-beat-detection;168;131;157;172;133;161;157;135;169;131 01:09:22 INFO - PROCESS | 6925 | |2;audio-dft;172;163;164;162;171;165;173;164;165;165 01:09:22 INFO - PROCESS | 6925 | |3;audio-fft;73;73;73;137;75;73;74;74;150;74 01:09:22 INFO - PROCESS | 6925 | |4;audio-oscillator;98;97;142;97;97;98;134;97;96;132 01:09:22 INFO - PROCESS | 6925 | |5;imaging-gaussian-blur;109;110;110;109;111;110;110;110;110;110 01:09:22 INFO - PROCESS | 6925 | |6;imaging-darkroom;147;149;149;148;149;147;152;147;149;147 01:09:22 INFO - PROCESS | 6925 | |7;imaging-desaturate;96;97;96;97;96;97;96;97;96;96 01:09:22 INFO - PROCESS | 6925 | |8;json-parse-financial;72;71;74;72;70;71;70;70;72;72 01:09:22 INFO - PROCESS | 6925 | |9;json-stringify-tinderbox;66;67;67;67;68;67;67;68;67;69 01:09:22 INFO - PROCESS | 6925 | |10;stanford-crypto-aes;83;82;86;83;85;89;84;84;100;105 01:09:22 INFO - PROCESS | 6925 | |11;stanford-crypto-ccm;138;134;129;121;126;126;122;130;140;123 01:09:22 INFO - PROCESS | 6925 | |12;stanford-crypto-pbkdf2;135;154;151;156;146;133;142;150;139;138 01:09:22 INFO - PROCESS | 6925 | |13;stanford-crypto-sha256-iterative;70;69;69;73;72;70;72;73;68;71 01:09:22 INFO - PROCESS | 6925 | __end_tp_report 01:09:22 INFO - PROCESS | 6925 | __start_cc_report 01:09:22 INFO - PROCESS | 6925 | _x_x_mozilla_cycle_collect,782 01:09:22 INFO - PROCESS | 6925 | __end_cc_report 01:09:22 INFO - PROCESS | 6925 | __startTimestamp1452676162011__endTimestamp 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | ------- Summary: start ------- 01:09:22 INFO - PROCESS | 6925 | Number of tests: 14 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.50 stddev:3.88 (3.4%) stddev-sans-first:4.12 01:09:22 INFO - PROCESS | 6925 | Values: 115.0 110.0 114.0 113.0 115.0 125.0 113.0 114.0 114.0 115.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:159.00 stddev:17.01 (10.7%) stddev-sans-first:16.95 01:09:22 INFO - PROCESS | 6925 | Values: 168.0 131.0 157.0 172.0 133.0 161.0 157.0 135.0 169.0 131.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#2] audio-dft Cycles:10 Average:166.40 Median:165.00 stddev:4.01 (2.4%) stddev-sans-first:3.70 01:09:22 INFO - PROCESS | 6925 | Values: 172.0 163.0 164.0 162.0 171.0 165.0 173.0 164.0 165.0 165.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#3] audio-fft Cycles:10 Average:87.60 Median:73.50 stddev:29.63 (40.3%) stddev-sans-first:30.95 01:09:22 INFO - PROCESS | 6925 | Values: 73.0 73.0 73.0 137.0 75.0 73.0 74.0 74.0 150.0 74.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:97.00 stddev:18.94 (19.5%) stddev-sans-first:19.69 01:09:22 INFO - PROCESS | 6925 | Values: 98.0 97.0 142.0 97.0 97.0 98.0 134.0 97.0 96.0 132.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 01:09:22 INFO - PROCESS | 6925 | Values: 109.0 110.0 110.0 109.0 111.0 110.0 110.0 110.0 110.0 110.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:1.58 (1.1%) stddev-sans-first:1.59 01:09:22 INFO - PROCESS | 6925 | Values: 147.0 149.0 149.0 148.0 149.0 147.0 152.0 147.0 149.0 147.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:09:22 INFO - PROCESS | 6925 | Values: 96.0 97.0 96.0 97.0 96.0 97.0 96.0 97.0 96.0 96.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#8] json-parse-financial Cycles:10 Average:71.40 Median:72.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 01:09:22 INFO - PROCESS | 6925 | Values: 72.0 71.0 74.0 72.0 70.0 71.0 70.0 70.0 72.0 72.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 01:09:22 INFO - PROCESS | 6925 | Values: 66.0 67.0 67.0 67.0 68.0 67.0 67.0 68.0 67.0 69.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:84.00 stddev:7.92 (9.4%) stddev-sans-first:8.19 01:09:22 INFO - PROCESS | 6925 | Values: 83.0 82.0 86.0 83.0 85.0 89.0 84.0 84.0 100.0 105.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:129.50 stddev:6.62 (5.1%) stddev-sans-first:6.15 01:09:22 INFO - PROCESS | 6925 | Values: 138.0 134.0 129.0 121.0 126.0 126.0 122.0 130.0 140.0 123.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:148.00 stddev:8.15 (5.5%) stddev-sans-first:7.91 01:09:22 INFO - PROCESS | 6925 | Values: 135.0 154.0 151.0 156.0 146.0 133.0 142.0 150.0 139.0 138.0 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - PROCESS | 6925 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.50 stddev:1.77 (2.5%) stddev-sans-first:1.86 01:09:22 INFO - PROCESS | 6925 | Values: 70.0 69.0 69.0 73.0 72.0 70.0 72.0 73.0 68.0 71.0 01:09:22 INFO - PROCESS | 6925 | -------- Summary: end -------- 01:09:22 INFO - PROCESS | 6925 | 01:09:22 INFO - TEST-INFO | 6925: exit 0 01:09:23 INFO - TEST-OK | kraken | took 61932ms 01:09:23 INFO - TEST-START | v8_7 01:09:23 INFO - operating with platform_type : linux_ 01:09:23 INFO - Initialising browser for v8_7 test... 01:09:23 INFO - TEST-INFO | started process 7209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9DECIa/profile http://localhost:44726/getInfo.html) 01:09:26 INFO - PROCESS | 7209 | 01:09:26 INFO - PROCESS | 7209 | (process:7280): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:09:27 INFO - PROCESS | 7209 | __metrics Screen width/height:1600/1200 01:09:27 INFO - PROCESS | 7209 | colorDepth:24 01:09:27 INFO - PROCESS | 7209 | Browser inner width/height: 1024/697 01:09:27 INFO - PROCESS | 7209 | __metrics 01:09:27 INFO - PROCESS | 7209 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:09:28 INFO - TEST-INFO | 7209: exit 0 01:09:28 INFO - Browser initialized. 01:09:28 INFO - Running cycle 1/1 for v8_7 test... 01:09:28 INFO - TEST-INFO | started process 7329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9DECIa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:30 INFO - PROCESS | 7329 | 01:09:30 INFO - PROCESS | 7329 | (process:7385): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:09:40 INFO - PROCESS | 7329 | RSS: Main: 150384640 01:09:40 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | Cycle 1(1): loaded http://localhost:44726/tests/v8_7/run.html (next: http://localhost:44726/tests/v8_7/run.html) 01:10:03 INFO - PROCESS | 7329 | RSS: Main: 145350656 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | __start_tp_report 01:10:03 INFO - PROCESS | 7329 | _x_x_mozilla_page_load 01:10:03 INFO - PROCESS | 7329 | _x_x_mozilla_page_load_details 01:10:03 INFO - PROCESS | 7329 | |i|pagename|runs| 01:10:03 INFO - PROCESS | 7329 | |0;Richards;166.38935108153078 01:10:03 INFO - PROCESS | 7329 | |1;DeltaBlue;186.25442354255912 01:10:03 INFO - PROCESS | 7329 | |2;Encrypt;278.2415136338342 01:10:03 INFO - PROCESS | 7329 | |3;Decrypt;5208.333333333333 01:10:03 INFO - PROCESS | 7329 | |4;RayTrace;1094.0919037199126 01:10:03 INFO - PROCESS | 7329 | |5;Earley;732.6007326007326 01:10:03 INFO - PROCESS | 7329 | |6;Boyer;12256.09756097561 01:10:03 INFO - PROCESS | 7329 | |7;RegExp;43042.55319148936 01:10:03 INFO - PROCESS | 7329 | |8;Splay;612.7450980392157 01:10:03 INFO - PROCESS | 7329 | |9;NavierStokes;4850.241545893719 01:10:03 INFO - PROCESS | 7329 | __end_tp_report 01:10:03 INFO - PROCESS | 7329 | __startTimestamp1452676203496__endTimestamp 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | ------- Summary: start ------- 01:10:03 INFO - PROCESS | 7329 | Number of tests: 10 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 01:10:03 INFO - PROCESS | 7329 | Values: 166.4 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | [#1] DeltaBlue Cycles:1 Average:186.25 Median:186.25 stddev:0.00 (0.0%) 01:10:03 INFO - PROCESS | 7329 | Values: 186.3 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 01:10:03 INFO - PROCESS | 7329 | Values: 278.2 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 01:10:03 INFO - PROCESS | 7329 | Values: 5208.3 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | [#4] RayTrace Cycles:1 Average:1094.09 Median:1094.09 stddev:0.00 (0.0%) 01:10:03 INFO - PROCESS | 7329 | Values: 1094.1 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | [#5] Earley Cycles:1 Average:732.60 Median:732.60 stddev:0.00 (0.0%) 01:10:03 INFO - PROCESS | 7329 | Values: 732.6 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 01:10:03 INFO - PROCESS | 7329 | Values: 12256.1 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | [#7] RegExp Cycles:1 Average:43042.55 Median:43042.55 stddev:0.00 (0.0%) 01:10:03 INFO - PROCESS | 7329 | Values: 43042.6 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | [#8] Splay Cycles:1 Average:612.75 Median:612.75 stddev:0.00 (0.0%) 01:10:03 INFO - PROCESS | 7329 | Values: 612.7 01:10:03 INFO - PROCESS | 7329 | 01:10:03 INFO - PROCESS | 7329 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 01:10:03 INFO - PROCESS | 7329 | Values: 4850.2 01:10:03 INFO - PROCESS | 7329 | -------- Summary: end -------- 01:10:03 INFO - PROCESS | 7329 | 01:10:04 INFO - TEST-INFO | 7329: exit 0 01:10:04 INFO - TEST-OK | v8_7 | took 41477ms 01:10:04 INFO - SUITE-END | took 1217s 01:10:04 INFO - Completed test suite (00:20:17) 01:10:04 INFO - Working with test: dromaeo_css 01:10:04 INFO - Generating results file: dromaeo_css 01:10:04 INFO - Working with test: kraken 01:10:04 INFO - Generating results file: kraken 01:10:04 INFO - javascript benchmark 01:10:04 INFO - Working with test: v8_7 01:10:04 INFO - Generating results file: v8_7 01:10:04 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:10:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 01:10:08 INFO - process_Request line: dromaeo_css 6173.74 graph.html#tests=[[72,132,43]] 01:10:08 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:10:08 INFO - process_Request line: kraken 1554.50 graph.html#tests=[[232,132,43]] 01:10:08 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:10:08 INFO - process_Request line: v8_7 20184.41 graph.html#tests=[[230,132,43]] 01:10:08 INFO - RETURN: dromaeo_css: 6173.74 01:10:08 INFO - RETURN: kraken: 1554.50 01:10:08 INFO - RETURN: v8_7: 20184.41 01:10:08 INFO - javascript benchmark 01:10:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2615.0847203478775, 2628.947421051579, 2632.894684212633, 2648.6291919131327, 2663.09454785373, 4482.0587676587875, 4491.618212451942, 4516.006478574708, 4524.298733696274, 4562.927711987681, 4472.575105364993, 4493.5731105545, 4527.660425468087, 4591.4260717410325, 4597.81608735651, 4162.250794856925, 4213.47331583552, 4262.7655478948645, 4292.6780491463105, 4303.031817840992, 4115.485564304462, 4171.144915292358, 4174.749515029108, 4218.093109981353, 4237.555056719031, 4011.8796436106963, 4109.712320137592, 4230.661547076226, 4260.723053001545, 4267.679924005696, 4179.26862799009, 4241.957580424218, 4270.274053410928, 4275.401443797839, 4282.379055037002, 4153.480814898137, 4184.184084103601, 4184.958150418487, 4190.874273771761, 4223.577642235782, 4439.356293337481, 4464.799084041226, 4507.774611269456, 4518.638508919312, 4541.34150548172, 4859.198232291667, 4880.560749532559, 4881.780319885578, 4907.8773030674165, 4930.605551555903, 4906.1168989581865, 4912.901741965176, 4919.040787046527, 4927.901441971177, 4960.727160006199, 4430.71200371978, 4520.570545798144, 4550.726956382561, 4584.472785629629, 4652.674312798072, 5061.316722242524, 5069.898602027939, 5089.949100508948, 5103.336566246364, 5147.716875571805, 4864.537868902448, 4868.075065737498, 4872.4153101628035, 4881.804727810848, 4893.21708526634, 4734.597559207437, 4863.294822250754, 4863.902721945541, 4905.092557876804, 4964.106460837084, 4783.808647654055, 4786.7845946932475, 4795.832145874878, 4806.423229212517, 4845.41854977405, 4660.813567457331, 4723.338732577442, 4751.738654374042, 4764.666473346832, 4782.569568738831, 3953.2686453006286, 4042.555318914917, 4086.7139300248696, 4087.509498860156, 4125.422440858282, 3581.7492775505466, 3604.116991337139, 3625.691816195653, 3628.3287591795074, 3645.8906232813056, 4116.300228961084, 4186.602272784142, 4232.830686772495, 4254.404383386328, 4254.85108021224, 4838.056578967067, 4895.7062576245535, 4900.166971614834, 4912.312276281324, 4943.703377797344, 4175.791210439526, 4214.662826973835, 4220.282551966112, 4223.028703398174, 4264.594863487963, 4162.646175075092, 4240.0, 4309.806058727365, 4328.177646247203, 4341.261985462479, 4626.23667094939, 4641.559051890065, 4645.024544845553, 4654.022655242302, 4665.46347170073, 4866.05112003156, 4896.2655601660035, 4905.435874874435, 4912.1158191525865, 4956.702597844141, 4563.406757121553, 4590.908181836411, 4656.743879086683, 4659.324397962208, 4688.882777930443, 4842.201036829025, 4874.780634871368, 4897.755112244302, 4907.33750943618, 4944.975275123601, 4945.653804233669, 4964.429090654477, 4982.402111746614, 4996.800127994839, 5028.622853285945, 4604.769761511978, 4690.742009189391, 4705.788239529161, 4764.166270902509, 4840.1529732296, 4724.881877953078, 4726.71639701619, 4741.525847415231, 4748.074125545623, 4786.2581299898575, 4601.769911504478, 4617.930731039104, 4625.653076019379, 4626.306054091779, 4670.766461676971, 4664.113818374498, 4754.0491901619125, 4825.806967721252, 4852.636052296021, 4888.755562221803, 4607.677462577587, 4656.5110663379855, 4659.20793465105, 4659.673822832369, 4705.647076469347], "unit": "score", "name": "dojo.html", "value": 4481.9153333135755}, {"lowerIsBetter": false, "replicates": [517.8084108879715, 554.7047643751839, 557.919101730249, 559.784482974055, 565.9122835960428, 32252.83873580632, 32826.343473130524, 32847.343053138924, 32862.0, 32870.342593148125, 36185.819070904676, 36613.816930915375, 36620.26759464809, 36632.26735465289, 36780.0, 7618.0, 7817.0, 7857.41069419793, 7863.13505514393, 7868.25251601097, 7561.319481246686, 7674.923250767477, 7709.38324934004, 7832.882506762375, 7882.80292992674, 7816.5700886451505, 7907.2488113629115, 7914.683412663487, 7923.0888447828665, 7924.524528528307, 7801.453898227126, 7880.054393472791, 7881.645325960317, 7899.842003159962, 7918.129005809356, 7758.185390533969, 7810.0, 7848.13670496245, 7900.170482099355, 7919.485233459806, 36516.0870978225, 36710.449343259876, 37046.62953370459, 37063.629363706284, 37157.07107322312, 2666.4533770576986, 2764.7235276472393, 2811.493931092423, 3178.7457003439667, 3384.2385463270566, 27820.86089569539, 27935.301617459725, 28176.859115704494, 28408.289792755346, 28410.147695569165, 3296.653851345622, 3313.37045961269, 3334.916627084318, 3395.847186876572, 3401.540791993074, 215199.0, 215572.0, 216745.0, 217031.0, 217462.91268543713, 38337.42493862594, 38634.227315453536, 50931.745341273054, 53144.46855531395, 53983.19025214625, 46281.0, 46380.768096159976, 46403.76798115988, 46734.0, 46793.06413871703, 12366.814497782541, 12435.502579896884, 12516.81224781629, 12530.0, 12536.122471427096, 8923.330750193762, 8948.776280592907, 8989.910100899038, 8995.595198215966, 9150.81698366029, 18243.17905694247, 18539.81460185381, 18637.81362186388, 18646.160922758507, 18732.344367947055, 7515.812104697427, 7754.7673569793, 7784.688612455551, 7794.454388192886, 7860.842783144305, 805.2430715127762, 821.6179476543316, 847.2459511035183, 932.5896605493562, 939.8449255872705, 24718.752812472005, 25299.98800048014, 25463.36341591438, 25516.872415637805, 25752.74247257541, 942.495764765847, 952.9332946693803, 954.236610711428, 958.9712308630752, 985.280745056113, 13512.527061552995, 13676.65808354799, 13748.65628359299, 13891.652708682364, 14014.159150451005, 267234.0, 270408.0, 271672.0, 273541.0, 274985.0, 45806.31290530645, 45970.31044534335, 45991.31013034807, 46170.307445388346, 46288.76855615768, 1186.3652945674023, 1204.7355143714115, 1209.0810983652486, 1214.481897627965, 1215.477344741752, 24502.63246051346, 26317.34206644849, 26367.868160659073, 26535.867320663274, 26713.732862671903, 38338.0, 38611.6138838608, 38803.223935521695, 38903.22193556056, 38938.80530597329, 258593.0, 260110.0, 261056.0, 262405.0, 263429.0, 26552.601710973966, 27781.16656500308, 27867.721322786514, 27953.161405157876, 28057.43885122327, 37406.2518749618, 37856.621433786415, 38426.23147537089, 38842.6115738839, 38882.80558597189, 31350.216244594067, 32586.34827303488, 32653.510197346583, 32734.0, 33180.50229246515, 29120.27199320034, 29251.7074829249, 29281.0, 29313.560296595995, 29451.11646650604, 29159.708402915698, 32429.0, 32577.511337330434, 32871.0, 33129.83435082809, 25049.499010020063, 26045.609315860656, 26830.463390731686, 26950.191494255203, 27068.32329191786, 20517.0, 20946.895265523573, 21011.0, 21019.0, 21197.36407907765], "unit": "score", "name": "ext.html", "value": 16156.841983978922}, {"lowerIsBetter": false, "replicates": [341.13862497194583, 345.83572802918616, 348.44597090625905, 350.2260005388092, 357.1891805601287, 14302.499412520563, 14450.421983120676, 14915.403383864646, 15077.92461037696, 15668.138252396113, 13271.203727776316, 13547.458101675946, 13779.517716879911, 13787.379567919443, 13807.309634518284, 4366.978165109178, 4510.819567217307, 4787.473377928425, 5018.623603229754, 5036.7481625918745, 4247.384129301249, 4931.778069986859, 4968.031233909389, 4969.826056088038, 4975.179095449246, 4810.807567697288, 4976.0, 5008.198688209887, 5023.095842748304, 5046.7224302663335, 4749.382580264543, 4921.089598424285, 4927.753612319388, 4958.231474121517, 5238.397584277819, 5051.06555287273, 5061.190209566488, 5066.214736715815, 5075.670081444694, 5083.05963396769, 11426.71433214168, 16052.51842444717, 17264.223109960083, 18156.364527241483, 18211.63576728471, 1649.9010059396355, 1672.774175486306, 1728.2482120277718, 1777.520069581206, 1810.4116162247321, 8587.398882078258, 8798.824023519557, 9318.534073296309, 10030.749231269278, 12233.755324893453, 1657.6601796631662, 1678.6978343898093, 1694.3392077089945, 1774.9201285942163, 1809.1406581873637, 47352.5264747355, 48548.029039419365, 49861.75069124668, 50199.0, 50840.0, 9522.476263805556, 9695.951520242354, 9806.852897206547, 9850.064243896819, 9896.505174741234, 12500.374981250901, 12520.87479125197, 12526.311052892179, 12541.811872821914, 12558.81161782574, 5821.912671309934, 6191.81424557264, 6257.624542527463, 6387.329330420332, 6408.423241908251, 5639.859003524863, 5678.4605462480995, 5685.317761868602, 5739.512141467939, 5759.913601295984, 3999.5800440953863, 4044.6157615027114, 4181.163767246502, 4209.726367786084, 4234.78826058702, 1701.6086300151035, 1702.7020271452693, 1706.7354560043213, 1762.691528982423, 1792.587704827897, 746.9663865126082, 844.7127976488024, 852.5992783391796, 942.4167398770132, 949.4018768176005, 14190.787138192729, 14270.714585708436, 14361.210133442552, 14976.62558436026, 15459.458918937784, 820.8604537228686, 837.1419295222446, 854.6666799948025, 869.1265278395299, 934.5654270763991, 7958.283754462126, 8655.437396569203, 8675.652973880975, 8762.430442021248, 8819.603117859711, 418639.0, 420911.0, 448029.0, 476458.0, 482880.0, 53276.73361633167, 63495.0, 64144.0, 64202.0, 68369.3163068373, 1099.301943266032, 1103.939283339424, 1109.5561775289787, 1122.9831552526718, 1127.4982632728356, 13556.93221533886, 13641.317934103454, 13653.180809151483, 13804.516841910485, 14093.224872632103, 30811.38377232398, 31286.374272514877, 31325.373492529565, 31547.684523154476, 31718.365632686757, 37201.627983719816, 38482.0, 38990.6100938987, 39827.60172398239, 41108.177836443705, 6286.748530058747, 6536.3790439910035, 6603.669816509059, 6732.461403087644, 6930.584164950119, 9539.952300238454, 9894.554745036634, 10084.495775211064, 10445.582176712845, 10660.040596346056, 8024.638891250024, 8382.0, 8490.617922193393, 8528.147185281423, 8640.438371505832, 8639.222469977733, 8674.132586741276, 8958.596863141043, 9036.728898133066, 9251.167394934488, 8542.316614670935, 8712.91287087121, 8766.21104100634, 8824.779380515538, 8827.514486703292, 6457.483401327976, 6840.555363901331, 6931.826704332432, 7024.121984751906, 7081.327273908971, 7522.623868806647, 7965.283124518821, 8294.29498492635, 8383.916160838313, 8858.379913406257], "unit": "score", "name": "jquery.html", "value": 7383.6013549887}, {"lowerIsBetter": false, "replicates": [1396.6997095624442, 1419.0917812599935, 1547.2573164880857, 1718.5016345259876, 1757.8857374270672, 6378.585391949531, 6457.321981191978, 7255.09311336083, 7436.628168591569, 7466.701331946716, 6746.898796518044, 6925.168979722441, 6970.128733908262, 7031.367176954073, 7031.648417579114, 2166.4042388343173, 2218.6561083032075, 2219.2454565447742, 2221.3224966385246, 2224.077008041661, 2165.32874808809, 2178.9128434862587, 2180.029886700411, 2196.6814811852273, 2198.2745693921047, 2155.299527653511, 2164.2425151197112, 2168.728908886389, 2172.196287373666, 2189.9452513687206, 2172.1202912820177, 2193.846430749848, 2209.381373215502, 2211.0381983837083, 2213.944651383712, 2122.9150833966623, 2153.2678889177755, 2161.848670593059, 2162.0919213930188, 2168.6530155175096, 7284.817879553, 7318.9634051829935, 7327.963360183218, 7328.596927169004, 7337.3029562191505, 4199.4120823084795, 4241.088166044285, 4249.617534421917, 4262.381954616594, 4279.122779830159, 2786.902458413966, 2797.188815243597, 2846.6868644449096, 2874.2814296425895, 2876.0, 844.2359664503634, 908.5684299957534, 911.1844898815589, 1778.7598674179078, 1782.875198736089, 9548.236141108695, 9666.565004574812, 9673.37123086997, 9680.75798105046, 9704.175145112675, 3883.708721845873, 3949.289127956938, 4023.879283621496, 4038.2932986727205, 4069.308217603015, 8001.239882211181, 8039.35685145187, 8048.5975701215875, 8066.475679080841, 8074.757757267292, 4349.630281426051, 4392.297232442857, 4408.603225709701, 4423.181711383404, 4424.292113261863, 3362.596488421405, 3453.188500702333, 3897.376419772879, 4033.1328764315813, 4055.9797201013807, 3298.802071875695, 3324.2354258520677, 3353.3796247694254, 3362.36115138123, 3362.4451965425433, 966.8888077870994, 969.345691658128, 972.2659392159017, 974.8635191073255, 977.9755506112261, 1085.831696087092, 1086.6522712732008, 1096.555894862582, 1142.9199956003167, 1170.5610396101463, 6708.127943367331, 6761.966190169116, 6763.628000459924, 6993.580385176906, 6994.370506654425, 1016.8423894296396, 1028.9897101029044, 1031.9587216511406, 1035.440861934562, 1042.8383600541777, 5090.847274581768, 5349.063913815066, 5352.518273355417, 5368.275282836845, 5378.91931621026, 8496.70261540843, 8592.957035214784, 8706.608202630898, 8827.16141966512, 8939.240164585954, 8779.780505487286, 8902.287816974627, 8909.821803563893, 8925.464472131693, 8932.8660070099, 6884.793456196322, 6896.3103689631635, 7060.646967651597, 7106.786796396116, 7120.501564890408, 6774.153230846145, 6783.626900520519, 6796.388325050769, 6803.489738269748, 6834.8633027340165, 7925.445218834857, 7951.403644726553, 7989.081255655674, 8075.87886181696, 8156.184381561797, 7949.0, 8160.97987751531, 8612.655493780429, 8652.783680407789, 8734.301255899385, 5224.138017227267, 5379.004884096455, 6366.522510811615, 6436.0, 6450.258220304725, 6587.4071333580205, 6707.0945422369305, 6733.932660673527, 6754.662266886734, 6757.3242675732035, 6400.423961843457, 6453.185551470637, 6522.543421960418, 6612.107365505595, 6672.432843208382, 6300.338464461349, 6405.807825765048, 6419.101325814297, 6473.708683109177, 6500.28496865335, 6410.871782564416, 6431.903521447089, 6462.418382345423, 6466.51501137426, 6475.643839588868, 5966.552508561962, 6062.151298818081, 6081.148639190428, 6081.939180608314, 6088.0, 6036.939630603638, 6043.637381757108, 6048.395160483917, 6072.726727297194, 6077.20996270482], "unit": "score", "name": "mootools.html", "value": 4205.765501513531}, {"lowerIsBetter": false, "replicates": [294.75093545953666, 303.40683962852626, 307.27176591478184, 307.37909422965595, 307.873771753581, 5479.287692599962, 5514.862128446791, 5550.1674748787755, 5620.803271885485, 5621.718914054291, 5484.095124304495, 5500.972495137528, 5507.0, 5517.613767036309, 5526.115821468566, 4008.8997775055564, 4241.384999175133, 4243.8090285937205, 4244.320908654616, 4255.276602977494, 4105.2815757242515, 4143.70994030418, 4229.55589663084, 4259.382389553512, 4271.530131685512, 4203.810828512725, 4228.830846766141, 4231.682623803227, 4232.915341693164, 4237.194932962742, 4188.199074398038, 4234.364845273219, 4235.0682849773, 4242.0, 4243.04531480416, 3727.7576957497945, 3732.682721968609, 3740.719446041531, 3744.0826997385816, 3746.981265093657, 5179.326687530634, 5302.469753024705, 5303.363596368422, 5308.495692909168, 5315.946840531584, 4787.61699064074, 4799.784009719571, 4802.711837289774, 4805.087033463666, 4812.542808433193, 5771.50942169916, 5775.913361299584, 5777.0, 5778.335491418498, 5781.479666830005, 3924.823382947774, 3942.172143849795, 3944.053427177457, 3949.980250098731, 3952.604739526053, 5881.941180588182, 6070.57505974582, 6093.512518998514, 6126.9387306127255, 6136.539759518054, 4003.8798836034966, 4037.555868854424, 4039.6162364575316, 4041.5958404159937, 4041.7372870763306, 4091.345384738487, 4104.97375656086, 4109.260333140004, 4109.753414795122, 4110.362893751473, 4756.548127927841, 4758.500357462486, 4762.928556071662, 4767.642426818003, 4778.665493415428, 5516.558675305966, 5539.944600554023, 5699.230603868507, 5702.515286200636, 5787.5080618147085, 1402.4530433131088, 1403.2142000479764, 1403.3334166271143, 1403.5719105672663, 1419.3541938417995, 976.3360914578155, 985.142925654685, 990.8365119755304, 994.1152374386802, 1004.3973615830589, 4929.901401971941, 4947.109520286383, 4970.279309500174, 4978.0, 4995.775190116454, 5996.700164991733, 6006.909896351558, 6020.819375418744, 6020.939790602126, 6033.4871535919065, 5023.14606516893, 5023.824166154167, 5029.270755740397, 5032.295478632995, 5037.29477873098, 3179.7774155809334, 3217.4208642444582, 3251.9837400813317, 3254.1864533866533, 3256.9348613028083, 5678.829635110953, 5690.061139911951, 5694.316681998187, 5704.201411802351, 5714.0571805652435, 6192.8761424771255, 6202.72087756052, 6207.34822843604, 6208.286047104641, 6210.50315974721, 5554.944450555605, 5656.123300888369, 5661.34894487131, 5674.716264186774, 5687.77248910039, 5951.851203719942, 5952.345242023461, 5995.760169593342, 6002.519798416029, 6005.339412664691, 5867.911981320369, 5870.53035757147, 5870.882582348415, 5874.118882167709, 5875.676837773793, 5665.348484924287, 5671.517920976763, 5683.06229472149, 5687.829365119053, 5691.3170419549915, 3937.4684417603257, 3986.740861843971, 4003.419504171937, 4004.0, 4037.39439084128, 5900.64596124234, 5985.191999080243, 6000.039993601003, 6014.0678194879865, 6055.424734650202, 5801.245838041028, 5802.970985145047, 5841.912371314519, 5856.648601083949, 5859.355470898113, 5793.94206057934, 5828.970855145697, 5839.065749480063, 5852.853678658068, 5858.47273745365, 5581.972090139686, 5637.379888212376, 5663.66018038919, 5665.178549110438, 5665.433456654301, 5892.1161825726485, 5897.144913987362, 5898.705064746831, 5899.085641725539, 5899.852503687443, 5692.459216374438, 5718.971405143114, 5725.227094342211, 5729.68486733217, 5730.341010783646], "unit": "score", "name": "prototype.html", "value": 4313.869129258351}, {"lowerIsBetter": false, "replicates": [797.9840403191936, 801.5871826009607, 801.9558924259163, 816.452976505741, 825.4345773145392, 11431.428428578569, 11550.711232219177, 11568.47941842617, 11590.65228043159, 11604.361760103191, 10533.473326333671, 10691.572337106525, 10711.410872402015, 10729.78540429191, 10735.087517560996, 773.5552057566907, 794.519315813933, 798.0901771979948, 798.7204478432532, 799.9040115186157, 802.0375549340786, 806.5080301016376, 809.0857331215718, 809.7044578728751, 810.7365106340434, 832.4256263178418, 834.9123342049088, 839.8026463781007, 840.9117042710519, 841.5497708725833, 819.7581713394563, 821.8972628421477, 823.2960818500156, 823.5799742131557, 823.7158180427773, 612.4640939178219, 616.8827922694674, 617.1760699466219, 617.5491890919609, 619.5013014523307, 12560.497580096786, 12617.558385456558, 12617.87382126176, 12624.431900564497, 12644.304563249018, 10971.286866353741, 11144.164187685956, 11166.274192177483, 11219.439028048564, 11309.038731707815, 9469.384490008197, 9561.808763824685, 9584.616615335379, 9609.423434593948, 9674.9516252419, 3233.87064517419, 3250.349930013983, 3254.6094468663673, 3306.9173270668184, 3347.8995630131135, 37145.62854371449, 39626.60373396258, 40946.181076378605, 40988.18023639511, 41262.0, 9331.34680572367, 9448.149666530046, 9610.135087842127, 9631.133198012072, 9655.420674759536, 15885.046897186206, 15953.04281743099, 15970.281337339848, 15972.0, 16023.878328516892, 6486.902696459557, 6654.168228971379, 6742.325767423316, 6850.554713943678, 6954.165500139914, 3556.822158892045, 3649.927001459956, 3657.213699054663, 3709.703223742094, 3730.1793605406765, 2591.6371707960902, 2603.765661090511, 2605.895764169412, 2609.712931577525, 2610.6345111684377, 465.95573420524994, 470.6470147389458, 478.18469509486243, 479.07777528257964, 481.60989598425385, 577.2092233639856, 588.5262363797099, 591.125134800489, 604.6613896218132, 619.8481372063783, 8149.796255093552, 8271.13153118926, 8624.223819856243, 8625.0, 8845.51349675774, 545.4899668809676, 614.8217017065001, 623.1089541955048, 633.1737083106498, 637.2130418932707, 3649.616790236987, 3730.5523337199165, 3736.1220113273357, 3777.2823163598828, 3782.6217378262504, 45865.0, 46765.064698705835, 46775.29837052447, 46794.76602616965, 46827.29759053617, 42195.7890210547, 42772.358414623806, 42908.57091429046, 43295.134097317874, 43375.0, 35508.7024762821, 38318.23363532769, 38926.2214755709, 41375.93120343971, 41845.58154418478, 7319.63401829917, 7925.801854953672, 7998.160193179865, 8210.63052162642, 8339.583020848811, 30448.086557403312, 30830.38339233158, 31315.217119572193, 31394.0, 31416.685833141375, 35304.293914122085, 35732.64267357293, 35858.64141358657, 37314.0, 38519.614803851604, 9658.806823863342, 9707.854382184414, 9743.269254805777, 9782.119609235204, 10073.899261007296, 11167.441627918734, 11170.664880053611, 11197.944010280222, 11345.376004319842, 11412.600558980728, 9429.764255893657, 9823.115919567274, 9872.654457093968, 9893.851592226267, 10147.086762191439, 10125.240606954361, 10216.591336346462, 10316.226283028953, 10378.584856605652, 10483.737906552396, 9915.355501892642, 10094.343867648578, 10236.795264094826, 10241.692749217535, 10253.07722304996, 8611.31109511225, 8713.956430217808, 8809.911900881165, 9007.054259302678, 9237.07629237071, 8822.898424909998, 9218.21645160169, 9249.491277979776, 9255.074492550692, 9390.389624674648], "unit": "score", "name": "yui.html", "value": 5707.54650101518}], "name": "dromaeo_css", "value": 6173.740879085789}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 114.0, 113.0, 115.0, 125.0, 113.0, 114.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [168.0, 131.0, 157.0, 172.0, 133.0, 161.0, 157.0, 135.0, 169.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [172.0, 163.0, 164.0, 162.0, 171.0, 165.0, 173.0, 164.0, 165.0, 165.0], "unit": "score", "name": "audio-dft", "value": 166.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 137.0, 75.0, 73.0, 74.0, 74.0, 150.0, 74.0], "unit": "score", "name": "audio-fft", "value": 87.6}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 142.0, 97.0, 97.0, 98.0, 134.0, 97.0, 96.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 149.0, 149.0, 148.0, 149.0, 147.0, 152.0, 147.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 74.0, 72.0, 70.0, 71.0, 70.0, 70.0, 72.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 86.0, 83.0, 85.0, 89.0, 84.0, 84.0, 100.0, 105.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [138.0, 134.0, 129.0, 121.0, 126.0, 126.0, 122.0, 130.0, 140.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.9}, {"lowerIsBetter": true, "replicates": [135.0, 154.0, 151.0, 156.0, 146.0, 133.0, 142.0, 150.0, 139.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 73.0, 72.0, 70.0, 72.0, 73.0, 68.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1554.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.38935108153078], "unit": "score", "name": "Richards", "value": 212.16501999999997}, {"lowerIsBetter": false, "replicates": [186.25442354255912], "unit": "score", "name": "DeltaBlue", "value": 354.98754199999996}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1094.0919037199126], "unit": "score", "name": "RayTrace", "value": 676.3499459999998}, {"lowerIsBetter": false, "replicates": [732.6007326007326], "unit": "score", "name": "Earley", "value": 909.721995}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [43042.55319148936], "unit": "score", "name": "RegExp", "value": 21.16475284231339}, {"lowerIsBetter": false, "replicates": [612.7450980392157], "unit": "score", "name": "Splay", "value": 132.99331200000003}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20184.411165580837}]} 01:10:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20184.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1554.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6173.74"}}} 01:10:08 INFO - Return code: 0 01:10:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:10:08 INFO - # TBPL SUCCESS # 01:10:08 INFO - Running post-action listener: _resource_record_post_action 01:10:08 INFO - Running post-run listener: _resource_record_post_run 01:10:09 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 0; Write bytes: 541179904; Read time: 0; Write time: 502044 01:10:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238026752; Read time: 0; Write time: 268408 01:10:09 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 0; Write bytes: 303153152; Read time: 0; Write time: 233636 01:10:09 INFO - Running post-run listener: _upload_blobber_files 01:10:09 INFO - Blob upload gear active. 01:10:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:10:09 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 01:10:09 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'] 01:10:09 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 01:10:09 INFO - (blobuploader) - INFO - Open directory for files ... 01:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:10:10 INFO - (blobuploader) - INFO - Done attempting. 01:10:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:10:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:10:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:10:11 INFO - (blobuploader) - INFO - Done attempting. 01:10:11 INFO - (blobuploader) - INFO - Iteration through files over. 01:10:11 INFO - Return code: 0 01:10:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:10:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:10:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/006f81cc716d380ee8e174f3abe481f33ea18489b988b38fa40816670d686ede3825805c5bdf058c6a4bd420fc63929ce9878117f88c6f0cd9392ab75fc3949e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52d9e806af7f13b4330d837ca6f66ddfeae0ad14946709fa662d70b12dd578d353309e5cb986e629a1f91972ed5c5b04c794b10156661872a35914f6ecbcc504"} 01:10:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:10:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:10:11 INFO - Contents: 01:10:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/006f81cc716d380ee8e174f3abe481f33ea18489b988b38fa40816670d686ede3825805c5bdf058c6a4bd420fc63929ce9878117f88c6f0cd9392ab75fc3949e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52d9e806af7f13b4330d837ca6f66ddfeae0ad14946709fa662d70b12dd578d353309e5cb986e629a1f91972ed5c5b04c794b10156661872a35914f6ecbcc504"} 01:10:11 INFO - Copying logs to upload dir... 01:10:11 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1299.825171 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-01-13 01:10:10.080571) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 01:10:10.084167) ========= 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=cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/006f81cc716d380ee8e174f3abe481f33ea18489b988b38fa40816670d686ede3825805c5bdf058c6a4bd420fc63929ce9878117f88c6f0cd9392ab75fc3949e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52d9e806af7f13b4330d837ca6f66ddfeae0ad14946709fa662d70b12dd578d353309e5cb986e629a1f91972ed5c5b04c794b10156661872a35914f6ecbcc504"} build_url:https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/E7rHME9qS7yo4amAmAryKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/006f81cc716d380ee8e174f3abe481f33ea18489b988b38fa40816670d686ede3825805c5bdf058c6a4bd420fc63929ce9878117f88c6f0cd9392ab75fc3949e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52d9e806af7f13b4330d837ca6f66ddfeae0ad14946709fa662d70b12dd578d353309e5cb986e629a1f91972ed5c5b04c794b10156661872a35914f6ecbcc504"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 01:10:10.112939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:10:10.113332) ========= 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=cbe409c6de289db6ac707de3000001d4-1452674843.936072-405269537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:10:10.196590) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 01:10:10.196900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 01:10:10.197190) ========= ========= Total master_lag: 0.28 =========