builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1452769289.07 results: success (0) buildid: 20160114014931 builduid: 8a09af4d713b4f8089061370e34ccb78 revision: dd3a10e8fcce1e16eff479fe0511cd5936e3a347 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.070175) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.070703) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.071149) ========= 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=574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.101085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.101430) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.130752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.131090) ========= 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=574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.181438) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.181762) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.182147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.182453) ========= 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=574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 03:01:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-01-14 03:01:29 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101860 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.302331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.302708) ========= 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=574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021702 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.356596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.356990) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd3a10e8fcce1e16eff479fe0511cd5936e3a347 --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 dd3a10e8fcce1e16eff479fe0511cd5936e3a347 --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=574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 03:01:29,630 truncating revision to first 12 chars 2016-01-14 03:01:29,630 Setting DEBUG logging. 2016-01-14 03:01:29,630 attempt 1/10 2016-01-14 03:01:29,630 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd3a10e8fcce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 03:01:29,895 unpacking tar archive at: fx-team-dd3a10e8fcce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622939 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.997915) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:29.998226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:30.008002) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:30.008263) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 03:01:30.008654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-01-14 03:01:30.008945) ========= /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=574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:01:30 INFO - MultiFileLogger online at 20160114 03:01:30 in /builds/slave/test 03:01:30 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 03:01:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:01:30 INFO - {'append_to_log': False, 03:01:30 INFO - 'base_work_dir': '/builds/slave/test', 03:01:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:01:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:01:30 INFO - 'branch': 'Fx-Team-Non-PGO', 03:01:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:01:30 INFO - 'config_files': ('talos/linux_config.py',), 03:01:30 INFO - 'default_actions': ('clobber', 03:01:30 INFO - 'read-buildbot-config', 03:01:30 INFO - 'download-and-extract', 03:01:30 INFO - 'populate-webroot', 03:01:30 INFO - 'create-virtualenv', 03:01:30 INFO - 'install', 03:01:30 INFO - 'run-tests'), 03:01:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:01:30 INFO - 'download_minidump_stackwalk': True, 03:01:30 INFO - 'download_symbols': 'ondemand', 03:01:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:01:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:01:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:01:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:01:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:01:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:01:30 INFO - 'installer_path': 'installer.exe', 03:01:30 INFO - 'log_level': 'info', 03:01:30 INFO - 'log_name': 'talos', 03:01:30 INFO - 'log_to_console': True, 03:01:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:01:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:01:30 INFO - 'opt_config_files': (), 03:01:30 INFO - 'pip_index': False, 03:01:30 INFO - 'sps_profile': False, 03:01:30 INFO - 'sps_profile_interval': 0, 03:01:30 INFO - 'suite': 'dromaeojs-e10s', 03:01:30 INFO - 'system_bits': '32', 03:01:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:01:30 INFO - 'title': 'talos-linux64-ix-044', 03:01:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:01:30 INFO - 'use_talos_json': True, 03:01:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:01:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:01:30 INFO - 'work_dir': 'build'} 03:01:30 INFO - ##### 03:01:30 INFO - ##### Running clobber step. 03:01:30 INFO - ##### 03:01:30 INFO - Running pre-action listener: _resource_record_pre_action 03:01:30 INFO - Running main action method: clobber 03:01:30 INFO - rmtree: /builds/slave/test/build 03:01:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:01:30 INFO - Running post-action listener: _resource_record_post_action 03:01:30 INFO - ##### 03:01:30 INFO - ##### Running read-buildbot-config step. 03:01:30 INFO - ##### 03:01:30 INFO - Running pre-action listener: _resource_record_pre_action 03:01:30 INFO - Running main action method: read_buildbot_config 03:01:30 INFO - Using buildbot properties: 03:01:30 INFO - { 03:01:30 INFO - "project": "", 03:01:30 INFO - "product": "firefox", 03:01:30 INFO - "script_repo_revision": "production", 03:01:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:01:30 INFO - "repository": "", 03:01:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:01:30 INFO - "buildid": "20160114014931", 03:01:30 INFO - "pgo_build": "False", 03:01:30 INFO - "basedir": "/builds/slave/test", 03:01:30 INFO - "buildnumber": 689, 03:01:30 INFO - "slavename": "talos-linux64-ix-044", 03:01:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:01:30 INFO - "platform": "ubuntu64_hw", 03:01:30 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:01:30 INFO - "branch": "fx-team", 03:01:30 INFO - "repo_path": "integration/fx-team", 03:01:30 INFO - "revision": "dd3a10e8fcce1e16eff479fe0511cd5936e3a347", 03:01:30 INFO - "stage_platform": "linux64", 03:01:30 INFO - "builduid": "8a09af4d713b4f8089061370e34ccb78", 03:01:30 INFO - "slavebuilddir": "test" 03:01:30 INFO - } 03:01:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:01:30 INFO - Running post-action listener: _resource_record_post_action 03:01:30 INFO - ##### 03:01:30 INFO - ##### Running download-and-extract step. 03:01:30 INFO - ##### 03:01:30 INFO - Running pre-action listener: _resource_record_pre_action 03:01:30 INFO - Running main action method: download_and_extract 03:01:30 INFO - mkdir: /builds/slave/test/build/tests 03:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:01:30 INFO - https://queue.taskcluster.net/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/test_packages.json 03:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/test_packages.json 03:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:01:31 INFO - Downloaded 1448 bytes. 03:01:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:01:31 INFO - Using the following test package requirements: 03:01:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:01:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:01:31 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:01:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:31 INFO - u'jsshell-linux-x86_64.zip'], 03:01:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:01:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:01:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:01:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:01:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:01:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:01:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:01:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:01:31 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')]} 03:01:31 INFO - https://queue.taskcluster.net/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:01:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/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 03:01:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/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 03:01:34 INFO - Downloaded 22762730 bytes. 03:01:34 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 03:01:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:34 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 03:01:35 INFO - Return code: 0 03:01:35 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 03:01:35 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')]} 03:01:35 INFO - https://queue.taskcluster.net/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/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 03:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/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 03:01:46 INFO - Downloaded 22762730 bytes. 03:01:46 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 03:01:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:46 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 03:01:47 INFO - Return code: 0 03:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:47 INFO - https://queue.taskcluster.net/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:01:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:01:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:01:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/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 03:01:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/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 03:01:49 INFO - Downloaded 11132144 bytes. 03:01:49 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 03:01:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:01:49 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 03:01:50 INFO - Return code: 0 03:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:01:50 INFO - https://queue.taskcluster.net/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/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 03:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtQbOR4-TjWwj5vjre_JnQ/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 03:01:54 INFO - Downloaded 53981767 bytes. 03:01:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:54 INFO - mkdir: /builds/slave/test/properties 03:01:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:01:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:01:54 INFO - Contents: 03:01:54 INFO - build_url:https://queue.taskcluster.net/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:54 INFO - Running post-action listener: _resource_record_post_action 03:01:54 INFO - Running post-action listener: set_extra_try_arguments 03:01:54 INFO - ##### 03:01:54 INFO - ##### Running populate-webroot step. 03:01:54 INFO - ##### 03:01:54 INFO - Running pre-action listener: _resource_record_pre_action 03:01:54 INFO - Running main action method: populate_webroot 03:01:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:01:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:01:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:01:54 INFO - '--tppagecycles', 03:01:54 INFO - '7'], 03:01:54 INFO - 'tests': ['tsvgm']}}, 03:01:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:01:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:01:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:01:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:01:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:01:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:01:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:54 INFO - 'talos_options': ['--e10s'], 03:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:54 INFO - 'tests': ['damp', 'tps']}, 03:01:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:54 INFO - 'talos_options': ['--e10s'], 03:01:54 INFO - 'tests': ['damp', 'tps']}, 03:01:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:01:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:01:54 INFO - 'other': {'tests': ['a11yr', 03:01:54 INFO - 'ts_paint', 03:01:54 INFO - 'tpaint', 03:01:54 INFO - 'sessionrestore', 03:01:54 INFO - 'sessionrestore_no_auto_restore']}, 03:01:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:01:54 INFO - 'tests': ['a11yr', 03:01:54 INFO - 'ts_paint', 03:01:54 INFO - 'tpaint', 03:01:54 INFO - 'sessionrestore', 03:01:54 INFO - 'sessionrestore_no_auto_restore']}, 03:01:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:01:54 INFO - 'tests': ['a11yr', 03:01:54 INFO - 'ts_paint', 03:01:54 INFO - 'tpaint', 03:01:54 INFO - 'sessionrestore', 03:01:54 INFO - 'sessionrestore_no_auto_restore']}, 03:01:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:01:54 INFO - 'tests': ['a11yr', 03:01:54 INFO - 'ts_paint', 03:01:54 INFO - 'tpaint', 03:01:54 INFO - 'sessionrestore', 03:01:54 INFO - 'sessionrestore_no_auto_restore']}, 03:01:54 INFO - 'other_l64': {'tests': ['a11yr', 03:01:54 INFO - 'ts_paint', 03:01:54 INFO - 'tpaint', 03:01:54 INFO - 'sessionrestore', 03:01:54 INFO - 'sessionrestore_no_auto_restore']}, 03:01:54 INFO - 'other_nol64': {'tests': ['a11yr', 03:01:54 INFO - 'ts_paint', 03:01:54 INFO - 'tpaint', 03:01:54 INFO - 'sessionrestore', 03:01:54 INFO - 'sessionrestore_no_auto_restore']}, 03:01:54 INFO - 'svgr': {'tests': ['tsvgx', 03:01:54 INFO - 'tsvgr_opacity', 03:01:54 INFO - 'tart', 03:01:54 INFO - 'tscrollx', 03:01:54 INFO - 'cart']}, 03:01:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:01:54 INFO - 'tests': ['tsvgx', 03:01:54 INFO - 'tsvgr_opacity', 03:01:54 INFO - 'tart', 03:01:54 INFO - 'tscrollx', 03:01:54 INFO - 'cart']}, 03:01:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:54 INFO - 'tests': ['tp5o']}, 03:01:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:54 INFO - 'talos_options': ['--e10s'], 03:01:54 INFO - 'tests': ['tp5o']}, 03:01:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:54 INFO - 'talos_options': ['--xperf_path', 03:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:54 INFO - 'tests': ['tp5n']}, 03:01:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:54 INFO - 'talos_options': ['--e10s', 03:01:54 INFO - '--xperf_path', 03:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:54 INFO - 'tests': ['tp5n']}}, 03:01:54 INFO - 'talos.zip': {'path': '', 03:01:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:01:54 INFO - Running post-action listener: _resource_record_post_action 03:01:54 INFO - ##### 03:01:54 INFO - ##### Running create-virtualenv step. 03:01:54 INFO - ##### 03:01:54 INFO - Running pre-action listener: _resource_record_pre_action 03:01:54 INFO - Running main action method: create_virtualenv 03:01:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:01:54 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 03:01:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:01:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:01:54 INFO - Using real prefix '/usr' 03:01:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:01:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:01:56 INFO - Installing pip.................done. 03:01:56 INFO - Return code: 0 03:01:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9525e10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe613d0>, '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 0xdcced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcd360>, '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': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', '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 03:01:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:01:56 INFO - Using env: {'DISPLAY': ':0', 03:01:56 INFO - 'HOME': '/home/cltbld', 03:01:56 INFO - 'LANG': 'en_US.UTF-8', 03:01:56 INFO - 'LANGUAGE': 'en_US:en', 03:01:56 INFO - 'LOGNAME': 'cltbld', 03:01:56 INFO - 'MAIL': '/var/mail/cltbld', 03:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:56 INFO - 'MOZ_NO_REMOTE': '1', 03:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:56 INFO - 'NO_EM_RESTART': '1', 03:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:56 INFO - 'PWD': '/builds/slave/test', 03:01:56 INFO - 'SHELL': '/bin/bash', 03:01:56 INFO - 'SHLVL': '1', 03:01:56 INFO - 'TERM': 'linux', 03:01:56 INFO - 'TMOUT': '86400', 03:01:56 INFO - 'USER': 'cltbld', 03:01:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', 03:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:56 INFO - '_': '/tools/buildbot/bin/python'} 03:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:56 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 03:01:56 INFO - Cleaning up... 03:01:56 INFO - Return code: 0 03:01:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9525e10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe613d0>, '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 0xdcced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcd360>, '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': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', '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 03:01:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:01:56 INFO - Using env: {'DISPLAY': ':0', 03:01:56 INFO - 'HOME': '/home/cltbld', 03:01:56 INFO - 'LANG': 'en_US.UTF-8', 03:01:56 INFO - 'LANGUAGE': 'en_US:en', 03:01:56 INFO - 'LOGNAME': 'cltbld', 03:01:56 INFO - 'MAIL': '/var/mail/cltbld', 03:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:56 INFO - 'MOZ_NO_REMOTE': '1', 03:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:56 INFO - 'NO_EM_RESTART': '1', 03:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:56 INFO - 'PWD': '/builds/slave/test', 03:01:56 INFO - 'SHELL': '/bin/bash', 03:01:56 INFO - 'SHLVL': '1', 03:01:56 INFO - 'TERM': 'linux', 03:01:56 INFO - 'TMOUT': '86400', 03:01:56 INFO - 'USER': 'cltbld', 03:01:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', 03:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:56 INFO - '_': '/tools/buildbot/bin/python'} 03:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:57 INFO - Downloading/unpacking psutil>=0.7.1 03:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:01:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:58 INFO - Installing collected packages: psutil 03:01:58 INFO - Running setup.py install for psutil 03:01:59 INFO - building 'psutil._psutil_linux' extension 03:01:59 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 03:01:59 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 03:01:59 INFO - building 'psutil._psutil_posix' extension 03:01:59 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 03:01:59 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 03:01:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:59 INFO - Successfully installed psutil 03:01:59 INFO - Cleaning up... 03:01:59 INFO - Return code: 0 03:01:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:01:59 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')]} 03:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:59 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')]} 03:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:59 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 0x7f9525e10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe613d0>, '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 0xdcced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcd360>, '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': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', '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 03:01:59 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 03:01:59 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 03:01:59 INFO - Using env: {'DISPLAY': ':0', 03:01:59 INFO - 'HOME': '/home/cltbld', 03:01:59 INFO - 'LANG': 'en_US.UTF-8', 03:01:59 INFO - 'LANGUAGE': 'en_US:en', 03:01:59 INFO - 'LOGNAME': 'cltbld', 03:01:59 INFO - 'MAIL': '/var/mail/cltbld', 03:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:59 INFO - 'MOZ_NO_REMOTE': '1', 03:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:59 INFO - 'NO_EM_RESTART': '1', 03:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:59 INFO - 'PWD': '/builds/slave/test', 03:01:59 INFO - 'SHELL': '/bin/bash', 03:01:59 INFO - 'SHLVL': '1', 03:01:59 INFO - 'TERM': 'linux', 03:01:59 INFO - 'TMOUT': '86400', 03:01:59 INFO - 'USER': 'cltbld', 03:01:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', 03:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:59 INFO - '_': '/tools/buildbot/bin/python'} 03:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:02:01 INFO - Installing collected packages: mozsystemmonitor 03:02:01 INFO - Running setup.py install for mozsystemmonitor 03:02:01 INFO - Successfully installed mozsystemmonitor 03:02:01 INFO - Cleaning up... 03:02:01 INFO - Return code: 0 03:02:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:01 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 0x7f9525e10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe613d0>, '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 0xdcced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcd360>, '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': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', '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 03:02:01 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 03:02:01 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 03:02:01 INFO - Using env: {'DISPLAY': ':0', 03:02:01 INFO - 'HOME': '/home/cltbld', 03:02:01 INFO - 'LANG': 'en_US.UTF-8', 03:02:01 INFO - 'LANGUAGE': 'en_US:en', 03:02:01 INFO - 'LOGNAME': 'cltbld', 03:02:01 INFO - 'MAIL': '/var/mail/cltbld', 03:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:01 INFO - 'MOZ_NO_REMOTE': '1', 03:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:01 INFO - 'NO_EM_RESTART': '1', 03:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:01 INFO - 'PWD': '/builds/slave/test', 03:02:01 INFO - 'SHELL': '/bin/bash', 03:02:01 INFO - 'SHLVL': '1', 03:02:01 INFO - 'TERM': 'linux', 03:02:01 INFO - 'TMOUT': '86400', 03:02:01 INFO - 'USER': 'cltbld', 03:02:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', 03:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:01 INFO - '_': '/tools/buildbot/bin/python'} 03:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:02:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:02:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:02:03 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 03:02:03 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 03:02:03 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 03:02:03 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 03:02:03 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 03:02:03 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 03:02:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:02:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:02:04 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 03:02:04 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 03:02:04 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 03:02:04 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 03:02:04 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 03:02:04 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 03:02:04 INFO - Downloading docopt-0.6.1.tar.gz 03:02:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:02:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:02:04 INFO - Running setup.py install for blobuploader 03:02:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:02:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:02:04 INFO - Running setup.py install for requests 03:02:04 INFO - Running setup.py install for docopt 03:02:04 INFO - Successfully installed blobuploader requests docopt 03:02:04 INFO - Cleaning up... 03:02:04 INFO - Return code: 0 03:02:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:04 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')]} 03:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:04 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')]} 03:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:04 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 0x7f9525e10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe613d0>, '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 0xdcced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcd360>, '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': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', '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 03:02:04 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 03:02:04 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 03:02:04 INFO - Using env: {'DISPLAY': ':0', 03:02:04 INFO - 'HOME': '/home/cltbld', 03:02:04 INFO - 'LANG': 'en_US.UTF-8', 03:02:04 INFO - 'LANGUAGE': 'en_US:en', 03:02:04 INFO - 'LOGNAME': 'cltbld', 03:02:04 INFO - 'MAIL': '/var/mail/cltbld', 03:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:04 INFO - 'MOZ_NO_REMOTE': '1', 03:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:04 INFO - 'NO_EM_RESTART': '1', 03:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:04 INFO - 'PWD': '/builds/slave/test', 03:02:04 INFO - 'SHELL': '/bin/bash', 03:02:04 INFO - 'SHLVL': '1', 03:02:04 INFO - 'TERM': 'linux', 03:02:04 INFO - 'TMOUT': '86400', 03:02:04 INFO - 'USER': 'cltbld', 03:02:04 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', 03:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:04 INFO - '_': '/tools/buildbot/bin/python'} 03:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:05 INFO - Running setup.py (path:/tmp/pip-ZHe4iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:05 INFO - Running setup.py (path:/tmp/pip-QdplCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:05 INFO - Running setup.py (path:/tmp/pip-tGQOvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:05 INFO - Running setup.py (path:/tmp/pip-YPPqJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:05 INFO - Running setup.py (path:/tmp/pip-vS99Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:05 INFO - Running setup.py (path:/tmp/pip-qb1jCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:05 INFO - Running setup.py (path:/tmp/pip-m1etp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:05 INFO - Running setup.py (path:/tmp/pip-pazBAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:05 INFO - Running setup.py (path:/tmp/pip-V5uUfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:05 INFO - Running setup.py (path:/tmp/pip-xia4Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:05 INFO - Running setup.py (path:/tmp/pip-EnlZxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:05 INFO - Running setup.py (path:/tmp/pip-aGZA06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:05 INFO - Running setup.py (path:/tmp/pip-zh9pww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:06 INFO - Running setup.py (path:/tmp/pip-F2wEmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:06 INFO - Running setup.py (path:/tmp/pip-mpLenO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:06 INFO - Running setup.py (path:/tmp/pip-X20dTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:06 INFO - Running setup.py (path:/tmp/pip-eYaNVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:02:06 INFO - Running setup.py install for manifestparser 03:02:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:02:06 INFO - Running setup.py install for mozcrash 03:02:06 INFO - Running setup.py install for mozdebug 03:02:06 INFO - Running setup.py install for mozdevice 03:02:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:02:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:02:06 INFO - Running setup.py install for mozfile 03:02:06 INFO - Running setup.py install for mozhttpd 03:02:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:02:06 INFO - Running setup.py install for mozinfo 03:02:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Running setup.py install for mozInstall 03:02:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Running setup.py install for mozleak 03:02:07 INFO - Running setup.py install for mozlog 03:02:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Running setup.py install for moznetwork 03:02:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Running setup.py install for mozprocess 03:02:07 INFO - Running setup.py install for mozprofile 03:02:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Running setup.py install for mozrunner 03:02:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:02:07 INFO - Running setup.py install for mozscreenshot 03:02:07 INFO - Running setup.py install for moztest 03:02:07 INFO - Running setup.py install for mozversion 03:02:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:02:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:02:08 INFO - Cleaning up... 03:02:08 INFO - Return code: 0 03:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9525e10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe613d0>, '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 0xdcced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcd360>, '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': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', '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 03:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:02:08 INFO - Using env: {'DISPLAY': ':0', 03:02:08 INFO - 'HOME': '/home/cltbld', 03:02:08 INFO - 'LANG': 'en_US.UTF-8', 03:02:08 INFO - 'LANGUAGE': 'en_US:en', 03:02:08 INFO - 'LOGNAME': 'cltbld', 03:02:08 INFO - 'MAIL': '/var/mail/cltbld', 03:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:08 INFO - 'MOZ_NO_REMOTE': '1', 03:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:08 INFO - 'NO_EM_RESTART': '1', 03:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:08 INFO - 'PWD': '/builds/slave/test', 03:02:08 INFO - 'SHELL': '/bin/bash', 03:02:08 INFO - 'SHLVL': '1', 03:02:08 INFO - 'TERM': 'linux', 03:02:08 INFO - 'TMOUT': '86400', 03:02:08 INFO - 'USER': 'cltbld', 03:02:08 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', 03:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:08 INFO - '_': '/tools/buildbot/bin/python'} 03:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:08 INFO - Running setup.py (path:/tmp/pip-x4E8nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:08 INFO - Running setup.py (path:/tmp/pip-xAgDyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:08 INFO - Running setup.py (path:/tmp/pip-qVkQda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:08 INFO - Running setup.py (path:/tmp/pip-m6V2G3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 03:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:08 INFO - Running setup.py (path:/tmp/pip-TkFEbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:08 INFO - Running setup.py (path:/tmp/pip-SZlYL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:08 INFO - Running setup.py (path:/tmp/pip-nVdnci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:08 INFO - Running setup.py (path:/tmp/pip-JTgoN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:08 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)) 03:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:08 INFO - Running setup.py (path:/tmp/pip-R6Luwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:08 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)) 03:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:08 INFO - Running setup.py (path:/tmp/pip-XxsA2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:09 INFO - Running setup.py (path:/tmp/pip-EIVdfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:09 INFO - Running setup.py (path:/tmp/pip-7Oxb45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:09 INFO - Running setup.py (path:/tmp/pip-rR_yQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:09 INFO - Running setup.py (path:/tmp/pip-EzSdrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:09 INFO - Running setup.py (path:/tmp/pip-i27qhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:09 INFO - Running setup.py (path:/tmp/pip-zCU6kU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:09 INFO - Running setup.py (path:/tmp/pip-SzueVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:02:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:11 INFO - Downloading blessings-1.5.1.tar.gz 03:02:11 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:02:11 INFO - Installing collected packages: blessings 03:02:11 INFO - Running setup.py install for blessings 03:02:11 INFO - Successfully installed blessings 03:02:11 INFO - Cleaning up... 03:02:11 INFO - Return code: 0 03:02:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:11 INFO - Reading from file tmpfile_stdout 03:02:11 INFO - Current package versions: 03:02:11 INFO - argparse == 1.2.1 03:02:11 INFO - blessings == 1.5.1 03:02:11 INFO - blobuploader == 1.2.4 03:02:11 INFO - docopt == 0.6.1 03:02:11 INFO - manifestparser == 1.1 03:02:11 INFO - mozInstall == 1.12 03:02:11 INFO - mozcrash == 0.16 03:02:11 INFO - mozdebug == 0.1 03:02:11 INFO - mozdevice == 0.48 03:02:11 INFO - mozfile == 1.2 03:02:11 INFO - mozhttpd == 0.7 03:02:11 INFO - mozinfo == 0.9 03:02:11 INFO - mozleak == 0.1 03:02:11 INFO - mozlog == 3.1 03:02:11 INFO - moznetwork == 0.27 03:02:11 INFO - mozprocess == 0.22 03:02:11 INFO - mozprofile == 0.28 03:02:11 INFO - mozrunner == 6.11 03:02:11 INFO - mozscreenshot == 0.1 03:02:11 INFO - mozsystemmonitor == 0.0 03:02:11 INFO - moztest == 0.7 03:02:11 INFO - mozversion == 1.4 03:02:11 INFO - psutil == 3.1.1 03:02:11 INFO - requests == 1.2.3 03:02:11 INFO - wsgiref == 0.1.2 03:02:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9525e10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe613d0>, '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 0xdcced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcd360>, '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': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', '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 03:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:02:11 INFO - Using env: {'DISPLAY': ':0', 03:02:11 INFO - 'HOME': '/home/cltbld', 03:02:11 INFO - 'LANG': 'en_US.UTF-8', 03:02:11 INFO - 'LANGUAGE': 'en_US:en', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MAIL': '/var/mail/cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SHLVL': '1', 03:02:11 INFO - 'TERM': 'linux', 03:02:11 INFO - 'TMOUT': '86400', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - '_': '/tools/buildbot/bin/python'} 03:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:11 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)) 03:02:11 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)) 03:02:11 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)) 03:02:11 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)) 03:02:11 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)) 03:02:11 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)) 03:02:11 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)) 03:02:11 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)) 03:02:11 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)) 03:02:11 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)) 03:02:11 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)) 03:02:11 INFO - Cleaning up... 03:02:11 INFO - Return code: 0 03:02:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9525e10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe613d0>, '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 0xdcced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcd360>, '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': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', '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 03:02: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', 'jsonschema'] in /builds/slave/test/build 03:02: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 jsonschema 03:02:11 INFO - Using env: {'DISPLAY': ':0', 03:02:11 INFO - 'HOME': '/home/cltbld', 03:02:11 INFO - 'LANG': 'en_US.UTF-8', 03:02:11 INFO - 'LANGUAGE': 'en_US:en', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MAIL': '/var/mail/cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SHLVL': '1', 03:02:11 INFO - 'TERM': 'linux', 03:02:11 INFO - 'TMOUT': '86400', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - '_': '/tools/buildbot/bin/python'} 03:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:12 INFO - Downloading/unpacking jsonschema 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:02:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:02:13 INFO - Downloading/unpacking functools32 (from jsonschema) 03:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:14 INFO - Downloading functools32-3.2.3-2.tar.gz 03:02:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:02:14 INFO - warning: no files found matching '*.txt' 03:02:14 INFO - no previously-included directories found matching 'build' 03:02:14 INFO - no previously-included directories found matching 'dist' 03:02:14 INFO - no previously-included directories found matching '.git*' 03:02:14 INFO - Installing collected packages: jsonschema, functools32 03:02:14 INFO - Running setup.py install for functools32 03:02:14 INFO - warning: no files found matching '*.txt' 03:02:14 INFO - no previously-included directories found matching 'build' 03:02:14 INFO - no previously-included directories found matching 'dist' 03:02:14 INFO - no previously-included directories found matching '.git*' 03:02:14 INFO - Successfully installed jsonschema functools32 03:02:14 INFO - Cleaning up... 03:02:14 INFO - Return code: 0 03:02:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9525e10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe613d0>, '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 0xdcced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcd360>, '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': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', '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 03:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:02:14 INFO - Using env: {'DISPLAY': ':0', 03:02:14 INFO - 'HOME': '/home/cltbld', 03:02:14 INFO - 'LANG': 'en_US.UTF-8', 03:02:14 INFO - 'LANGUAGE': 'en_US:en', 03:02:14 INFO - 'LOGNAME': 'cltbld', 03:02:14 INFO - 'MAIL': '/var/mail/cltbld', 03:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:14 INFO - 'MOZ_NO_REMOTE': '1', 03:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:14 INFO - 'NO_EM_RESTART': '1', 03:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:14 INFO - 'PWD': '/builds/slave/test', 03:02:14 INFO - 'SHELL': '/bin/bash', 03:02:14 INFO - 'SHLVL': '1', 03:02:14 INFO - 'TERM': 'linux', 03:02:14 INFO - 'TMOUT': '86400', 03:02:14 INFO - 'USER': 'cltbld', 03:02:14 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', 03:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:14 INFO - '_': '/tools/buildbot/bin/python'} 03:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:14 INFO - Downloading/unpacking flake8 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:02:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:02:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:02:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:02:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:02:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:02:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:02:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:02:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:02:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:02:16 INFO - no previously-included directories found matching 'docs/_build' 03:02:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:02:17 INFO - Running setup.py install for pep8 03:02:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:02:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:02:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:02:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:02:17 INFO - no previously-included directories found matching 'docs/_build' 03:02:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:02:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:02:17 INFO - Cleaning up... 03:02:17 INFO - Return code: 0 03:02:17 INFO - Running post-action listener: _resource_record_post_action 03:02:17 INFO - Running post-action listener: _start_resource_monitoring 03:02:17 INFO - Starting resource monitoring. 03:02:17 INFO - ##### 03:02:17 INFO - ##### Running install step. 03:02:17 INFO - ##### 03:02:17 INFO - Running pre-action listener: _resource_record_pre_action 03:02:17 INFO - Running main action method: install 03:02:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:17 INFO - Reading from file tmpfile_stdout 03:02:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:02:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:02:17 INFO - Reading from file tmpfile_stdout 03:02:17 INFO - Output received: 03:02:17 INFO - Usage: mozinstall [options] installer 03:02:17 INFO - Options: 03:02:17 INFO - -h, --help show this help message and exit 03:02:17 INFO - -d DEST, --destination=DEST 03:02:17 INFO - Directory to install application into. [default: 03:02:17 INFO - "/builds/slave/test"] 03:02:17 INFO - --app=APP Application being installed. [default: firefox] 03:02:17 INFO - mkdir: /builds/slave/test/build/application 03:02:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:02:33 INFO - Reading from file tmpfile_stdout 03:02:33 INFO - Output received: 03:02:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:02:33 INFO - Running post-action listener: _resource_record_post_action 03:02:33 INFO - ##### 03:02:33 INFO - ##### Running run-tests step. 03:02:33 INFO - ##### 03:02:33 INFO - Running pre-action listener: _resource_record_pre_action 03:02:33 INFO - Running main action method: run_tests 03:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:02:33 INFO - Python 2.7.3 03:02:33 INFO - Return code: 0 03:02:33 INFO - grabbing minidump binary from tooltool 03:02: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')]} 03:02:33 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 0xe613d0>, '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 0xdcced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcd360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:02:33 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 03:02:33 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 03:02:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:02:33 INFO - Return code: 0 03:02:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:02:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:02:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:02:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:02:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:02:34 INFO - Return code: 0 03:02:34 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/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 03:02:34 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/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 03:02:34 INFO - Using env: {'DISPLAY': ':0', 03:02:34 INFO - 'HOME': '/home/cltbld', 03:02:34 INFO - 'LANG': 'en_US.UTF-8', 03:02:34 INFO - 'LANGUAGE': 'en_US:en', 03:02:34 INFO - 'LOGNAME': 'cltbld', 03:02:34 INFO - 'MAIL': '/var/mail/cltbld', 03:02:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:02:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:34 INFO - 'MOZ_NO_REMOTE': '1', 03:02:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:34 INFO - 'NO_EM_RESTART': '1', 03:02:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:34 INFO - 'PWD': '/builds/slave/test', 03:02:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:02:34 INFO - 'SHELL': '/bin/bash', 03:02:34 INFO - 'SHLVL': '1', 03:02:34 INFO - 'TERM': 'linux', 03:02:34 INFO - 'TMOUT': '86400', 03:02:34 INFO - 'USER': 'cltbld', 03:02:34 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396', 03:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:34 INFO - '_': '/tools/buildbot/bin/python'} 03:02:34 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/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 03:02:34 INFO - mozversion application_buildid: 20160114014931 03:02:34 INFO - mozversion application_changeset: dd3a10e8fcce1e16eff479fe0511cd5936e3a347 03:02:34 INFO - mozversion application_display_name: Nightly 03:02:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:02:34 INFO - mozversion application_name: Firefox 03:02:34 INFO - mozversion application_remotingname: firefox 03:02:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:02:34 INFO - mozversion application_vendor: Mozilla 03:02:34 INFO - mozversion application_version: 46.0a1 03:02:34 INFO - mozversion platform_buildid: 20160114014931 03:02:34 INFO - mozversion platform_changeset: dd3a10e8fcce1e16eff479fe0511cd5936e3a347 03:02:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:02:34 INFO - mozversion platform_version: 46.0a1 03:02:34 INFO - using testdate: 1452769354 03:02:34 INFO - actual date: 1452769354 03:02:34 INFO - starting webserver on 'localhost:34230' 03:02:34 INFO - SUITE-START | Running 3 tests 03:02:34 INFO - TEST-START | dromaeo_css 03:02:34 INFO - operating with platform_type : linux_ 03:02:34 INFO - Initialising browser for dromaeo_css test... 03:02:34 INFO - TEST-INFO | started process 2467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdoZd1y/profile http://localhost:34230/getInfo.html) 03:02:38 INFO - PROCESS | 2467 | 03:02:38 INFO - PROCESS | 2467 | (process:2567): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:02:39 INFO - PROCESS | 2467 | __metrics Screen width/height:1600/1200 03:02:39 INFO - PROCESS | 2467 | colorDepth:24 03:02:39 INFO - PROCESS | 2467 | Browser inner width/height: 1024/697 03:02:39 INFO - PROCESS | 2467 | __metrics 03:02:39 INFO - PROCESS | 2467 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:02:40 INFO - TEST-INFO | 2467: exit 0 03:02:40 INFO - Browser initialized. 03:02:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:02:40 INFO - TEST-INFO | started process 2616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdoZd1y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:41 INFO - PROCESS | 2616 | 03:02:41 INFO - PROCESS | 2616 | (process:2676): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:02:52 INFO - PROCESS | 2616 | RSS: Main: 150421504 03:02:52 INFO - PROCESS | 2616 | 03:03:42 INFO - PROCESS | 2616 | 1452769422030 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] 03:05:53 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:34230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34230/tests/dromaeo/cssquery-ext.html) 03:05:54 INFO - PROCESS | 2616 | RSS: Main: 156647424 03:05:54 INFO - PROCESS | 2616 | 03:08:56 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:34230/tests/dromaeo/cssquery-ext.html (next: http://localhost:34230/tests/dromaeo/cssquery-jquery.html) 03:08:57 INFO - PROCESS | 2616 | RSS: Main: 150794240 03:08:57 INFO - PROCESS | 2616 | 03:11:59 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:34230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34230/tests/dromaeo/cssquery-mootools.html) 03:11:59 INFO - PROCESS | 2616 | RSS: Main: 152330240 03:11:59 INFO - PROCESS | 2616 | 03:15:01 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:34230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34230/tests/dromaeo/cssquery-prototype.html) 03:15:02 INFO - PROCESS | 2616 | RSS: Main: 150536192 03:15:02 INFO - PROCESS | 2616 | 03:18:05 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:34230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34230/tests/dromaeo/cssquery-yui.html) 03:18:05 INFO - PROCESS | 2616 | RSS: Main: 150417408 03:18:05 INFO - PROCESS | 2616 | 03:21:08 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:34230/tests/dromaeo/cssquery-yui.html (next: http://localhost:34230/tests/dromaeo/cssquery-dojo.html) 03:21:08 INFO - PROCESS | 2616 | RSS: Main: 152285184 03:21:08 INFO - PROCESS | 2616 | 03:21:08 INFO - PROCESS | 2616 | __start_tp_report 03:21:08 INFO - PROCESS | 2616 | _x_x_mozilla_page_load 03:21:08 INFO - PROCESS | 2616 | _x_x_mozilla_page_load_details 03:21:08 INFO - PROCESS | 2616 | |i|pagename|runs| 03:21:08 INFO - PROCESS | 2616 | |0;dojo.html;2614.1373346795554;2639.5512762830317;2668.4262883480046;2678.1028355500907;2686.3955609987756;4482.394876691646;4584.564466375689;4596.264597664374;4615.538446155383;4627.791749371278;4544.182047231497;4599.908001839961;4603.930941035887;4682.625389968803;4683.25067989121;4297.871063868089;4299.462567179103;4306.267934451143;4360.825566977317;4377.102693947733;4360.062586543892;4369.126174765044;4390.209762242795;4403.713758605696;4452.10957808438;4187.267228235047;4263.893402664927;4273.850415235483;4308.6983911126235;4353.020570371641;4249.957500424987;4269.807858646368;4276.144771045772;4276.593723596254;4286.121345124242;4113.930378101715;4220.388043733641;4246.426732391118;4255.17024180285;4268.487781466213;4451.354553589711;4464.933026004613;4535.750533720644;4602.9079418411775;4611.492735799093;4964.801407943678;4996.9500304996845;5004.549590536869;5024.598032157419;5025.246213068032;4857.951420485785;5023.2214006829;5025.949740502621;5029.597632189416;5096.847094587169;4493.236149854532;4506.143832671749;4523.32150177476;4530.365748795171;4577.267637178035;5107.821226257063;5119.974400127976;5125.615578831603;5125.615578831603;5129.435762066169;4886.511348865085;4886.682365646222;4894.510548945148;4917.483664215278;4944.554990050912;4868.14807408702;4939.876503087452;4948.480409557017;5016.372953380827;5058.772355244023;4915.606751459874;4931.605471562267;4933.629977751683;4936.827211047596;4970.701757894538;4821.746345950079;4858.295547145644;4874.707517548958;4883.487233840467;4886.682365646222;4078.6125318094732;4159.646430053419;4160.375943608423;4173.874783756492;4257.084726783756;3610.4403817408343;3642.817859107034;3645.070507020746;3670.045788095061;3675.1547144156993;4204.810783514749;4220.725652832556;4242.7242229255;4262.296721041055;4278.529361770203;4806.44725856524;4871;4955.0337684151245;5034.697918124924;5062.417821950523;4290.313549832012;4299.032717638506;4300.569943005675;4311.719738217006;4326.4159338489535;4294.248506511348;4449.2658711312915;4481.641468682497;4493.191225579361;4498;4590.357349971074;4606.401167848158;4625.074985003012;4736.597389221817;4817.421909370898;4930.433000205022;4978.601711863114;4981.4769449207315;5000.224965130411;5044.041632089891;4695.34265202865;4696.835610753607;4716.198246298206;4718.457377401505;4750.667453278237;4782.928256076092;4855.878603034952;4864.246041863516;4920.803167873245;4956;4945.77744001528;4977.253411988086;4999.975000124976;5005.7997680092385;5022.146235139962;4789.3294938709305;4855.927161092657;4860.17377045896;4866.7079975201605;4880.243562247857;4689.953100468952;4784.6889952153;4832.516748325139;4884.560389564814;4936.531029552187;4681.321208424692;4684.6486513510945;4685.367475390915;4725.173094708481;4759.357486739246;4727.550882666279;4834.806607735652;4836.806527738851;4845.903081938271;4888.780004899717;4584.701994370355;4699.976500117615;4709.929351059668;4712.340272361804;4760.071786001835 03:21:08 INFO - PROCESS | 2616 | |1;ext.html;500.3395517916352;507.88572571171466;515.775637597645;526.6339893773827;539.8677324055607;24818.379540511498;25402.23793286202;31946.520802187955;32407.351852962925;32496.67503324972;35221.82389088057;35640.46539301913;35670.10824729383;35743;35886;7606.125295590995;7769.572673502955;7809.336206422461;7816.101148367954;7825.569593672346;7563.735269265577;7683.270089341504;7695.6152192390155;7702.614869256543;7729.497582657137;7667.386609071289;7762.728304509344;7827.882581761278;7931.206879312081;7934.246246606564;7789.571573563452;7879.133295337509;7898.289153976112;7898.80252993674;7926.524408535506;7523.683355412835;7749.457537972344;7749.651265693057;7760.340371068466;7786.104597971249;35944.46083308753;36648.267034659155;36726.449103263476;36726.81636591827;36739;2921.6055832462557;3039.361734035855;3055.801372910754;3100.612423447069;3119.3605310911207;26724.599131013052;27678.584821227698;27733.722662773518;27949.720502795117;28256.293592660142;3407.4207384744655;3440.3291358184915;3479.6346383629607;3520.3487354839435;3521.506989021539;218108;220956;221948;223790;224351;55550.444495554526;55902;55930;55942.72028639912;56175.71912140413;51021.74489127605;51364.743176284624;59300.40699592949;65901.67049164724;67745.66127169333;14018;14120.646983825487;14174.07868488545;14212.71574568503;14259.144451332953;10342.172626189888;10365.844512332322;10379.792404151875;10435.37387756737;10444.529996150191;19217.80782192188;19518.31685890987;19521.707174392395;19541.459610250575;19617.607647846962;7427.925720742832;7726.884096738553;7768;7884.802879928047;7885.5662938538935;839.1650307943635;882.1663527966139;913.9862902056475;995.9442990430167;1028.3521381529588;24791.752082479306;25179.87410062938;25291.49417011686;25565.744342556336;26126;923.4505469245788;935.036911980661;952.3238500664605;984.3109823123842;1019.8776146862276;12138.393080345948;12214.57248996281;14970.775438368433;15335.769963450557;15458.922705386625;225873;226585;228743;228799;228947;43236.78381608135;43980;43997.78001110038;44000.77999610046;44124;1179.7404570994538;1230.4585982167816;1231.1012960538858;1244.8506179258547;1245.9626211213679;24293.271201863972;26746;26821.19536413911;27426.451470970867;27569.172924812287;38172.42741358937;38871.41692874666;38879.6112038876;38955.22089558136;39201.6079839198;239358;240686;241039;242719;244090;28741.42517149687;38078.80960595179;38229;38365;38901.22197555976;33198.33603327968;33705.49441758425;34141;34145.65854341425;34435.82782086074;30547.694523054484;32475.67524324821;32590.348193035534;32903.17742056468;33130.5030424539;34097.659023410444;35641.466437452895;35708.821455892554;36014.099647507974;38864.6113538861;33073.669263307056;33261.833690831394;33449.83275083609;35923.640763592026;36618.26763464769;28484.57273140946;29775.404491910474;29949.55075673823;30075.81553870811;30942.53586196254;21597.01738362271;23014.884925575265;23213.41966450785;23317.183898563468;23634.29097127089 03:21:08 INFO - PROCESS | 2616 | |2;jquery.html;323.24844735988825;325.65805903801004;330.8957678331327;331.86891177984694;332.77038843198204;13617.251051192181;14218.933579981503;14803.481878134267;15003.849961500382;15674.451394201205;10522.684319470409;10630.202734794882;13231.735365292712;15276.847231527681;15294.388224471035;4223.556526564705;4597.678162528624;4657.604103651177;5039.622028347871;5054.039732450822;5013.147764879979;5101.948980510185;5106.591472682177;5107.693538387709;5109.795608175668;4823.493533179018;4965.0566392385335;5334.439883812202;5516.448355164472;5528.391876893538;5230.555402790767;5447.346318441792;5463.972680136594;5465.125579907196;5465.672059676433;4756.904861902743;4896.143174944371;4901.632377571661;4906.607471402279;4913.115639184945;11700.648980530597;11945.163838531307;11987.700307492296;12035.819462708067;14691.706165876623;1801.351513455155;1832.7617409736781;1873.1102726204945;1942.2328180368816;2017.2233690029298;8597.054324024351;9108.68119615817;9115.680951166678;11658.242214256132;12397.814032789516;1731.887427317233;1746.388763932626;1770.9114544272863;1831.8992455414948;1850.6272343514543;43912.780436097935;47562.524374756154;48613.513864861256;50664.74667626638;53389.733051334886;8790.604422800989;9155.679551215675;9338.112879276458;9398.778158839445;9446.338756286994;11689.240199387013;11700.473478693479;11756.882431175749;11880.821787673192;11888.643340699793;6979.511434199558;7050.647467626598;7134.357907788324;7147.2138064812825;7154.713811447588;6820.181578210647;6834.4874134440115;6856.794296171123;6880.208775990725;6891.345322194384;3982.38273067675;3986.142979259473;4006.2187873364996;4025.1144748155943;4045.939310910339;1629.54372775623;1694.2037242496008;1740.7475915992363;1806.8464180544538;1818.5271829324206;825.7852958230783;830.1034882327073;832.8334333133276;853.9103394143525;858.3519442820631;13362.599122026355;13914.443422263199;14256.287185640676;14299.57101286963;14990.62523436901;812.8983877015373;850.7702920211632;871.2681347667989;880.7489865388334;947.0340252942099;8525.829483410422;8659.696910608098;8815.338849586307;8829.955850220707;8861.778455538662;479406;480385;487986;492398;498137.5838087222;57868.8426231473;62396.37603623996;62706.68646656738;64767.35232647708;65479;1072.4369705904307;1096.8848270931596;1098.220263612828;1098.9560417583366;1100.8293714474269;12945.676358091123;13689.31553422305;14021.929890350482;14032;14380.856191437952;26762.330941725835;27446.451070978866;27669.584956226074;28418.147455576367;30989.535156973114;36179.095522612144;36966;37218.62781372152;37382;37586.81206593949;5906.0255057914965;6185.134081228722;6232.937670623236;6297.96851015742;6311.779087731908;7061.364477197077;9266.305027122859;9743.220542356736;9948.005199479994;9969.35199212049;6456.451201647913;7480.3641690456925;8319.708810191614;8875.600597972978;8880.378373513791;8616.217884576054;8650;8783.516906569945;8807.295416366547;8827.514486703292;8323.83352332962;8754.387192896436;8905.376623636543;8936.687215947411;9104.271658267455;6564.540482166202;6687.799366019027;6756.23800383885;6824;6914.997325387892;7539.698412063456;8790.310521856205;8792.780180495283;9079.68221112258;9187.402818816756 03:21:08 INFO - PROCESS | 2616 | |3;mootools.html;1365.3651052260698;1383.2461308586821;1497.348653335799;1684.83994020568;1699.5156380431572;6704.296048914861;6751.932480675192;6900.758473453424;6926.27274136216;6985.790426287213;6859.074025006623;6865.41643960264;6869.725210991554;6886.104806375164;6897.172339319289;2049.1086377425795;2071.388940262626;2089.1330098009385;2089.9791002090014;2096.0462989339812;2009.979900201001;2009.9899500502477;2054.4042227753935;2091.5607722378318;2098.055874856313;1735.1237624999358;1778.5909240874607;1953.3749200255925;2003.6593779057596;2024.433158715562;2009.1260301768632;2009.357005758158;2017.1628774058822;2019.3538067818304;2020.2020202020267;1928.6914093745074;1963.3619073800928;1964.5874366383077;1969.812867777559;1975.9703604445945;6689.632070236135;6697.129373181455;6707.597544147318;6716.697748601325;6736.494762892754;4002.639762421396;4106.240345536055;4130.896727581804;4153.54311025787;4161.771102589387;2601.5447296722996;2620.93447663808;2646.775024122952;2649.8012649051398;2664.920052398431;839.0393000014949;843.9071702112763;847.8812966184739;863.2274114667338;880.1374652840188;9040.728778136667;9056.13966673165;9073.727788166365;9087.182153606207;9087.182153606273;3518.3354798773953;3553.2538166985223;3622.0582648511577;3665.651763082503;3670.5595328560744;7514;7520.398368130536;7525.962370188224;7552.244775522514;7596.8480630388185;4038.1318016626565;4062.289099407592;4064.4106604542176;4066.6340029397497;4068.3897415387337;3733.1040550268285;3752.5309336332957;3788.8673896413493;3807.676347510437;3809.8857034289017;3056.938861222763;3077.046115704139;3113.470709979309;3130.6712795156636;3142.245860993391;914.2457472585144;917.9127982841619;932.4731526687535;934.7522906429801;937.779621788879;842.7808769719917;888.3603805260202;905.7599736069947;953.8712273843081;1128.142611615162;6159.3224745277985;6234.532410069172;6242.5942313749465;6244.687765611792;6247.406496382836;556.9777208911598;564.0608387035621;585.1106318396014;585.6398315036222;707.7558242406361;4793.976030119827;4830.541098595628;4833.73414462208;4868.8782780430065;4872.1473742094995;7958.6418611162635;8067.072286686989;8391.95804020976;8408.663653453794;8450.61972211252;8202.26179643823;8204.466709663853;8223.95888020568;8230.876536851953;8312;6234.096056071844;6443.097966284724;6506.707198176094;6599.967000164968;6616.206055273302;6192.225971753531;6325.462335701517;6333.461655759312;6336.873262534816;6372.203474565679;7118.181409138016;7284.745033923788;7310.342069213583;7337.963310183415;7355.117385913511;7195.46034047438;7320;7341.26587341283;7359.595222262613;7457.589832559262;5883.264591926009;6096.268447786294;6118.082287656887;6127.3566275540425;6130.601510901777;6515.837104072436;6543.1821022372205;6557.245916719638;6583.901241481286;6598.076269322395;6130.63216207029;6156.538259630456;6162.22972128484;6227.844303892439;6329;5380.43505431924;5480.780768769364;5919.970400147971;6162.352952939877;6192.783252586138;5996.520278377807;6026;6076.118962750465;6082.908756368746;6085.513158947185;5518.668879867221;5590.273264475755;5594.076977298863;5598.804041858678;5607.775688972559;5408.37803652585;5463.289772329572;5495.477929596682;5505.532029777353;5522.502974732293 03:21:08 INFO - PROCESS | 2616 | |4;prototype.html;303.92857678445563;313.81955375659004;319.87205117952817;320.06700468135404;321.3492677328408;5553.139263414172;5645.8588535286635;5761;5773.3937936516695;5785.826425207245;5507.705689163044;5655.1517272409155;5684.943150568493;5701.486866182043;5712.542996560275;4242.109157077018;4349.34759786033;4356.97821510892;4404.29531274996;4412.955870441295;4317.071829556645;4328.675349348796;4344.695871289011;4350.54319296474;4362.498312694033;4299.50555686097;4306.956930430702;4308.246056940038;4317.568243175673;4383.846565370212;4358.324459708719;4363.367311739796;4365.105153443536;4371.4972778130605;4377.277749171415;3679.6504332088407;3756.492873462075;3842.3852183650483;3846.11539345952;3846.788426636534;5308.097623404031;5425.810096646598;5447.891042179134;5452.318460192476;5456.345238571397;4929.482404347527;4952.62855285855;4957.603391728653;4964.776585053645;4965.577925876305;6006.519478441714;6011.278646562397;6015.669138197398;6024.939750602482;6026.337102918676;3984.322665146932;4042.9191416171807;4060.959390406117;4127.876163715094;4183.309753890604;6207.844803879894;6267.937320626781;6269.968650156766;6274.215723034621;6284.120223168806;4279.97860010698;4285.785710714452;4296.119295544406;4296.613304802583;4297.634701050383;4323.092150648399;4337.15425492026;4338.110687309094;4360.803763830635;4377.9781101094295;4828.227483602606;4974.27872958419;4977.875553111129;4978.626603004716;4988.326575912205;5933.288005439289;5964.015937370285;5978.043513037893;5980.312264089685;5996.850078748066;1545.2814441284856;1561.2584022589178;1569.9010692515285;1575.243882936174;1577.0458872382274;1047.895210478946;1053.2837670384213;1053.9262251642465;1071.919606029551;1075.4998925499524;5172.922406163911;5180.818671346485;5187.740612969336;5188.0661480933795;5191.818286360035;6123.510119190454;6206.193194884636;6207.286162091327;6221.9377806222265;6224.06639004153;5163.974180129076;5172.922406163911;5175.974120129451;5180.585553155814;5184.066867963727;3285.195127193853;3323.7507186960593;3357.949630755492;3362.4788157835574;3367.3770352484867;5711;5786.247787787561;5860.384659610765;5887.911681324784;5906.822795316148;6417.294097649255;6447.194100737408;6453.645049522322;6457.903131453032;6476.190476190476;5866.090755932837;5868.970655146697;5871.559633027455;5877.206577112035;5879.3826648202175;6024.668643224665;6269.341719119427;6271.341509141657;6273.121762953281;6274.090256912813;6116.694165291807;6121.204243448323;6126.050462178369;6130.846728831815;6132.6627035513475;5806.44838740319;5878.529717622666;5878.735456904364;5893.499052580579;5897.469227769521;4055.7566546007333;4092.3656833190903;4094.754314741006;4109.465769450072;4111.547729749785;6080.908786368296;6242.563020588515;6242.687865606792;6254.562180647493;6257.53068519872;6011.849703757266;6014.1580178775885;6022.488088512526;6031.703183815501;6045.939540604538;5955.910661339996;5959.523238141025;5979.850503737267;5983.4914032306;6004.339522652592;5697.401772813795;5852.824415267549;5874.970625146847;5877.764889404547;5885.852853678693;6070.514358851369;6079.3008803988105;6083.391660833881;6091.299500557316;6095.329513753395;5801.8549536261935;5819.94180058194;5834.533237341087;5841.18223448709;5872.265966754156 03:21:08 INFO - PROCESS | 2616 | |5;yui.html;762.7673559564334;765.1162906842598;775.9456838021339;788.7554857994025;791.9049714034317;11256.54973801048;11303.208775385727;11325.377104259262;11344.092472602193;11366.659000229996;10986.285891417072;11135;11186.776264474705;11198.888011119887;11223.158263130257;763.7059732003177;775.5269285735696;775.7284950267418;776.3556248313914;779.8791187365968;765.4565258666354;767.4972892755254;768.7271018788333;772.3666593393419;772.4168252969029;815.6615004773012;817.5544328341068;822.4736168851939;824.1181935329171;826.7437094500694;816.4529765057396;817.65249768848;818.2758258940851;818.7502811642447;820.3519219816368;607.8510764862593;609.1471939284992;609.7225762278152;609.765240382456;610.4658423879106;11048.226624136314;11074.501647425805;11076.280041797258;11135.777284454265;11161.330320180816;10067.697969060866;10095.899041009568;10168.084872361449;10206;10285.485725713685;10501.09344877228;10589.73525661857;10863.239573229877;10884.564617415293;10895.564177432892;3259.2177877309273;3318.0377690469736;3325.7173140283103;3380.070480617825;3390.2710917152685;38250;38597.80701096504;38772.22455550901;39150.60849391498;40542.79728601338;9574.95212523933;9685.128338449573;9763.463009534402;9949.502524873727;9963.103320701026;17126.828731712525;17127;17152.399666011628;17162.656746864992;17180.570485737957;6591.736330546821;6638.701258443285;6651.368120028589;6705.430038446689;6813.454923606099;3616.710663146942;3652.7077833773233;3664.1755604988666;3670.2109046554583;3683.834227459771;2539.911103111382;2546.1597672767944;2564.9743502565107;2571.4085760275243;2592.0539003263675;484.0754159555233;487.6756956623805;495.09891996565904;496.0624419846493;499.1713755166479;576.844252051952;588.6173986908543;592.7406586447047;607.808540309801;613.5429105316479;7322.816929576803;7646.502977306457;7655.349295309961;7705.9229407706325;7708.306252437307;574.4772257245886;585.2158108135119;587.0196771391786;599.658194828952;604.4257954942734;3441.4149594568985;3573.5533058367705;3636.7636103653176;3641.7450778445786;3687.7049836013052;47226.58320250398;48156.27765583519;48386;48788;48879;42446.363304550454;42661;42705.35941960873;43007.262023538366;43168.56831431708;36424.453633195524;37592;38163.23673526514;38708.225835483136;39068.43726250918;8189.676710138458;8232.794180145544;8505.829883402173;8537.40238183346;8728.956355218183;30114.698853012065;30279.69720302857;30503.694963050086;30601.846990764905;31252.687473124977;34295.65704343024;34386.484202737476;34398.82800585981;37616.43575346427;38299;9997.150242229493;10038.333250360873;10054.34646747959;10267.589296428358;10729.839052414063;10069.19446444268;10543.578256869947;10739.570417183226;10869.836952445878;11004.559817607525;10252.794944101226;10525.526351314362;10782.299150555189;10793.784124317626;10824.188185886247;10185.541650625888;10236.641717539851;10531.736706582396;10756.031957123896;10941.12471002302;9974.351667141613;10174.13519850821;10458.163346932075;10524;10683.679489615324;8542.40203185771;8643.265322447662;8797.780055498664;8819.867701984347;9113.954430227806;8497.957510212409;8748.300135988979;8872.689455869013;9395.107464790834;9474.526273686426 03:21:08 INFO - PROCESS | 2616 | __end_tp_report 03:21:08 INFO - PROCESS | 2616 | __start_cc_report 03:21:08 INFO - PROCESS | 2616 | _x_x_mozilla_cycle_collect,333 03:21:08 INFO - PROCESS | 2616 | __end_cc_report 03:21:08 INFO - PROCESS | 2616 | __startTimestamp1452770468640__endTimestamp 03:21:08 INFO - PROCESS | 2616 | 03:21:08 INFO - PROCESS | 2616 | ------- Summary: start ------- 03:21:08 INFO - PROCESS | 2616 | Number of tests: 6 03:21:08 INFO - PROCESS | 2616 | 03:21:08 INFO - PROCESS | 2616 | [#0] dojo.html Cycles:165 Average:4579.37 Median:4689.95 stddev:474.04 (10.1%) stddev-sans-first:449.73 03:21:08 INFO - PROCESS | 2616 | Values: 2614.1 2639.6 2668.4 2678.1 2686.4 4482.4 4584.6 4596.3 4615.5 4627.8 4544.2 4599.9 4603.9 4682.6 4683.3 4297.9 4299.5 4306.3 4360.8 4377.1 4360.1 4369.1 4390.2 4403.7 4452.1 4187.3 4263.9 4273.9 4308.7 4353.0 4250.0 4269.8 4276.1 4276.6 4286.1 4113.9 4220.4 4246.4 4255.2 4268.5 4451.4 4464.9 4535.8 4602.9 4611.5 4964.8 4997.0 5004.5 5024.6 5025.2 4858.0 5023.2 5025.9 5029.6 5096.8 4493.2 4506.1 4523.3 4530.4 4577.3 5107.8 5120.0 5125.6 5125.6 5129.4 4886.5 4886.7 4894.5 4917.5 4944.6 4868.1 4939.9 4948.5 5016.4 5058.8 4915.6 4931.6 4933.6 4936.8 4970.7 4821.7 4858.3 4874.7 4883.5 4886.7 4078.6 4159.6 4160.4 4173.9 4257.1 3610.4 3642.8 3645.1 3670.0 3675.2 4204.8 4220.7 4242.7 4262.3 4278.5 4806.4 4871.0 4955.0 5034.7 5062.4 4290.3 4299.0 4300.6 4311.7 4326.4 4294.2 4449.3 4481.6 4493.2 4498.0 4590.4 4606.4 4625.1 4736.6 4817.4 4930.4 4978.6 4981.5 5000.2 5044.0 4695.3 4696.8 4716.2 4718.5 4750.7 4782.9 4855.9 4864.2 4920.8 4956.0 4945.8 4977.3 5000.0 5005.8 5022.1 4789.3 4855.9 4860.2 4866.7 4880.2 4690.0 4784.7 4832.5 4884.6 4936.5 4681.3 4684.6 4685.4 4725.2 4759.4 4727.6 4834.8 4836.8 4845.9 4888.8 4584.7 4700.0 4709.9 4712.3 4760.1 03:21:08 INFO - PROCESS | 2616 | 03:21:08 INFO - PROCESS | 2616 | [#1] ext.html Cycles:180 Average:39192.98 Median:34143.33 stddev:59932.69 (175.5%) stddev-sans-first:60030.40 03:21:08 INFO - PROCESS | 2616 | Values: 500.3 507.9 515.8 526.6 539.9 24818.4 25402.2 31946.5 32407.4 32496.7 35221.8 35640.5 35670.1 35743.0 35886.0 7606.1 7769.6 7809.3 7816.1 7825.6 7563.7 7683.3 7695.6 7702.6 7729.5 7667.4 7762.7 7827.9 7931.2 7934.2 7789.6 7879.1 7898.3 7898.8 7926.5 7523.7 7749.5 7749.7 7760.3 7786.1 35944.5 36648.3 36726.4 36726.8 36739.0 2921.6 3039.4 3055.8 3100.6 3119.4 26724.6 27678.6 27733.7 27949.7 28256.3 3407.4 3440.3 3479.6 3520.3 3521.5 218108.0 220956.0 221948.0 223790.0 224351.0 55550.4 55902.0 55930.0 55942.7 56175.7 51021.7 51364.7 59300.4 65901.7 67745.7 14018.0 14120.6 14174.1 14212.7 14259.1 10342.2 10365.8 10379.8 10435.4 10444.5 19217.8 19518.3 19521.7 19541.5 19617.6 7427.9 7726.9 7768.0 7884.8 7885.6 839.2 882.2 914.0 995.9 1028.4 24791.8 25179.9 25291.5 25565.7 26126.0 923.5 935.0 952.3 984.3 1019.9 12138.4 12214.6 14970.8 15335.8 15458.9 225873.0 226585.0 228743.0 228799.0 228947.0 43236.8 43980.0 43997.8 44000.8 44124.0 1179.7 1230.5 1231.1 1244.9 1246.0 24293.3 26746.0 26821.2 27426.5 27569.2 38172.4 38871.4 38879.6 38955.2 39201.6 239358.0 240686.0 241039.0 242719.0 244090.0 28741.4 38078.8 38229.0 38365.0 38901.2 33198.3 33705.5 34141.0 34145.7 34435.8 30547.7 32475.7 32590.3 32903.2 33130.5 34097.7 35641.5 35708.8 36014.1 38864.6 33073.7 33261.8 33449.8 35923.6 36618.3 28484.6 29775.4 29949.6 30075.8 30942.5 21597.0 23014.9 23213.4 23317.2 23634.3 03:21:08 INFO - PROCESS | 2616 | 03:21:08 INFO - PROCESS | 2616 | [#2] jquery.html Cycles:180 Average:24463.35 Median:5026.38 stddev:79608.70 (1583.8%) stddev-sans-first:79811.38 03:21:08 INFO - PROCESS | 2616 | Values: 323.2 325.7 330.9 331.9 332.8 13617.3 14218.9 14803.5 15003.8 15674.5 10522.7 10630.2 13231.7 15276.8 15294.4 4223.6 4597.7 4657.6 5039.6 5054.0 5013.1 5101.9 5106.6 5107.7 5109.8 4823.5 4965.1 5334.4 5516.4 5528.4 5230.6 5447.3 5464.0 5465.1 5465.7 4756.9 4896.1 4901.6 4906.6 4913.1 11700.6 11945.2 11987.7 12035.8 14691.7 1801.4 1832.8 1873.1 1942.2 2017.2 8597.1 9108.7 9115.7 11658.2 12397.8 1731.9 1746.4 1770.9 1831.9 1850.6 43912.8 47562.5 48613.5 50664.7 53389.7 8790.6 9155.7 9338.1 9398.8 9446.3 11689.2 11700.5 11756.9 11880.8 11888.6 6979.5 7050.6 7134.4 7147.2 7154.7 6820.2 6834.5 6856.8 6880.2 6891.3 3982.4 3986.1 4006.2 4025.1 4045.9 1629.5 1694.2 1740.7 1806.8 1818.5 825.8 830.1 832.8 853.9 858.4 13362.6 13914.4 14256.3 14299.6 14990.6 812.9 850.8 871.3 880.7 947.0 8525.8 8659.7 8815.3 8830.0 8861.8 479406.0 480385.0 487986.0 492398.0 498137.6 57868.8 62396.4 62706.7 64767.4 65479.0 1072.4 1096.9 1098.2 1099.0 1100.8 12945.7 13689.3 14021.9 14032.0 14380.9 26762.3 27446.5 27669.6 28418.1 30989.5 36179.1 36966.0 37218.6 37382.0 37586.8 5906.0 6185.1 6232.9 6298.0 6311.8 7061.4 9266.3 9743.2 9948.0 9969.4 6456.5 7480.4 8319.7 8875.6 8880.4 8616.2 8650.0 8783.5 8807.3 8827.5 8323.8 8754.4 8905.4 8936.7 9104.3 6564.5 6687.8 6756.2 6824.0 6915.0 7539.7 8790.3 8792.8 9079.7 9187.4 03:21:08 INFO - PROCESS | 2616 | 03:21:08 INFO - PROCESS | 2616 | [#3] mootools.html Cycles:180 Average:4720.61 Median:6122.72 stddev:2455.38 (40.1%) stddev-sans-first:2449.32 03:21:08 INFO - PROCESS | 2616 | Values: 1365.4 1383.2 1497.3 1684.8 1699.5 6704.3 6751.9 6900.8 6926.3 6985.8 6859.1 6865.4 6869.7 6886.1 6897.2 2049.1 2071.4 2089.1 2090.0 2096.0 2010.0 2010.0 2054.4 2091.6 2098.1 1735.1 1778.6 1953.4 2003.7 2024.4 2009.1 2009.4 2017.2 2019.4 2020.2 1928.7 1963.4 1964.6 1969.8 1976.0 6689.6 6697.1 6707.6 6716.7 6736.5 4002.6 4106.2 4130.9 4153.5 4161.8 2601.5 2620.9 2646.8 2649.8 2664.9 839.0 843.9 847.9 863.2 880.1 9040.7 9056.1 9073.7 9087.2 9087.2 3518.3 3553.3 3622.1 3665.7 3670.6 7514.0 7520.4 7526.0 7552.2 7596.8 4038.1 4062.3 4064.4 4066.6 4068.4 3733.1 3752.5 3788.9 3807.7 3809.9 3056.9 3077.0 3113.5 3130.7 3142.2 914.2 917.9 932.5 934.8 937.8 842.8 888.4 905.8 953.9 1128.1 6159.3 6234.5 6242.6 6244.7 6247.4 557.0 564.1 585.1 585.6 707.8 4794.0 4830.5 4833.7 4868.9 4872.1 7958.6 8067.1 8392.0 8408.7 8450.6 8202.3 8204.5 8224.0 8230.9 8312.0 6234.1 6443.1 6506.7 6600.0 6616.2 6192.2 6325.5 6333.5 6336.9 6372.2 7118.2 7284.7 7310.3 7338.0 7355.1 7195.5 7320.0 7341.3 7359.6 7457.6 5883.3 6096.3 6118.1 6127.4 6130.6 6515.8 6543.2 6557.2 6583.9 6598.1 6130.6 6156.5 6162.2 6227.8 6329.0 5380.4 5480.8 5920.0 6162.4 6192.8 5996.5 6026.0 6076.1 6082.9 6085.5 5518.7 5590.3 5594.1 5598.8 5607.8 5408.4 5463.3 5495.5 5505.5 5522.5 03:21:08 INFO - PROCESS | 2616 | 03:21:08 INFO - PROCESS | 2616 | [#4] prototype.html Cycles:180 Average:4947.20 Median:5530.42 stddev:1466.91 (26.5%) stddev-sans-first:1429.03 03:21:08 INFO - PROCESS | 2616 | Values: 303.9 313.8 319.9 320.1 321.3 5553.1 5645.9 5761.0 5773.4 5785.8 5507.7 5655.2 5684.9 5701.5 5712.5 4242.1 4349.3 4357.0 4404.3 4413.0 4317.1 4328.7 4344.7 4350.5 4362.5 4299.5 4307.0 4308.2 4317.6 4383.8 4358.3 4363.4 4365.1 4371.5 4377.3 3679.7 3756.5 3842.4 3846.1 3846.8 5308.1 5425.8 5447.9 5452.3 5456.3 4929.5 4952.6 4957.6 4964.8 4965.6 6006.5 6011.3 6015.7 6024.9 6026.3 3984.3 4042.9 4061.0 4127.9 4183.3 6207.8 6267.9 6270.0 6274.2 6284.1 4280.0 4285.8 4296.1 4296.6 4297.6 4323.1 4337.2 4338.1 4360.8 4378.0 4828.2 4974.3 4977.9 4978.6 4988.3 5933.3 5964.0 5978.0 5980.3 5996.9 1545.3 1561.3 1569.9 1575.2 1577.0 1047.9 1053.3 1053.9 1071.9 1075.5 5172.9 5180.8 5187.7 5188.1 5191.8 6123.5 6206.2 6207.3 6221.9 6224.1 5164.0 5172.9 5176.0 5180.6 5184.1 3285.2 3323.8 3357.9 3362.5 3367.4 5711.0 5786.2 5860.4 5887.9 5906.8 6417.3 6447.2 6453.6 6457.9 6476.2 5866.1 5869.0 5871.6 5877.2 5879.4 6024.7 6269.3 6271.3 6273.1 6274.1 6116.7 6121.2 6126.1 6130.8 6132.7 5806.4 5878.5 5878.7 5893.5 5897.5 4055.8 4092.4 4094.8 4109.5 4111.5 6080.9 6242.6 6242.7 6254.6 6257.5 6011.8 6014.2 6022.5 6031.7 6045.9 5955.9 5959.5 5979.9 5983.5 6004.3 5697.4 5852.8 5875.0 5877.8 5885.9 6070.5 6079.3 6083.4 6091.3 6095.3 5801.9 5819.9 5834.5 5841.2 5872.3 03:21:08 INFO - PROCESS | 2616 | 03:21:08 INFO - PROCESS | 2616 | [#5] yui.html Cycles:180 Average:11894.46 Median:39109.52 stddev:13132.14 (33.6%) stddev-sans-first:13142.37 03:21:08 INFO - PROCESS | 2616 | Values: 762.8 765.1 775.9 788.8 791.9 11256.5 11303.2 11325.4 11344.1 11366.7 10986.3 11135.0 11186.8 11198.9 11223.2 763.7 775.5 775.7 776.4 779.9 765.5 767.5 768.7 772.4 772.4 815.7 817.6 822.5 824.1 826.7 816.5 817.7 818.3 818.8 820.4 607.9 609.1 609.7 609.8 610.5 11048.2 11074.5 11076.3 11135.8 11161.3 10067.7 10095.9 10168.1 10206.0 10285.5 10501.1 10589.7 10863.2 10884.6 10895.6 3259.2 3318.0 3325.7 3380.1 3390.3 38250.0 38597.8 38772.2 39150.6 40542.8 9575.0 9685.1 9763.5 9949.5 9963.1 17126.8 17127.0 17152.4 17162.7 17180.6 6591.7 6638.7 6651.4 6705.4 6813.5 3616.7 3652.7 3664.2 3670.2 3683.8 2539.9 2546.2 2565.0 2571.4 2592.1 484.1 487.7 495.1 496.1 499.2 576.8 588.6 592.7 607.8 613.5 7322.8 7646.5 7655.3 7705.9 7708.3 574.5 585.2 587.0 599.7 604.4 3441.4 3573.6 3636.8 3641.7 3687.7 47226.6 48156.3 48386.0 48788.0 48879.0 42446.4 42661.0 42705.4 43007.3 43168.6 36424.5 37592.0 38163.2 38708.2 39068.4 8189.7 8232.8 8505.8 8537.4 8729.0 30114.7 30279.7 30503.7 30601.8 31252.7 34295.7 34386.5 34398.8 37616.4 38299.0 9997.2 10038.3 10054.3 10267.6 10729.8 10069.2 10543.6 10739.6 10869.8 11004.6 10252.8 10525.5 10782.3 10793.8 10824.2 10185.5 10236.6 10531.7 10756.0 10941.1 9974.4 10174.1 10458.2 10524.0 10683.7 8542.4 8643.3 8797.8 8819.9 9114.0 8498.0 8748.3 8872.7 9395.1 9474.5 03:21:08 INFO - PROCESS | 2616 | -------- Summary: end -------- 03:21:08 INFO - PROCESS | 2616 | 03:21:09 INFO - TEST-INFO | 2616: exit 0 03:21:09 INFO - TEST-OK | dromaeo_css | took 1114990ms 03:21:09 INFO - TEST-START | kraken 03:21:09 INFO - operating with platform_type : linux_ 03:21:09 INFO - Initialising browser for kraken test... 03:21:09 INFO - TEST-INFO | started process 2965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw1dZoZ/profile http://localhost:34230/getInfo.html) 03:21:13 INFO - PROCESS | 2965 | 03:21:13 INFO - PROCESS | 2965 | (process:3036): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:21:14 INFO - PROCESS | 2965 | __metrics Screen width/height:1600/1200 03:21:14 INFO - PROCESS | 2965 | colorDepth:24 03:21:14 INFO - PROCESS | 2965 | Browser inner width/height: 1024/697 03:21:14 INFO - PROCESS | 2965 | __metrics 03:21:14 INFO - PROCESS | 2965 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:21:15 INFO - TEST-INFO | 2965: exit 0 03:21:15 INFO - Browser initialized. 03:21:15 INFO - Running cycle 1/1 for kraken test... 03:21:15 INFO - TEST-INFO | started process 3085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw1dZoZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:16 INFO - PROCESS | 3085 | 03:21:16 INFO - PROCESS | 3085 | (process:3144): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:21:27 INFO - PROCESS | 3085 | RSS: Main: 151654400 03:21:27 INFO - PROCESS | 3085 | 03:21:29 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34230/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:30 INFO - PROCESS | 3085 | RSS: Main: 150614016 03:21:30 INFO - PROCESS | 3085 | 03:21:33 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34230/tests/kraken/driver.html?testName=audio-dft) 03:21:33 INFO - PROCESS | 3085 | RSS: Main: 154775552 03:21:33 INFO - PROCESS | 3085 | 03:21:36 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34230/tests/kraken/driver.html?testName=audio-fft) 03:21:37 INFO - PROCESS | 3085 | RSS: Main: 146214912 03:21:37 INFO - PROCESS | 3085 | 03:21:39 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34230/tests/kraken/driver.html?testName=audio-oscillator) 03:21:40 INFO - PROCESS | 3085 | RSS: Main: 146706432 03:21:40 INFO - PROCESS | 3085 | 03:21:42 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:43 INFO - PROCESS | 3085 | RSS: Main: 148930560 03:21:43 INFO - PROCESS | 3085 | 03:21:46 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34230/tests/kraken/driver.html?testName=imaging-darkroom) 03:21:46 INFO - PROCESS | 3085 | RSS: Main: 148983808 03:21:46 INFO - PROCESS | 3085 | 03:21:50 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34230/tests/kraken/driver.html?testName=imaging-desaturate) 03:21:50 INFO - PROCESS | 3085 | RSS: Main: 149364736 03:21:50 INFO - PROCESS | 3085 | 03:21:53 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34230/tests/kraken/driver.html?testName=json-parse-financial) 03:21:54 INFO - PROCESS | 3085 | RSS: Main: 151134208 03:21:54 INFO - PROCESS | 3085 | 03:21:56 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:21:56 INFO - PROCESS | 3085 | RSS: Main: 151011328 03:21:56 INFO - PROCESS | 3085 | 03:21:58 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34230/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:21:59 INFO - PROCESS | 3085 | RSS: Main: 151236608 03:21:59 INFO - PROCESS | 3085 | 03:22:01 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:22:01 INFO - PROCESS | 3085 | RSS: Main: 151719936 03:22:01 INFO - PROCESS | 3085 | 03:22:04 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:22:05 INFO - PROCESS | 3085 | RSS: Main: 152223744 03:22:05 INFO - PROCESS | 3085 | 03:22:07 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:22:08 INFO - PROCESS | 3085 | RSS: Main: 151699456 03:22:08 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:34230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34230/tests/kraken/driver.html?testName=ai-astar) 03:22:10 INFO - PROCESS | 3085 | RSS: Main: 151912448 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | __start_tp_report 03:22:10 INFO - PROCESS | 3085 | _x_x_mozilla_page_load 03:22:10 INFO - PROCESS | 3085 | _x_x_mozilla_page_load_details 03:22:10 INFO - PROCESS | 3085 | |i|pagename|runs| 03:22:10 INFO - PROCESS | 3085 | |0;ai-astar;116;109;114;115;115;125;113;114;115;117 03:22:10 INFO - PROCESS | 3085 | |1;audio-beat-detection;165;131;158;177;135;160;163;139;178;134 03:22:10 INFO - PROCESS | 3085 | |2;audio-dft;161;164;164;162;162;175;168;167;167;164 03:22:10 INFO - PROCESS | 3085 | |3;audio-fft;76;72;72;73;134;76;71;72;72;87 03:22:10 INFO - PROCESS | 3085 | |4;audio-oscillator;96;97;136;97;97;98;131;97;97;132 03:22:10 INFO - PROCESS | 3085 | |5;imaging-gaussian-blur;110;109;110;110;111;111;110;110;110;110 03:22:10 INFO - PROCESS | 3085 | |6;imaging-darkroom;147;150;148;149;148;149;148;148;147;148 03:22:10 INFO - PROCESS | 3085 | |7;imaging-desaturate;97;97;98;96;95;96;96;98;96;96 03:22:10 INFO - PROCESS | 3085 | |8;json-parse-financial;71;71;70;71;73;70;71;70;68;70 03:22:10 INFO - PROCESS | 3085 | |9;json-stringify-tinderbox;67;67;67;67;66;68;66;68;67;67 03:22:10 INFO - PROCESS | 3085 | |10;stanford-crypto-aes;84;92;88;88;93;85;87;86;87;85 03:22:10 INFO - PROCESS | 3085 | |11;stanford-crypto-ccm;126;122;119;122;118;123;122;127;130;127 03:22:10 INFO - PROCESS | 3085 | |12;stanford-crypto-pbkdf2;141;142;161;151;151;147;165;151;152;136 03:22:10 INFO - PROCESS | 3085 | |13;stanford-crypto-sha256-iterative;70;70;73;75;71;72;71;70;70;71 03:22:10 INFO - PROCESS | 3085 | __end_tp_report 03:22:10 INFO - PROCESS | 3085 | __start_cc_report 03:22:10 INFO - PROCESS | 3085 | _x_x_mozilla_cycle_collect,830 03:22:10 INFO - PROCESS | 3085 | __end_cc_report 03:22:10 INFO - PROCESS | 3085 | __startTimestamp1452770530323__endTimestamp 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | ------- Summary: start ------- 03:22:10 INFO - PROCESS | 3085 | Number of tests: 14 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:4.03 (3.5%) stddev-sans-first:4.27 03:22:10 INFO - PROCESS | 3085 | Values: 116.0 109.0 114.0 115.0 115.0 125.0 113.0 114.0 115.0 117.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:161.50 stddev:17.87 (11.1%) stddev-sans-first:18.51 03:22:10 INFO - PROCESS | 3085 | Values: 165.0 131.0 158.0 177.0 135.0 160.0 163.0 139.0 178.0 134.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.50 stddev:4.12 (2.5%) stddev-sans-first:4.04 03:22:10 INFO - PROCESS | 3085 | Values: 161.0 164.0 164.0 162.0 162.0 175.0 168.0 167.0 167.0 164.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#3] audio-fft Cycles:10 Average:80.50 Median:72.50 stddev:19.38 (26.7%) stddev-sans-first:20.49 03:22:10 INFO - PROCESS | 3085 | Values: 76.0 72.0 72.0 73.0 134.0 76.0 71.0 72.0 72.0 87.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:97.00 stddev:17.44 (18.0%) stddev-sans-first:17.97 03:22:10 INFO - PROCESS | 3085 | Values: 96.0 97.0 136.0 97.0 97.0 98.0 131.0 97.0 97.0 132.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:22:10 INFO - PROCESS | 3085 | Values: 110.0 109.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 110.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 03:22:10 INFO - PROCESS | 3085 | Values: 147.0 150.0 148.0 149.0 148.0 149.0 148.0 148.0 147.0 148.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.97 (1.0%) stddev-sans-first:1.01 03:22:10 INFO - PROCESS | 3085 | Values: 97.0 97.0 98.0 96.0 95.0 96.0 96.0 98.0 96.0 96.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#8] json-parse-financial Cycles:10 Average:70.50 Median:71.00 stddev:1.27 (1.8%) stddev-sans-first:1.33 03:22:10 INFO - PROCESS | 3085 | Values: 71.0 71.0 70.0 71.0 73.0 70.0 71.0 70.0 68.0 70.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 03:22:10 INFO - PROCESS | 3085 | Values: 67.0 67.0 67.0 67.0 66.0 68.0 66.0 68.0 67.0 67.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.50 stddev:2.95 (3.4%) stddev-sans-first:2.85 03:22:10 INFO - PROCESS | 3085 | Values: 84.0 92.0 88.0 88.0 93.0 85.0 87.0 86.0 87.0 85.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.50 stddev:3.81 (3.1%) stddev-sans-first:3.94 03:22:10 INFO - PROCESS | 3085 | Values: 126.0 122.0 119.0 122.0 118.0 123.0 122.0 127.0 130.0 127.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:151.00 stddev:8.83 (5.8%) stddev-sans-first:8.79 03:22:10 INFO - PROCESS | 3085 | Values: 141.0 142.0 161.0 151.0 151.0 147.0 165.0 151.0 152.0 136.0 03:22:10 INFO - PROCESS | 3085 | 03:22:10 INFO - PROCESS | 3085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:1.64 (2.3%) stddev-sans-first:1.67 03:22:10 INFO - PROCESS | 3085 | Values: 70.0 70.0 73.0 75.0 71.0 72.0 71.0 70.0 70.0 71.0 03:22:10 INFO - PROCESS | 3085 | -------- Summary: end -------- 03:22:10 INFO - PROCESS | 3085 | 03:22:11 INFO - TEST-INFO | 3085: exit 0 03:22:11 INFO - TEST-OK | kraken | took 61921ms 03:22:11 INFO - TEST-START | v8_7 03:22:11 INFO - operating with platform_type : linux_ 03:22:11 INFO - Initialising browser for v8_7 test... 03:22:11 INFO - TEST-INFO | started process 3372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOj5mQo/profile http://localhost:34230/getInfo.html) 03:22:15 INFO - PROCESS | 3372 | 03:22:15 INFO - PROCESS | 3372 | (process:3447): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:22:16 INFO - PROCESS | 3372 | __metrics Screen width/height:1600/1200 03:22:16 INFO - PROCESS | 3372 | colorDepth:24 03:22:16 INFO - PROCESS | 3372 | Browser inner width/height: 1024/697 03:22:16 INFO - PROCESS | 3372 | __metrics 03:22:16 INFO - PROCESS | 3372 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:22:17 INFO - TEST-INFO | 3372: exit 0 03:22:17 INFO - Browser initialized. 03:22:17 INFO - Running cycle 1/1 for v8_7 test... 03:22:17 INFO - TEST-INFO | started process 3496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOj5mQo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:18 INFO - PROCESS | 3496 | 03:22:18 INFO - PROCESS | 3496 | (process:3551): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:22:29 INFO - PROCESS | 3496 | RSS: Main: 150478848 03:22:29 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:34230/tests/v8_7/run.html (next: http://localhost:34230/tests/v8_7/run.html) 03:22:52 INFO - PROCESS | 3496 | RSS: Main: 146145280 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | __start_tp_report 03:22:52 INFO - PROCESS | 3496 | _x_x_mozilla_page_load 03:22:52 INFO - PROCESS | 3496 | _x_x_mozilla_page_load_details 03:22:52 INFO - PROCESS | 3496 | |i|pagename|runs| 03:22:52 INFO - PROCESS | 3496 | |0;Richards;166.11295681063123 03:22:52 INFO - PROCESS | 3496 | |1;DeltaBlue;187.72292096865027 03:22:52 INFO - PROCESS | 3496 | |2;Encrypt;277.31558513588465 03:22:52 INFO - PROCESS | 3496 | |3;Decrypt;5240.837696335078 03:22:52 INFO - PROCESS | 3496 | |4;RayTrace;1063.8297872340424 03:22:52 INFO - PROCESS | 3496 | |5;Earley;727.2727272727273 03:22:52 INFO - PROCESS | 3496 | |6;Boyer;12456.79012345679 03:22:52 INFO - PROCESS | 3496 | |7;RegExp;42937.5 03:22:52 INFO - PROCESS | 3496 | |8;Splay;605.6935190793458 03:22:52 INFO - PROCESS | 3496 | |9;NavierStokes;4826.923076923077 03:22:52 INFO - PROCESS | 3496 | __end_tp_report 03:22:52 INFO - PROCESS | 3496 | __startTimestamp1452770572273__endTimestamp 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | ------- Summary: start ------- 03:22:52 INFO - PROCESS | 3496 | Number of tests: 10 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 03:22:52 INFO - PROCESS | 3496 | Values: 166.1 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 03:22:52 INFO - PROCESS | 3496 | Values: 187.7 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | [#2] Encrypt Cycles:1 Average:277.32 Median:277.32 stddev:0.00 (0.0%) 03:22:52 INFO - PROCESS | 3496 | Values: 277.3 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 03:22:52 INFO - PROCESS | 3496 | Values: 5240.8 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 03:22:52 INFO - PROCESS | 3496 | Values: 1063.8 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | [#5] Earley Cycles:1 Average:727.27 Median:727.27 stddev:0.00 (0.0%) 03:22:52 INFO - PROCESS | 3496 | Values: 727.3 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 03:22:52 INFO - PROCESS | 3496 | Values: 12456.8 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | [#7] RegExp Cycles:1 Average:42937.50 Median:42937.50 stddev:0.00 (0.0%) 03:22:52 INFO - PROCESS | 3496 | Values: 42937.5 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | [#8] Splay Cycles:1 Average:605.69 Median:605.69 stddev:0.00 (0.0%) 03:22:52 INFO - PROCESS | 3496 | Values: 605.7 03:22:52 INFO - PROCESS | 3496 | 03:22:52 INFO - PROCESS | 3496 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 03:22:52 INFO - PROCESS | 3496 | Values: 4826.9 03:22:52 INFO - PROCESS | 3496 | -------- Summary: end -------- 03:22:52 INFO - PROCESS | 3496 | 03:22:53 INFO - TEST-INFO | 3496: exit 0 03:22:53 INFO - TEST-OK | v8_7 | took 41985ms 03:22:53 INFO - SUITE-END | took 1218s 03:22:53 INFO - Completed test suite (00:20:19) 03:22:53 INFO - Working with test: dromaeo_css 03:22:53 INFO - Generating results file: dromaeo_css 03:22:53 INFO - Working with test: kraken 03:22:53 INFO - Generating results file: kraken 03:22:53 INFO - javascript benchmark 03:22:53 INFO - Working with test: v8_7 03:22:53 INFO - Generating results file: v8_7 03:22:53 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:22:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 03:22:53 INFO - process_Request line: dromaeo_css 6150.16 graph.html#tests=[[72,132,43]] 03:22:53 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:22:53 INFO - process_Request line: kraken 1547.40 graph.html#tests=[[232,132,43]] 03:22:53 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:22:53 INFO - process_Request line: v8_7 20243.38 graph.html#tests=[[230,132,43]] 03:22:53 INFO - RETURN: dromaeo_css: 6150.16 03:22:53 INFO - RETURN: kraken: 1547.40 03:22:53 INFO - RETURN: v8_7: 20243.38 03:22:53 INFO - javascript benchmark 03:22:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2614.1373346795554, 2639.5512762830317, 2668.4262883480046, 2678.1028355500907, 2686.3955609987756, 4482.394876691646, 4584.564466375689, 4596.264597664374, 4615.538446155383, 4627.791749371278, 4544.182047231497, 4599.908001839961, 4603.930941035887, 4682.625389968803, 4683.25067989121, 4297.871063868089, 4299.462567179103, 4306.267934451143, 4360.825566977317, 4377.102693947733, 4360.062586543892, 4369.126174765044, 4390.209762242795, 4403.713758605696, 4452.10957808438, 4187.267228235047, 4263.893402664927, 4273.850415235483, 4308.6983911126235, 4353.020570371641, 4249.957500424987, 4269.807858646368, 4276.144771045772, 4276.593723596254, 4286.121345124242, 4113.930378101715, 4220.388043733641, 4246.426732391118, 4255.17024180285, 4268.487781466213, 4451.354553589711, 4464.933026004613, 4535.750533720644, 4602.9079418411775, 4611.492735799093, 4964.801407943678, 4996.9500304996845, 5004.549590536869, 5024.598032157419, 5025.246213068032, 4857.951420485785, 5023.2214006829, 5025.949740502621, 5029.597632189416, 5096.847094587169, 4493.236149854532, 4506.143832671749, 4523.32150177476, 4530.365748795171, 4577.267637178035, 5107.821226257063, 5119.974400127976, 5125.615578831603, 5125.615578831603, 5129.435762066169, 4886.511348865085, 4886.682365646222, 4894.510548945148, 4917.483664215278, 4944.554990050912, 4868.14807408702, 4939.876503087452, 4948.480409557017, 5016.372953380827, 5058.772355244023, 4915.606751459874, 4931.605471562267, 4933.629977751683, 4936.827211047596, 4970.701757894538, 4821.746345950079, 4858.295547145644, 4874.707517548958, 4883.487233840467, 4886.682365646222, 4078.6125318094732, 4159.646430053419, 4160.375943608423, 4173.874783756492, 4257.084726783756, 3610.4403817408343, 3642.817859107034, 3645.070507020746, 3670.045788095061, 3675.1547144156993, 4204.810783514749, 4220.725652832556, 4242.7242229255, 4262.296721041055, 4278.529361770203, 4806.44725856524, 4871.0, 4955.0337684151245, 5034.697918124924, 5062.417821950523, 4290.313549832012, 4299.032717638506, 4300.569943005675, 4311.719738217006, 4326.4159338489535, 4294.248506511348, 4449.2658711312915, 4481.641468682497, 4493.191225579361, 4498.0, 4590.357349971074, 4606.401167848158, 4625.074985003012, 4736.597389221817, 4817.421909370898, 4930.433000205022, 4978.601711863114, 4981.4769449207315, 5000.224965130411, 5044.041632089891, 4695.34265202865, 4696.835610753607, 4716.198246298206, 4718.457377401505, 4750.667453278237, 4782.928256076092, 4855.878603034952, 4864.246041863516, 4920.803167873245, 4956.0, 4945.77744001528, 4977.253411988086, 4999.975000124976, 5005.7997680092385, 5022.146235139962, 4789.3294938709305, 4855.927161092657, 4860.17377045896, 4866.7079975201605, 4880.243562247857, 4689.953100468952, 4784.6889952153, 4832.516748325139, 4884.560389564814, 4936.531029552187, 4681.321208424692, 4684.6486513510945, 4685.367475390915, 4725.173094708481, 4759.357486739246, 4727.550882666279, 4834.806607735652, 4836.806527738851, 4845.903081938271, 4888.780004899717, 4584.701994370355, 4699.976500117615, 4709.929351059668, 4712.340272361804, 4760.071786001835], "unit": "score", "name": "dojo.html", "value": 4550.041839349321}, {"lowerIsBetter": false, "replicates": [500.3395517916352, 507.88572571171466, 515.775637597645, 526.6339893773827, 539.8677324055607, 24818.379540511498, 25402.23793286202, 31946.520802187955, 32407.351852962925, 32496.67503324972, 35221.82389088057, 35640.46539301913, 35670.10824729383, 35743.0, 35886.0, 7606.125295590995, 7769.572673502955, 7809.336206422461, 7816.101148367954, 7825.569593672346, 7563.735269265577, 7683.270089341504, 7695.6152192390155, 7702.614869256543, 7729.497582657137, 7667.386609071289, 7762.728304509344, 7827.882581761278, 7931.206879312081, 7934.246246606564, 7789.571573563452, 7879.133295337509, 7898.289153976112, 7898.80252993674, 7926.524408535506, 7523.683355412835, 7749.457537972344, 7749.651265693057, 7760.340371068466, 7786.104597971249, 35944.46083308753, 36648.267034659155, 36726.449103263476, 36726.81636591827, 36739.0, 2921.6055832462557, 3039.361734035855, 3055.801372910754, 3100.612423447069, 3119.3605310911207, 26724.599131013052, 27678.584821227698, 27733.722662773518, 27949.720502795117, 28256.293592660142, 3407.4207384744655, 3440.3291358184915, 3479.6346383629607, 3520.3487354839435, 3521.506989021539, 218108.0, 220956.0, 221948.0, 223790.0, 224351.0, 55550.444495554526, 55902.0, 55930.0, 55942.72028639912, 56175.71912140413, 51021.74489127605, 51364.743176284624, 59300.40699592949, 65901.67049164724, 67745.66127169333, 14018.0, 14120.646983825487, 14174.07868488545, 14212.71574568503, 14259.144451332953, 10342.172626189888, 10365.844512332322, 10379.792404151875, 10435.37387756737, 10444.529996150191, 19217.80782192188, 19518.31685890987, 19521.707174392395, 19541.459610250575, 19617.607647846962, 7427.925720742832, 7726.884096738553, 7768.0, 7884.802879928047, 7885.5662938538935, 839.1650307943635, 882.1663527966139, 913.9862902056475, 995.9442990430167, 1028.3521381529588, 24791.752082479306, 25179.87410062938, 25291.49417011686, 25565.744342556336, 26126.0, 923.4505469245788, 935.036911980661, 952.3238500664605, 984.3109823123842, 1019.8776146862276, 12138.393080345948, 12214.57248996281, 14970.775438368433, 15335.769963450557, 15458.922705386625, 225873.0, 226585.0, 228743.0, 228799.0, 228947.0, 43236.78381608135, 43980.0, 43997.78001110038, 44000.77999610046, 44124.0, 1179.7404570994538, 1230.4585982167816, 1231.1012960538858, 1244.8506179258547, 1245.9626211213679, 24293.271201863972, 26746.0, 26821.19536413911, 27426.451470970867, 27569.172924812287, 38172.42741358937, 38871.41692874666, 38879.6112038876, 38955.22089558136, 39201.6079839198, 239358.0, 240686.0, 241039.0, 242719.0, 244090.0, 28741.42517149687, 38078.80960595179, 38229.0, 38365.0, 38901.22197555976, 33198.33603327968, 33705.49441758425, 34141.0, 34145.65854341425, 34435.82782086074, 30547.694523054484, 32475.67524324821, 32590.348193035534, 32903.17742056468, 33130.5030424539, 34097.659023410444, 35641.466437452895, 35708.821455892554, 36014.099647507974, 38864.6113538861, 33073.669263307056, 33261.833690831394, 33449.83275083609, 35923.640763592026, 36618.26763464769, 28484.57273140946, 29775.404491910474, 29949.55075673823, 30075.81553870811, 30942.53586196254, 21597.01738362271, 23014.884925575265, 23213.41966450785, 23317.183898563468, 23634.29097127089], "unit": "score", "name": "ext.html", "value": 16629.28162409777}, {"lowerIsBetter": false, "replicates": [323.24844735988825, 325.65805903801004, 330.8957678331327, 331.86891177984694, 332.77038843198204, 13617.251051192181, 14218.933579981503, 14803.481878134267, 15003.849961500382, 15674.451394201205, 10522.684319470409, 10630.202734794882, 13231.735365292712, 15276.847231527681, 15294.388224471035, 4223.556526564705, 4597.678162528624, 4657.604103651177, 5039.622028347871, 5054.039732450822, 5013.147764879979, 5101.948980510185, 5106.591472682177, 5107.693538387709, 5109.795608175668, 4823.493533179018, 4965.0566392385335, 5334.439883812202, 5516.448355164472, 5528.391876893538, 5230.555402790767, 5447.346318441792, 5463.972680136594, 5465.125579907196, 5465.672059676433, 4756.904861902743, 4896.143174944371, 4901.632377571661, 4906.607471402279, 4913.115639184945, 11700.648980530597, 11945.163838531307, 11987.700307492296, 12035.819462708067, 14691.706165876623, 1801.351513455155, 1832.7617409736781, 1873.1102726204945, 1942.2328180368816, 2017.2233690029298, 8597.054324024351, 9108.68119615817, 9115.680951166678, 11658.242214256132, 12397.814032789516, 1731.887427317233, 1746.388763932626, 1770.9114544272863, 1831.8992455414948, 1850.6272343514543, 43912.780436097935, 47562.524374756154, 48613.513864861256, 50664.74667626638, 53389.733051334886, 8790.604422800989, 9155.679551215675, 9338.112879276458, 9398.778158839445, 9446.338756286994, 11689.240199387013, 11700.473478693479, 11756.882431175749, 11880.821787673192, 11888.643340699793, 6979.511434199558, 7050.647467626598, 7134.357907788324, 7147.2138064812825, 7154.713811447588, 6820.181578210647, 6834.4874134440115, 6856.794296171123, 6880.208775990725, 6891.345322194384, 3982.38273067675, 3986.142979259473, 4006.2187873364996, 4025.1144748155943, 4045.939310910339, 1629.54372775623, 1694.2037242496008, 1740.7475915992363, 1806.8464180544538, 1818.5271829324206, 825.7852958230783, 830.1034882327073, 832.8334333133276, 853.9103394143525, 858.3519442820631, 13362.599122026355, 13914.443422263199, 14256.287185640676, 14299.57101286963, 14990.62523436901, 812.8983877015373, 850.7702920211632, 871.2681347667989, 880.7489865388334, 947.0340252942099, 8525.829483410422, 8659.696910608098, 8815.338849586307, 8829.955850220707, 8861.778455538662, 479406.0, 480385.0, 487986.0, 492398.0, 498137.5838087222, 57868.8426231473, 62396.37603623996, 62706.68646656738, 64767.35232647708, 65479.0, 1072.4369705904307, 1096.8848270931596, 1098.220263612828, 1098.9560417583366, 1100.8293714474269, 12945.676358091123, 13689.31553422305, 14021.929890350482, 14032.0, 14380.856191437952, 26762.330941725835, 27446.451070978866, 27669.584956226074, 28418.147455576367, 30989.535156973114, 36179.095522612144, 36966.0, 37218.62781372152, 37382.0, 37586.81206593949, 5906.0255057914965, 6185.134081228722, 6232.937670623236, 6297.96851015742, 6311.779087731908, 7061.364477197077, 9266.305027122859, 9743.220542356736, 9948.005199479994, 9969.35199212049, 6456.451201647913, 7480.3641690456925, 8319.708810191614, 8875.600597972978, 8880.378373513791, 8616.217884576054, 8650.0, 8783.516906569945, 8807.295416366547, 8827.514486703292, 8323.83352332962, 8754.387192896436, 8905.376623636543, 8936.687215947411, 9104.271658267455, 6564.540482166202, 6687.799366019027, 6756.23800383885, 6824.0, 6914.997325387892, 7539.698412063456, 8790.310521856205, 8792.780180495283, 9079.68221112258, 9187.402818816756], "unit": "score", "name": "jquery.html", "value": 7338.496040974659}, {"lowerIsBetter": false, "replicates": [1365.3651052260698, 1383.2461308586821, 1497.348653335799, 1684.83994020568, 1699.5156380431572, 6704.296048914861, 6751.932480675192, 6900.758473453424, 6926.27274136216, 6985.790426287213, 6859.074025006623, 6865.41643960264, 6869.725210991554, 6886.104806375164, 6897.172339319289, 2049.1086377425795, 2071.388940262626, 2089.1330098009385, 2089.9791002090014, 2096.0462989339812, 2009.979900201001, 2009.9899500502477, 2054.4042227753935, 2091.5607722378318, 2098.055874856313, 1735.1237624999358, 1778.5909240874607, 1953.3749200255925, 2003.6593779057596, 2024.433158715562, 2009.1260301768632, 2009.357005758158, 2017.1628774058822, 2019.3538067818304, 2020.2020202020267, 1928.6914093745074, 1963.3619073800928, 1964.5874366383077, 1969.812867777559, 1975.9703604445945, 6689.632070236135, 6697.129373181455, 6707.597544147318, 6716.697748601325, 6736.494762892754, 4002.639762421396, 4106.240345536055, 4130.896727581804, 4153.54311025787, 4161.771102589387, 2601.5447296722996, 2620.93447663808, 2646.775024122952, 2649.8012649051398, 2664.920052398431, 839.0393000014949, 843.9071702112763, 847.8812966184739, 863.2274114667338, 880.1374652840188, 9040.728778136667, 9056.13966673165, 9073.727788166365, 9087.182153606207, 9087.182153606273, 3518.3354798773953, 3553.2538166985223, 3622.0582648511577, 3665.651763082503, 3670.5595328560744, 7514.0, 7520.398368130536, 7525.962370188224, 7552.244775522514, 7596.8480630388185, 4038.1318016626565, 4062.289099407592, 4064.4106604542176, 4066.6340029397497, 4068.3897415387337, 3733.1040550268285, 3752.5309336332957, 3788.8673896413493, 3807.676347510437, 3809.8857034289017, 3056.938861222763, 3077.046115704139, 3113.470709979309, 3130.6712795156636, 3142.245860993391, 914.2457472585144, 917.9127982841619, 932.4731526687535, 934.7522906429801, 937.779621788879, 842.7808769719917, 888.3603805260202, 905.7599736069947, 953.8712273843081, 1128.142611615162, 6159.3224745277985, 6234.532410069172, 6242.5942313749465, 6244.687765611792, 6247.406496382836, 556.9777208911598, 564.0608387035621, 585.1106318396014, 585.6398315036222, 707.7558242406361, 4793.976030119827, 4830.541098595628, 4833.73414462208, 4868.8782780430065, 4872.1473742094995, 7958.6418611162635, 8067.072286686989, 8391.95804020976, 8408.663653453794, 8450.61972211252, 8202.26179643823, 8204.466709663853, 8223.95888020568, 8230.876536851953, 8312.0, 6234.096056071844, 6443.097966284724, 6506.707198176094, 6599.967000164968, 6616.206055273302, 6192.225971753531, 6325.462335701517, 6333.461655759312, 6336.873262534816, 6372.203474565679, 7118.181409138016, 7284.745033923788, 7310.342069213583, 7337.963310183415, 7355.117385913511, 7195.46034047438, 7320.0, 7341.26587341283, 7359.595222262613, 7457.589832559262, 5883.264591926009, 6096.268447786294, 6118.082287656887, 6127.3566275540425, 6130.601510901777, 6515.837104072436, 6543.1821022372205, 6557.245916719638, 6583.901241481286, 6598.076269322395, 6130.63216207029, 6156.538259630456, 6162.22972128484, 6227.844303892439, 6329.0, 5380.43505431924, 5480.780768769364, 5919.970400147971, 6162.352952939877, 6192.783252586138, 5996.520278377807, 6026.0, 6076.118962750465, 6082.908756368746, 6085.513158947185, 5518.668879867221, 5590.273264475755, 5594.076977298863, 5598.804041858678, 5607.775688972559, 5408.37803652585, 5463.289772329572, 5495.477929596682, 5505.532029777353, 5522.502974732293], "unit": "score", "name": "mootools.html", "value": 3837.0105607973464}, {"lowerIsBetter": false, "replicates": [303.92857678445563, 313.81955375659004, 319.87205117952817, 320.06700468135404, 321.3492677328408, 5553.139263414172, 5645.8588535286635, 5761.0, 5773.3937936516695, 5785.826425207245, 5507.705689163044, 5655.1517272409155, 5684.943150568493, 5701.486866182043, 5712.542996560275, 4242.109157077018, 4349.34759786033, 4356.97821510892, 4404.29531274996, 4412.955870441295, 4317.071829556645, 4328.675349348796, 4344.695871289011, 4350.54319296474, 4362.498312694033, 4299.50555686097, 4306.956930430702, 4308.246056940038, 4317.568243175673, 4383.846565370212, 4358.324459708719, 4363.367311739796, 4365.105153443536, 4371.4972778130605, 4377.277749171415, 3679.6504332088407, 3756.492873462075, 3842.3852183650483, 3846.11539345952, 3846.788426636534, 5308.097623404031, 5425.810096646598, 5447.891042179134, 5452.318460192476, 5456.345238571397, 4929.482404347527, 4952.62855285855, 4957.603391728653, 4964.776585053645, 4965.577925876305, 6006.519478441714, 6011.278646562397, 6015.669138197398, 6024.939750602482, 6026.337102918676, 3984.322665146932, 4042.9191416171807, 4060.959390406117, 4127.876163715094, 4183.309753890604, 6207.844803879894, 6267.937320626781, 6269.968650156766, 6274.215723034621, 6284.120223168806, 4279.97860010698, 4285.785710714452, 4296.119295544406, 4296.613304802583, 4297.634701050383, 4323.092150648399, 4337.15425492026, 4338.110687309094, 4360.803763830635, 4377.9781101094295, 4828.227483602606, 4974.27872958419, 4977.875553111129, 4978.626603004716, 4988.326575912205, 5933.288005439289, 5964.015937370285, 5978.043513037893, 5980.312264089685, 5996.850078748066, 1545.2814441284856, 1561.2584022589178, 1569.9010692515285, 1575.243882936174, 1577.0458872382274, 1047.895210478946, 1053.2837670384213, 1053.9262251642465, 1071.919606029551, 1075.4998925499524, 5172.922406163911, 5180.818671346485, 5187.740612969336, 5188.0661480933795, 5191.818286360035, 6123.510119190454, 6206.193194884636, 6207.286162091327, 6221.9377806222265, 6224.06639004153, 5163.974180129076, 5172.922406163911, 5175.974120129451, 5180.585553155814, 5184.066867963727, 3285.195127193853, 3323.7507186960593, 3357.949630755492, 3362.4788157835574, 3367.3770352484867, 5711.0, 5786.247787787561, 5860.384659610765, 5887.911681324784, 5906.822795316148, 6417.294097649255, 6447.194100737408, 6453.645049522322, 6457.903131453032, 6476.190476190476, 5866.090755932837, 5868.970655146697, 5871.559633027455, 5877.206577112035, 5879.3826648202175, 6024.668643224665, 6269.341719119427, 6271.341509141657, 6273.121762953281, 6274.090256912813, 6116.694165291807, 6121.204243448323, 6126.050462178369, 6130.846728831815, 6132.6627035513475, 5806.44838740319, 5878.529717622666, 5878.735456904364, 5893.499052580579, 5897.469227769521, 4055.7566546007333, 4092.3656833190903, 4094.754314741006, 4109.465769450072, 4111.547729749785, 6080.908786368296, 6242.563020588515, 6242.687865606792, 6254.562180647493, 6257.53068519872, 6011.849703757266, 6014.1580178775885, 6022.488088512526, 6031.703183815501, 6045.939540604538, 5955.910661339996, 5959.523238141025, 5979.850503737267, 5983.4914032306, 6004.339522652592, 5697.401772813795, 5852.824415267549, 5874.970625146847, 5877.764889404547, 5885.852853678693, 6070.514358851369, 6079.3008803988105, 6083.391660833881, 6091.299500557316, 6095.329513753395, 5801.8549536261935, 5819.94180058194, 5834.533237341087, 5841.18223448709, 5872.265966754156], "unit": "score", "name": "prototype.html", "value": 4476.6944382461}, {"lowerIsBetter": false, "replicates": [762.7673559564334, 765.1162906842598, 775.9456838021339, 788.7554857994025, 791.9049714034317, 11256.54973801048, 11303.208775385727, 11325.377104259262, 11344.092472602193, 11366.659000229996, 10986.285891417072, 11135.0, 11186.776264474705, 11198.888011119887, 11223.158263130257, 763.7059732003177, 775.5269285735696, 775.7284950267418, 776.3556248313914, 779.8791187365968, 765.4565258666354, 767.4972892755254, 768.7271018788333, 772.3666593393419, 772.4168252969029, 815.6615004773012, 817.5544328341068, 822.4736168851939, 824.1181935329171, 826.7437094500694, 816.4529765057396, 817.65249768848, 818.2758258940851, 818.7502811642447, 820.3519219816368, 607.8510764862593, 609.1471939284992, 609.7225762278152, 609.765240382456, 610.4658423879106, 11048.226624136314, 11074.501647425805, 11076.280041797258, 11135.777284454265, 11161.330320180816, 10067.697969060866, 10095.899041009568, 10168.084872361449, 10206.0, 10285.485725713685, 10501.09344877228, 10589.73525661857, 10863.239573229877, 10884.564617415293, 10895.564177432892, 3259.2177877309273, 3318.0377690469736, 3325.7173140283103, 3380.070480617825, 3390.2710917152685, 38250.0, 38597.80701096504, 38772.22455550901, 39150.60849391498, 40542.79728601338, 9574.95212523933, 9685.128338449573, 9763.463009534402, 9949.502524873727, 9963.103320701026, 17126.828731712525, 17127.0, 17152.399666011628, 17162.656746864992, 17180.570485737957, 6591.736330546821, 6638.701258443285, 6651.368120028589, 6705.430038446689, 6813.454923606099, 3616.710663146942, 3652.7077833773233, 3664.1755604988666, 3670.2109046554583, 3683.834227459771, 2539.911103111382, 2546.1597672767944, 2564.9743502565107, 2571.4085760275243, 2592.0539003263675, 484.0754159555233, 487.6756956623805, 495.09891996565904, 496.0624419846493, 499.1713755166479, 576.844252051952, 588.6173986908543, 592.7406586447047, 607.808540309801, 613.5429105316479, 7322.816929576803, 7646.502977306457, 7655.349295309961, 7705.9229407706325, 7708.306252437307, 574.4772257245886, 585.2158108135119, 587.0196771391786, 599.658194828952, 604.4257954942734, 3441.4149594568985, 3573.5533058367705, 3636.7636103653176, 3641.7450778445786, 3687.7049836013052, 47226.58320250398, 48156.27765583519, 48386.0, 48788.0, 48879.0, 42446.363304550454, 42661.0, 42705.35941960873, 43007.262023538366, 43168.56831431708, 36424.453633195524, 37592.0, 38163.23673526514, 38708.225835483136, 39068.43726250918, 8189.676710138458, 8232.794180145544, 8505.829883402173, 8537.40238183346, 8728.956355218183, 30114.698853012065, 30279.69720302857, 30503.694963050086, 30601.846990764905, 31252.687473124977, 34295.65704343024, 34386.484202737476, 34398.82800585981, 37616.43575346427, 38299.0, 9997.150242229493, 10038.333250360873, 10054.34646747959, 10267.589296428358, 10729.839052414063, 10069.19446444268, 10543.578256869947, 10739.570417183226, 10869.836952445878, 11004.559817607525, 10252.794944101226, 10525.526351314362, 10782.299150555189, 10793.784124317626, 10824.188185886247, 10185.541650625888, 10236.641717539851, 10531.736706582396, 10756.031957123896, 10941.12471002302, 9974.351667141613, 10174.13519850821, 10458.163346932075, 10524.0, 10683.679489615324, 8542.40203185771, 8643.265322447662, 8797.780055498664, 8819.867701984347, 9113.954430227806, 8497.957510212409, 8748.300135988979, 8872.689455869013, 9395.107464790834, 9474.526273686426], "unit": "score", "name": "yui.html", "value": 5673.186029190934}], "name": "dromaeo_css", "value": 6150.156976344395}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 109.0, 114.0, 115.0, 115.0, 125.0, 113.0, 114.0, 115.0, 117.0], "unit": "score", "name": "ai-astar", "value": 115.3}, {"lowerIsBetter": true, "replicates": [165.0, 131.0, 158.0, 177.0, 135.0, 160.0, 163.0, 139.0, 178.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 154.0}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 164.0, 162.0, 162.0, 175.0, 168.0, 167.0, 167.0, 164.0], "unit": "score", "name": "audio-dft", "value": 165.4}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 72.0, 73.0, 134.0, 76.0, 71.0, 72.0, 72.0, 87.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 136.0, 97.0, 97.0, 98.0, 131.0, 97.0, 97.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 150.0, 148.0, 149.0, 148.0, 149.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 98.0, 96.0, 95.0, 96.0, 96.0, 98.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 71.0, 73.0, 70.0, 71.0, 70.0, 68.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 70.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 66.0, 68.0, 66.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [84.0, 92.0, 88.0, 88.0, 93.0, 85.0, 87.0, 86.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.5}, {"lowerIsBetter": true, "replicates": [126.0, 122.0, 119.0, 122.0, 118.0, 123.0, 122.0, 127.0, 130.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [141.0, 142.0, 161.0, 151.0, 151.0, 147.0, 165.0, 151.0, 152.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 73.0, 75.0, 71.0, 72.0, 71.0, 70.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1547.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [187.72292096865027], "unit": "score", "name": "DeltaBlue", "value": 352.210586}, {"lowerIsBetter": false, "replicates": [277.31558513588465], "unit": "score", "name": "Encrypt", "value": 959.8486860000002}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [727.2727272727273], "unit": "score", "name": "Earley", "value": 916.3866250000003}, {"lowerIsBetter": false, "replicates": [12456.79012345679], "unit": "score", "name": "Boyer", "value": 53.501985133795806}, {"lowerIsBetter": false, "replicates": [42937.5], "unit": "score", "name": "RegExp", "value": 21.216535662299844}, {"lowerIsBetter": false, "replicates": [605.6935190793458], "unit": "score", "name": "Splay", "value": 134.541641}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20243.384260041068}]} 03:22:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20243.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1547.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6150.16"}}} 03:22:53 INFO - Return code: 0 03:22:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:22:53 INFO - # TBPL SUCCESS # 03:22:53 INFO - Running post-action listener: _resource_record_post_action 03:22:53 INFO - Running post-run listener: _resource_record_post_run 03:22:54 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 540217344; Read time: 0; Write time: 453976 03:22:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231972864; Read time: 0; Write time: 248404 03:22:55 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 308244480; Read time: 0; Write time: 205572 03:22:55 INFO - Running post-run listener: _upload_blobber_files 03:22:55 INFO - Blob upload gear active. 03:22:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:22:55 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 03:22:55 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'] 03:22:55 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 03:22:55 INFO - (blobuploader) - INFO - Open directory for files ... 03:22:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:22:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:22:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:56 INFO - (blobuploader) - INFO - Done attempting. 03:22:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:22:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:22:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:57 INFO - (blobuploader) - INFO - Done attempting. 03:22:57 INFO - (blobuploader) - INFO - Iteration through files over. 03:22:57 INFO - Return code: 0 03:22:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:22:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:22:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9956916e398be641f7cdc1cd0321b15a136df3facaaf99528608e779b8660358e67993fb3297ce31da17ab64eaaa9c265f3780c72b0a2b92d406c3aae48f3c06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/addb540efbff224e3787ac76f26586235fbb5b3c19be8abfd22590deaa5424005b9b822d64127b5096935a516a10f6814aad10aa3092df02b991f9070c51eb9b"} 03:22:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:22:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:22:57 INFO - Contents: 03:22:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9956916e398be641f7cdc1cd0321b15a136df3facaaf99528608e779b8660358e67993fb3297ce31da17ab64eaaa9c265f3780c72b0a2b92d406c3aae48f3c06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/addb540efbff224e3787ac76f26586235fbb5b3c19be8abfd22590deaa5424005b9b822d64127b5096935a516a10f6814aad10aa3092df02b991f9070c51eb9b"} 03:22:57 INFO - Copying logs to upload dir... 03:22:57 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.974392 ========= master_lag: 0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-01-14 03:22:57.285295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 03:22:57.288934) ========= 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=574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396 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/9956916e398be641f7cdc1cd0321b15a136df3facaaf99528608e779b8660358e67993fb3297ce31da17ab64eaaa9c265f3780c72b0a2b92d406c3aae48f3c06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/addb540efbff224e3787ac76f26586235fbb5b3c19be8abfd22590deaa5424005b9b822d64127b5096935a516a10f6814aad10aa3092df02b991f9070c51eb9b"} build_url:https://queue.taskcluster.net/v1/task/WtQbOR4-TjWwj5vjre_JnQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009670 build_url: 'https://queue.taskcluster.net/v1/task/WtQbOR4-TjWwj5vjre_JnQ/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/9956916e398be641f7cdc1cd0321b15a136df3facaaf99528608e779b8660358e67993fb3297ce31da17ab64eaaa9c265f3780c72b0a2b92d406c3aae48f3c06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/addb540efbff224e3787ac76f26586235fbb5b3c19be8abfd22590deaa5424005b9b822d64127b5096935a516a10f6814aad10aa3092df02b991f9070c51eb9b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 03:22:57.310937) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:22:57.311238) ========= 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=574dc5aafe09851ec43d388c000001b6-1452768187.648832-1399232396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:22:57.360171) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 03:22:57.360492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 03:22:57.363718) ========= ========= Total master_lag: 0.50 =========