builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1450351353.26 results: success (0) buildid: 20151217024532 builduid: 10d8dcff67b742f699b9138cd9586f8e revision: ee39999c8d225f524e857e56a17dbf2787143448 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.258869) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.259290) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.259630) ========= 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=edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006426 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.291585) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.291894) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.325819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.326110) ========= 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=edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.380393) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.380729) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.381146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.381526) ========= 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=edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 03:22:34-- 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% 78.3M=0s 2015-12-17 03:22:34 (78.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.555727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.556036) ========= 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=edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019561 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.607876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:33.608486) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ee39999c8d225f524e857e56a17dbf2787143448 --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 ee39999c8d225f524e857e56a17dbf2787143448 --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=edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 03:22:34,369 truncating revision to first 12 chars 2015-12-17 03:22:34,369 Setting DEBUG logging. 2015-12-17 03:22:34,369 attempt 1/10 2015-12-17 03:22:34,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ee39999c8d22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 03:22:34,709 unpacking tar archive at: fx-team-ee39999c8d22/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:34.214859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:34.215160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:34.225166) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:34.225486) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:34.225924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-17 03:22:34.226242) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:22:35 INFO - MultiFileLogger online at 20151217 03:22:35 in /builds/slave/test 03:22:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:22:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:35 INFO - {'append_to_log': False, 03:22:35 INFO - 'base_work_dir': '/builds/slave/test', 03:22:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:22:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:35 INFO - 'branch': 'Fx-Team-Non-PGO', 03:22:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:35 INFO - 'config_files': ('talos/linux_config.py',), 03:22:35 INFO - 'default_actions': ('clobber', 03:22:35 INFO - 'read-buildbot-config', 03:22:35 INFO - 'download-and-extract', 03:22:35 INFO - 'populate-webroot', 03:22:35 INFO - 'create-virtualenv', 03:22:35 INFO - 'install', 03:22:35 INFO - 'run-tests'), 03:22:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:35 INFO - 'download_minidump_stackwalk': True, 03:22:35 INFO - 'download_symbols': 'ondemand', 03:22:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:22:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:22:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:22:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:22:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:35 INFO - 'installer_path': 'installer.exe', 03:22:35 INFO - 'log_level': 'info', 03:22:35 INFO - 'log_name': 'talos', 03:22:35 INFO - 'log_to_console': True, 03:22:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:22:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:22:35 INFO - 'opt_config_files': (), 03:22:35 INFO - 'pip_index': False, 03:22:35 INFO - 'sps_profile': False, 03:22:35 INFO - 'sps_profile_interval': 0, 03:22:35 INFO - 'suite': 'dromaeojs-e10s', 03:22:35 INFO - 'system_bits': '64', 03:22:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:35 INFO - 'title': 'talos-linux64-ix-063', 03:22:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:35 INFO - 'use_talos_json': True, 03:22:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:35 INFO - 'work_dir': 'build'} 03:22:35 INFO - ##### 03:22:35 INFO - ##### Running clobber step. 03:22:35 INFO - ##### 03:22:35 INFO - Running pre-action listener: _resource_record_pre_action 03:22:35 INFO - Running main action method: clobber 03:22:35 INFO - rmtree: /builds/slave/test/build 03:22:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:35 INFO - Running post-action listener: _resource_record_post_action 03:22:35 INFO - ##### 03:22:35 INFO - ##### Running read-buildbot-config step. 03:22:35 INFO - ##### 03:22:35 INFO - Running pre-action listener: _resource_record_pre_action 03:22:35 INFO - Running main action method: read_buildbot_config 03:22:35 INFO - Using buildbot properties: 03:22:35 INFO - { 03:22:35 INFO - "project": "", 03:22:35 INFO - "product": "firefox", 03:22:35 INFO - "script_repo_revision": "production", 03:22:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:22:35 INFO - "repository": "", 03:22:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:22:35 INFO - "buildid": "20151217024532", 03:22:35 INFO - "pgo_build": "False", 03:22:35 INFO - "basedir": "/builds/slave/test", 03:22:35 INFO - "buildnumber": 594, 03:22:35 INFO - "slavename": "talos-linux64-ix-063", 03:22:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:22:35 INFO - "platform": "ubuntu64_hw", 03:22:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:22:35 INFO - "branch": "fx-team", 03:22:35 INFO - "repo_path": "integration/fx-team", 03:22:35 INFO - "revision": "ee39999c8d225f524e857e56a17dbf2787143448", 03:22:35 INFO - "stage_platform": "linux64", 03:22:35 INFO - "builduid": "10d8dcff67b742f699b9138cd9586f8e", 03:22:35 INFO - "slavebuilddir": "test" 03:22:35 INFO - } 03:22:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:22:35 INFO - Running post-action listener: _resource_record_post_action 03:22:35 INFO - ##### 03:22:35 INFO - ##### Running download-and-extract step. 03:22:35 INFO - ##### 03:22:35 INFO - Running pre-action listener: _resource_record_pre_action 03:22:35 INFO - Running main action method: download_and_extract 03:22:35 INFO - mkdir: /builds/slave/test/build/tests 03:22: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:22:35 INFO - https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/test_packages.json 03:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/test_packages.json 03:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:22:36 INFO - Downloaded 1302 bytes. 03:22:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:22:36 INFO - Using the following test package requirements: 03:22:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:22:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:22:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:36 INFO - u'jsshell-linux-x86_64.zip'], 03:22:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:22:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:22:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:22:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:22:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:22:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:22:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:22:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:36 INFO - https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:22:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:22:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:22:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/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:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/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:22:38 INFO - Downloaded 21869235 bytes. 03:22:38 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:22:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:22:38 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:22:39 INFO - Return code: 0 03:22:39 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:22:39 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:22:39 INFO - https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:22:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:22:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:22:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/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:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/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:22:42 INFO - Downloaded 21869235 bytes. 03:22:42 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:22:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:22:42 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:22:43 INFO - Return code: 0 03:22:43 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:22:43 INFO - https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/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:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/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:22:44 INFO - Downloaded 11132052 bytes. 03:22:44 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:22:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:22:44 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:22:45 INFO - Return code: 0 03:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:45 INFO - https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/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:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7fYncb0LQY2yVaxmVn27BA/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:22:47 INFO - Downloaded 57773529 bytes. 03:22:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:22:47 INFO - mkdir: /builds/slave/test/properties 03:22:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:47 INFO - Contents: 03:22:47 INFO - build_url:https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:22:47 INFO - Running post-action listener: _resource_record_post_action 03:22:47 INFO - Running post-action listener: set_extra_try_arguments 03:22:47 INFO - ##### 03:22:47 INFO - ##### Running populate-webroot step. 03:22:47 INFO - ##### 03:22:47 INFO - Running pre-action listener: _resource_record_pre_action 03:22:47 INFO - Running main action method: populate_webroot 03:22:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:47 INFO - '--tppagecycles', 03:22:47 INFO - '7'], 03:22:47 INFO - 'tests': ['tsvgm']}}, 03:22:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:22:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:22:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:22:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'tests': ['damp', 'tps']}, 03:22:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['damp', 'tps']}, 03:22:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:47 INFO - 'other': {'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'other_l64': {'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'other_nol64': {'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'svgr': {'tests': ['tsvgx', 03:22:47 INFO - 'tsvgr_opacity', 03:22:47 INFO - 'tart', 03:22:47 INFO - 'tscrollx', 03:22:47 INFO - 'cart']}, 03:22:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['tsvgx', 03:22:47 INFO - 'tsvgr_opacity', 03:22:47 INFO - 'tart', 03:22:47 INFO - 'tscrollx', 03:22:47 INFO - 'cart']}, 03:22:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'tests': ['tp5o']}, 03:22:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['tp5o']}, 03:22:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'talos_options': ['--xperf_path', 03:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:47 INFO - 'tests': ['tp5n']}, 03:22:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'talos_options': ['--e10s', 03:22:47 INFO - '--xperf_path', 03:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:47 INFO - 'tests': ['tp5n']}}, 03:22:47 INFO - 'talos.zip': {'path': '', 03:22:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:47 INFO - Running post-action listener: _resource_record_post_action 03:22:47 INFO - ##### 03:22:47 INFO - ##### Running create-virtualenv step. 03:22:47 INFO - ##### 03:22:47 INFO - Running pre-action listener: _resource_record_pre_action 03:22:47 INFO - Running main action method: create_virtualenv 03:22:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:47 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:22:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:47 INFO - Using real prefix '/usr' 03:22:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:49 INFO - Installing pip.................done. 03:22:49 INFO - Return code: 0 03:22:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22:49 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:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:49 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:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:49 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 0x7ff20d99af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a0b0>, '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 0x160afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', '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:22:49 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:22:49 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:22:49 INFO - Using env: {'DISPLAY': ':0', 03:22:49 INFO - 'HOME': '/home/cltbld', 03:22:49 INFO - 'LANG': 'en_US.UTF-8', 03:22:49 INFO - 'LANGUAGE': 'en_US:en', 03:22:49 INFO - 'LOGNAME': 'cltbld', 03:22:49 INFO - 'MAIL': '/var/mail/cltbld', 03:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:49 INFO - 'MOZ_NO_REMOTE': '1', 03:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:49 INFO - 'NO_EM_RESTART': '1', 03:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:49 INFO - 'PWD': '/builds/slave/test', 03:22:49 INFO - 'SHELL': '/bin/bash', 03:22:49 INFO - 'SHLVL': '1', 03:22:49 INFO - 'TERM': 'linux', 03:22:49 INFO - 'TMOUT': '86400', 03:22:49 INFO - 'USER': 'cltbld', 03:22:49 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', 03:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:49 INFO - '_': '/tools/buildbot/bin/python'} 03:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:50 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:22:50 INFO - Cleaning up... 03:22:50 INFO - Return code: 0 03:22:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:22: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:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:50 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 0x7ff20d99af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a0b0>, '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 0x160afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', '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:22:50 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:22:50 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:22:50 INFO - Using env: {'DISPLAY': ':0', 03:22:50 INFO - 'HOME': '/home/cltbld', 03:22:50 INFO - 'LANG': 'en_US.UTF-8', 03:22:50 INFO - 'LANGUAGE': 'en_US:en', 03:22:50 INFO - 'LOGNAME': 'cltbld', 03:22:50 INFO - 'MAIL': '/var/mail/cltbld', 03:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:50 INFO - 'MOZ_NO_REMOTE': '1', 03:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:50 INFO - 'NO_EM_RESTART': '1', 03:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:50 INFO - 'PWD': '/builds/slave/test', 03:22:50 INFO - 'SHELL': '/bin/bash', 03:22:50 INFO - 'SHLVL': '1', 03:22:50 INFO - 'TERM': 'linux', 03:22:50 INFO - 'TMOUT': '86400', 03:22:50 INFO - 'USER': 'cltbld', 03:22:50 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', 03:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:50 INFO - '_': '/tools/buildbot/bin/python'} 03:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:50 INFO - Downloading/unpacking psutil>=0.7.1 03:22:50 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:22:50 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:22:50 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:22:50 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:22:50 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:22:50 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:22:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:22:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:52 INFO - Installing collected packages: psutil 03:22:52 INFO - Running setup.py install for psutil 03:22:52 INFO - building 'psutil._psutil_linux' extension 03:22:52 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:22:52 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:22:52 INFO - building 'psutil._psutil_posix' extension 03:22:52 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:22:52 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:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:52 INFO - Successfully installed psutil 03:22:52 INFO - Cleaning up... 03:22:52 INFO - Return code: 0 03:22:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:52 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 0x7ff20d99af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a0b0>, '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 0x160afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', '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:22:52 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:22:52 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:22:52 INFO - Using env: {'DISPLAY': ':0', 03:22:52 INFO - 'HOME': '/home/cltbld', 03:22:52 INFO - 'LANG': 'en_US.UTF-8', 03:22:52 INFO - 'LANGUAGE': 'en_US:en', 03:22:52 INFO - 'LOGNAME': 'cltbld', 03:22:52 INFO - 'MAIL': '/var/mail/cltbld', 03:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:52 INFO - 'MOZ_NO_REMOTE': '1', 03:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:52 INFO - 'NO_EM_RESTART': '1', 03:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:52 INFO - 'PWD': '/builds/slave/test', 03:22:52 INFO - 'SHELL': '/bin/bash', 03:22:52 INFO - 'SHLVL': '1', 03:22:52 INFO - 'TERM': 'linux', 03:22:52 INFO - 'TMOUT': '86400', 03:22:52 INFO - 'USER': 'cltbld', 03:22:52 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', 03:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:52 INFO - '_': '/tools/buildbot/bin/python'} 03:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:22:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:54 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:22:54 INFO - Installing collected packages: mozsystemmonitor 03:22:54 INFO - Running setup.py install for mozsystemmonitor 03:22:54 INFO - Successfully installed mozsystemmonitor 03:22:54 INFO - Cleaning up... 03:22:54 INFO - Return code: 0 03:22:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff20d99af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a0b0>, '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 0x160afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', '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:22:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:22:54 INFO - Using env: {'DISPLAY': ':0', 03:22:54 INFO - 'HOME': '/home/cltbld', 03:22:54 INFO - 'LANG': 'en_US.UTF-8', 03:22:54 INFO - 'LANGUAGE': 'en_US:en', 03:22:54 INFO - 'LOGNAME': 'cltbld', 03:22:54 INFO - 'MAIL': '/var/mail/cltbld', 03:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:54 INFO - 'MOZ_NO_REMOTE': '1', 03:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:54 INFO - 'NO_EM_RESTART': '1', 03:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:54 INFO - 'PWD': '/builds/slave/test', 03:22:54 INFO - 'SHELL': '/bin/bash', 03:22:54 INFO - 'SHLVL': '1', 03:22:54 INFO - 'TERM': 'linux', 03:22:54 INFO - 'TMOUT': '86400', 03:22:54 INFO - 'USER': 'cltbld', 03:22:54 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', 03:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:54 INFO - '_': '/tools/buildbot/bin/python'} 03:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:22:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:57 INFO - Downloading docopt-0.6.1.tar.gz 03:22:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:57 INFO - Running setup.py install for blobuploader 03:22:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:22:57 INFO - Running setup.py install for requests 03:22:57 INFO - Running setup.py install for docopt 03:22:57 INFO - Successfully installed blobuploader requests docopt 03:22:57 INFO - Cleaning up... 03:22:57 INFO - Return code: 0 03:22:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:57 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 0x7ff20d99af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a0b0>, '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 0x160afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', '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:22:57 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:22:57 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:22:57 INFO - Using env: {'DISPLAY': ':0', 03:22:57 INFO - 'HOME': '/home/cltbld', 03:22:57 INFO - 'LANG': 'en_US.UTF-8', 03:22:57 INFO - 'LANGUAGE': 'en_US:en', 03:22:57 INFO - 'LOGNAME': 'cltbld', 03:22:57 INFO - 'MAIL': '/var/mail/cltbld', 03:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:57 INFO - 'MOZ_NO_REMOTE': '1', 03:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:57 INFO - 'NO_EM_RESTART': '1', 03:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:57 INFO - 'PWD': '/builds/slave/test', 03:22:57 INFO - 'SHELL': '/bin/bash', 03:22:57 INFO - 'SHLVL': '1', 03:22:57 INFO - 'TERM': 'linux', 03:22:57 INFO - 'TMOUT': '86400', 03:22:57 INFO - 'USER': 'cltbld', 03:22:57 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', 03:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:57 INFO - '_': '/tools/buildbot/bin/python'} 03:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:58 INFO - Running setup.py (path:/tmp/pip-j_VJpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:58 INFO - Running setup.py (path:/tmp/pip-Q64DHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:58 INFO - Running setup.py (path:/tmp/pip-beUawA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:58 INFO - Running setup.py (path:/tmp/pip-w6oQIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:58 INFO - Running setup.py (path:/tmp/pip-bLeP0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:58 INFO - Running setup.py (path:/tmp/pip-bkuGU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:58 INFO - Running setup.py (path:/tmp/pip-jZLv9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:58 INFO - Running setup.py (path:/tmp/pip-kAdLcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:58 INFO - Running setup.py (path:/tmp/pip-znEgLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:58 INFO - Running setup.py (path:/tmp/pip-TkwOe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:58 INFO - Running setup.py (path:/tmp/pip-jo_uv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:58 INFO - Running setup.py (path:/tmp/pip-oI2Z8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:58 INFO - Running setup.py (path:/tmp/pip-vk7iG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:58 INFO - Running setup.py (path:/tmp/pip-Kjrsfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:59 INFO - Running setup.py (path:/tmp/pip-b9GtJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:59 INFO - Running setup.py (path:/tmp/pip-n5luSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:59 INFO - Running setup.py (path:/tmp/pip-uXbhua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:59 INFO - Running setup.py install for manifestparser 03:22:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:22:59 INFO - Running setup.py install for mozcrash 03:22:59 INFO - Running setup.py install for mozdebug 03:22:59 INFO - Running setup.py install for mozdevice 03:22:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:22:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:22:59 INFO - Running setup.py install for mozfile 03:22:59 INFO - Running setup.py install for mozhttpd 03:22:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:22:59 INFO - Running setup.py install for mozinfo 03:22:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:22:59 INFO - Running setup.py install for mozInstall 03:23:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:00 INFO - Running setup.py install for mozleak 03:23:00 INFO - Running setup.py install for mozlog 03:23:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:00 INFO - Running setup.py install for moznetwork 03:23:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:00 INFO - Running setup.py install for mozprocess 03:23:00 INFO - Running setup.py install for mozprofile 03:23:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:00 INFO - Running setup.py install for mozrunner 03:23:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:00 INFO - Running setup.py install for mozscreenshot 03:23:00 INFO - Running setup.py install for moztest 03:23:00 INFO - Running setup.py install for mozversion 03:23:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:01 INFO - Cleaning up... 03:23:01 INFO - Return code: 0 03:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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', '-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 0x7ff20d99af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a0b0>, '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 0x160afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', '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:23:01 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:23:01 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:23:01 INFO - Using env: {'DISPLAY': ':0', 03:23:01 INFO - 'HOME': '/home/cltbld', 03:23:01 INFO - 'LANG': 'en_US.UTF-8', 03:23:01 INFO - 'LANGUAGE': 'en_US:en', 03:23:01 INFO - 'LOGNAME': 'cltbld', 03:23:01 INFO - 'MAIL': '/var/mail/cltbld', 03:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:01 INFO - 'MOZ_NO_REMOTE': '1', 03:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:01 INFO - 'NO_EM_RESTART': '1', 03:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:01 INFO - 'PWD': '/builds/slave/test', 03:23:01 INFO - 'SHELL': '/bin/bash', 03:23:01 INFO - 'SHLVL': '1', 03:23:01 INFO - 'TERM': 'linux', 03:23:01 INFO - 'TMOUT': '86400', 03:23:01 INFO - 'USER': 'cltbld', 03:23:01 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', 03:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:01 INFO - '_': '/tools/buildbot/bin/python'} 03:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:01 INFO - Running setup.py (path:/tmp/pip-T0_DE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:01 INFO - Running setup.py (path:/tmp/pip-lbCV9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:01 INFO - Running setup.py (path:/tmp/pip-bXQKM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:01 INFO - Running setup.py (path:/tmp/pip-UK_JKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:01 INFO - Running setup.py (path:/tmp/pip-vIj11F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:01 INFO - Running setup.py (path:/tmp/pip-ZTj9LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:01 INFO - Running setup.py (path:/tmp/pip-rn0rm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:01 INFO - Running setup.py (path:/tmp/pip-Crl4t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:01 INFO - Running setup.py (path:/tmp/pip-SiEnNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:01 INFO - Running setup.py (path:/tmp/pip-TXMMNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:02 INFO - Running setup.py (path:/tmp/pip-KNOzPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:02 INFO - Running setup.py (path:/tmp/pip-aFk1Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:02 INFO - Running setup.py (path:/tmp/pip-Jbww6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:02 INFO - Running setup.py (path:/tmp/pip-cb5m_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:02 INFO - Running setup.py (path:/tmp/pip-OFJfSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:02 INFO - Running setup.py (path:/tmp/pip-Elbh4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:02 INFO - Running setup.py (path:/tmp/pip-y_treT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:02 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:23:02 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:23:02 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:23:02 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:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:02 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:23:02 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:23:02 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:23:02 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:23:02 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:23:02 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:23:04 INFO - Downloading blessings-1.5.1.tar.gz 03:23:04 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:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:04 INFO - Installing collected packages: blessings 03:23:04 INFO - Running setup.py install for blessings 03:23:04 INFO - Successfully installed blessings 03:23:04 INFO - Cleaning up... 03:23:04 INFO - Return code: 0 03:23:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:04 INFO - Reading from file tmpfile_stdout 03:23:04 INFO - Current package versions: 03:23:04 INFO - argparse == 1.2.1 03:23:04 INFO - blessings == 1.5.1 03:23:04 INFO - blobuploader == 1.2.4 03:23:04 INFO - docopt == 0.6.1 03:23:04 INFO - manifestparser == 1.1 03:23:04 INFO - mozInstall == 1.12 03:23:04 INFO - mozcrash == 0.16 03:23:04 INFO - mozdebug == 0.1 03:23:04 INFO - mozdevice == 0.47 03:23:04 INFO - mozfile == 1.2 03:23:04 INFO - mozhttpd == 0.7 03:23:04 INFO - mozinfo == 0.9 03:23:04 INFO - mozleak == 0.1 03:23:04 INFO - mozlog == 3.1 03:23:04 INFO - moznetwork == 0.27 03:23:04 INFO - mozprocess == 0.22 03:23:04 INFO - mozprofile == 0.27 03:23:04 INFO - mozrunner == 6.11 03:23:04 INFO - mozscreenshot == 0.1 03:23:04 INFO - mozsystemmonitor == 0.0 03:23:04 INFO - moztest == 0.7 03:23:04 INFO - mozversion == 1.4 03:23:04 INFO - psutil == 3.1.1 03:23:04 INFO - requests == 1.2.3 03:23:04 INFO - wsgiref == 0.1.2 03:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:04 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 0x7ff20d99af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a0b0>, '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 0x160afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', '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:23:04 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:23:04 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:23:04 INFO - Using env: {'DISPLAY': ':0', 03:23:04 INFO - 'HOME': '/home/cltbld', 03:23:04 INFO - 'LANG': 'en_US.UTF-8', 03:23:04 INFO - 'LANGUAGE': 'en_US:en', 03:23:04 INFO - 'LOGNAME': 'cltbld', 03:23:04 INFO - 'MAIL': '/var/mail/cltbld', 03:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:04 INFO - 'MOZ_NO_REMOTE': '1', 03:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:04 INFO - 'NO_EM_RESTART': '1', 03:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:04 INFO - 'PWD': '/builds/slave/test', 03:23:04 INFO - 'SHELL': '/bin/bash', 03:23:04 INFO - 'SHLVL': '1', 03:23:04 INFO - 'TERM': 'linux', 03:23:04 INFO - 'TMOUT': '86400', 03:23:04 INFO - 'USER': 'cltbld', 03:23:04 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', 03:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:04 INFO - '_': '/tools/buildbot/bin/python'} 03:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:04 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 1)) 03:23:04 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 2)) 03:23:04 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 3)) 03:23:04 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 4)) 03:23:04 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 5)) 03:23:04 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 6)) 03:23:04 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 7)) 03:23:04 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 8)) 03:23:04 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:04 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 3)) 03:23:04 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:04 INFO - Cleaning up... 03:23:04 INFO - Return code: 0 03:23:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23: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:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:04 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 0x7ff20d99af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a0b0>, '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 0x160afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', '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:23:04 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:23:04 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:23:04 INFO - Using env: {'DISPLAY': ':0', 03:23:04 INFO - 'HOME': '/home/cltbld', 03:23:04 INFO - 'LANG': 'en_US.UTF-8', 03:23:04 INFO - 'LANGUAGE': 'en_US:en', 03:23:04 INFO - 'LOGNAME': 'cltbld', 03:23:04 INFO - 'MAIL': '/var/mail/cltbld', 03:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:04 INFO - 'MOZ_NO_REMOTE': '1', 03:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:04 INFO - 'NO_EM_RESTART': '1', 03:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:04 INFO - 'PWD': '/builds/slave/test', 03:23:04 INFO - 'SHELL': '/bin/bash', 03:23:04 INFO - 'SHLVL': '1', 03:23:04 INFO - 'TERM': 'linux', 03:23:04 INFO - 'TMOUT': '86400', 03:23:04 INFO - 'USER': 'cltbld', 03:23:04 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', 03:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:04 INFO - '_': '/tools/buildbot/bin/python'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 INFO - Downloading/unpacking jsonschema 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:06 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:23:06 INFO - Downloading/unpacking functools32 (from jsonschema) 03:23:06 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:23:06 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:23:06 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:23:06 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:23:06 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:23:06 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:23:06 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:06 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:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:06 INFO - warning: no files found matching '*.txt' 03:23:06 INFO - no previously-included directories found matching 'build' 03:23:06 INFO - no previously-included directories found matching 'dist' 03:23:06 INFO - no previously-included directories found matching '.git*' 03:23:07 INFO - Installing collected packages: jsonschema, functools32 03:23:07 INFO - Running setup.py install for functools32 03:23:07 INFO - warning: no files found matching '*.txt' 03:23:07 INFO - no previously-included directories found matching 'build' 03:23:07 INFO - no previously-included directories found matching 'dist' 03:23:07 INFO - no previously-included directories found matching '.git*' 03:23:07 INFO - Successfully installed jsonschema functools32 03:23:07 INFO - Cleaning up... 03:23:07 INFO - Return code: 0 03:23:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:07 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 0x7ff20d99af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a0b0>, '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 0x160afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', '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:23:07 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:23:07 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:23:07 INFO - Using env: {'DISPLAY': ':0', 03:23:07 INFO - 'HOME': '/home/cltbld', 03:23:07 INFO - 'LANG': 'en_US.UTF-8', 03:23:07 INFO - 'LANGUAGE': 'en_US:en', 03:23:07 INFO - 'LOGNAME': 'cltbld', 03:23:07 INFO - 'MAIL': '/var/mail/cltbld', 03:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:07 INFO - 'MOZ_NO_REMOTE': '1', 03:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:07 INFO - 'NO_EM_RESTART': '1', 03:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:07 INFO - 'PWD': '/builds/slave/test', 03:23:07 INFO - 'SHELL': '/bin/bash', 03:23:07 INFO - 'SHLVL': '1', 03:23:07 INFO - 'TERM': 'linux', 03:23:07 INFO - 'TMOUT': '86400', 03:23:07 INFO - 'USER': 'cltbld', 03:23:07 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', 03:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:07 INFO - '_': '/tools/buildbot/bin/python'} 03:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:07 INFO - Downloading/unpacking flake8 03:23:07 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:23:07 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:23:07 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:23:07 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:23:07 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:23:07 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:23:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:23:09 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:23:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:23: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:23: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:23: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:23: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:23: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:23: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:23:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:23:09 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:23:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:23: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:23: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:23: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:23: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:23: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:23: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:23:09 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:23:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:23: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:23: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:23: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:23: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:23: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:23: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:23:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:09 INFO - no previously-included directories found matching 'docs/_build' 03:23:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:23:09 INFO - Running setup.py install for pep8 03:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:09 INFO - no previously-included directories found matching 'docs/_build' 03:23:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:23:09 INFO - Cleaning up... 03:23:09 INFO - Return code: 0 03:23:09 INFO - Running post-action listener: _resource_record_post_action 03:23:09 INFO - Running post-action listener: _start_resource_monitoring 03:23:10 INFO - Starting resource monitoring. 03:23:10 INFO - ##### 03:23:10 INFO - ##### Running install step. 03:23:10 INFO - ##### 03:23:10 INFO - Running pre-action listener: _resource_record_pre_action 03:23:10 INFO - Running main action method: install 03:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:10 INFO - Reading from file tmpfile_stdout 03:23:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:10 INFO - Reading from file tmpfile_stdout 03:23:10 INFO - Output received: 03:23:10 INFO - Usage: mozinstall [options] installer 03:23:10 INFO - Options: 03:23:10 INFO - -h, --help show this help message and exit 03:23:10 INFO - -d DEST, --destination=DEST 03:23:10 INFO - Directory to install application into. [default: 03:23:10 INFO - "/builds/slave/test"] 03:23:10 INFO - --app=APP Application being installed. [default: firefox] 03:23:10 INFO - mkdir: /builds/slave/test/build/application 03:23:10 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:23:10 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:23:24 INFO - Reading from file tmpfile_stdout 03:23:24 INFO - Output received: 03:23:24 INFO - /builds/slave/test/build/application/firefox/firefox 03:23:24 INFO - Running post-action listener: _resource_record_post_action 03:23:24 INFO - ##### 03:23:24 INFO - ##### Running run-tests step. 03:23:24 INFO - ##### 03:23:24 INFO - Running pre-action listener: _resource_record_pre_action 03:23:24 INFO - Running main action method: run_tests 03:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:24 INFO - Python 2.7.3 03:23:24 INFO - Return code: 0 03:23:24 INFO - grabbing minidump binary from tooltool 03:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:24 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 0x160a0b0>, '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 0x160afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:24 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:23:24 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:23:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:24 INFO - Return code: 0 03:23:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:23:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:23:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:23:25 INFO - Return code: 0 03:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] in /builds/slave/test/build 03:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost 03:23:25 INFO - Using env: {'DISPLAY': ':0', 03:23:25 INFO - 'HOME': '/home/cltbld', 03:23:25 INFO - 'LANG': 'en_US.UTF-8', 03:23:25 INFO - 'LANGUAGE': 'en_US:en', 03:23:25 INFO - 'LOGNAME': 'cltbld', 03:23:25 INFO - 'MAIL': '/var/mail/cltbld', 03:23:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:25 INFO - 'MOZ_NO_REMOTE': '1', 03:23:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:25 INFO - 'NO_EM_RESTART': '1', 03:23:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:25 INFO - 'PWD': '/builds/slave/test', 03:23:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:25 INFO - 'SHELL': '/bin/bash', 03:23:25 INFO - 'SHLVL': '1', 03:23:25 INFO - 'TERM': 'linux', 03:23:25 INFO - 'TMOUT': '86400', 03:23:25 INFO - 'USER': 'cltbld', 03:23:25 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610', 03:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:25 INFO - '_': '/tools/buildbot/bin/python'} 03:23:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] with output_timeout 3600 03:23:26 INFO - mozversion INFO | application_buildid: 20151217024532 03:23:26 INFO - mozversion INFO | application_changeset: ee39999c8d225f524e857e56a17dbf2787143448 03:23:26 INFO - mozversion INFO | application_display_name: Nightly 03:23:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:26 INFO - mozversion INFO | application_name: Firefox 03:23:26 INFO - mozversion INFO | application_remotingname: firefox 03:23:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:23:26 INFO - mozversion INFO | application_vendor: Mozilla 03:23:26 INFO - mozversion INFO | application_version: 46.0a1 03:23:26 INFO - mozversion INFO | platform_buildid: 20151217024532 03:23:26 INFO - mozversion INFO | platform_changeset: ee39999c8d225f524e857e56a17dbf2787143448 03:23:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:23:26 INFO - mozversion INFO | platform_version: 46.0a1 03:23:26 INFO - 2015-12-17 03:23:26,079 DEBUG : using testdate: 1450351406 03:23:26 INFO - 2015-12-17 03:23:26,079 DEBUG : actual date: 1450351406 03:23:26 INFO - 2015-12-17 03:23:26,089 INFO : starting webserver on 'localhost:35343' 03:23:26 INFO - 2015-12-17 03:23:26,090 INFO : Starting test suite talos-linux64-ix-063.e 03:23:26 INFO - 2015-12-17 03:23:26,091 INFO : Starting test dromaeo_css 03:23:26 INFO - 2015-12-17 03:23:26,091 DEBUG : operating with platform_type : linux_ 03:23:26 INFO - 2015-12-17 03:23:26,091 INFO : Initialising browser for dromaeo_css test... 03:23:26 INFO - 2015-12-17 03:23:26,104 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dPP5H/profile http://localhost:35343/getInfo.html 03:23:30 INFO - 2015-12-17 03:23:30,923 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:23:30 INFO - 2015-12-17 03:23:30,924 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:23:30 INFO - 2015-12-17 03:23:30,924 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:23:30 INFO - 2015-12-17 03:23:30,924 DEBUG : BROWSER_OUTPUT: __metrics 03:23:31 INFO - 2015-12-17 03:23:31,028 DEBUG : BROWSER_OUTPUT: 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:23:31 INFO - 2015-12-17 03:23:31,977 INFO : Browser initialized. 03:23:31 INFO - 2015-12-17 03:23:31,978 INFO : Running cycle 1/1 for dromaeo_css test... 03:23:31 INFO - 2015-12-17 03:23:31,978 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dPP5H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:23:44 INFO - 2015-12-17 03:23:44,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 142991360 03:23:44 INFO - 2015-12-17 03:23:44,108 DEBUG : BROWSER_OUTPUT: 03:24:33 INFO - 2015-12-17 03:24:33,738 DEBUG : BROWSER_OUTPUT: 1450351473736 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:26:45 INFO - 2015-12-17 03:26:45,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35343/tests/dromaeo/cssquery-ext.html) 03:26:46 INFO - 2015-12-17 03:26:46,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 146821120 03:26:46 INFO - 2015-12-17 03:26:46,436 DEBUG : BROWSER_OUTPUT: 03:29:48 INFO - 2015-12-17 03:29:48,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/dromaeo/cssquery-ext.html (next: http://localhost:35343/tests/dromaeo/cssquery-jquery.html) 03:29:49 INFO - 2015-12-17 03:29:49,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 146735104 03:29:49 INFO - 2015-12-17 03:29:49,081 DEBUG : BROWSER_OUTPUT: 03:32:50 INFO - 2015-12-17 03:32:50,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35343/tests/dromaeo/cssquery-mootools.html) 03:32:51 INFO - 2015-12-17 03:32:51,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 145620992 03:32:51 INFO - 2015-12-17 03:32:51,489 DEBUG : BROWSER_OUTPUT: 03:35:53 INFO - 2015-12-17 03:35:53,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35343/tests/dromaeo/cssquery-prototype.html) 03:35:53 INFO - 2015-12-17 03:35:53,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 144130048 03:35:53 INFO - 2015-12-17 03:35:53,867 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-12-17 03:38:56,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35343/tests/dromaeo/cssquery-yui.html) 03:38:57 INFO - 2015-12-17 03:38:57,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 143880192 03:38:57 INFO - 2015-12-17 03:38:57,203 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-12-17 03:41:59,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/dromaeo/cssquery-yui.html (next: http://localhost:35343/tests/dromaeo/cssquery-dojo.html) 03:41:59 INFO - 2015-12-17 03:41:59,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 147214336 03:41:59 INFO - 2015-12-17 03:41:59,805 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-12-17 03:41:59,806 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:41:59 INFO - 2015-12-17 03:41:59,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:41:59 INFO - 2015-12-17 03:41:59,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:41:59 INFO - 2015-12-17 03:41:59,806 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:41:59 INFO - 2015-12-17 03:41:59,808 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2673.7459941305574;2711.4170453352526;2750.834949903006;2754.752072313491;2769.169249225232;4686.461056978448;4820.915294058839;4824.565789078983;4881.560659540645;4890.388701412324;4738.123447162277;4759.500252473493;4772.403449568804;4803.903921921559;4934.309196712463;4406.228909940755;4467.620252278561;4537.70504917181;4539.341795439659;4566.611837993774;495.1517980821479;4414.073044660625;4466.977665111686;4531.365608814768;4543.840965566206;4437.090396468732;4461.955380446187;4463.620592249663;4464.374987501752;4517.480489743656;4470.240059189946;4483.3947417098925;4502.527234640348;4503.324501324795;4535.637149028103;4281.957180428187;4384.912301753979;4385.56144385562;4432.889177770581;4467.6425885929375;4712.929306060412;4773.140834649762;4776.641751868589;4785.1024208566105;4805.279208118775;4940.209566469348;5214.5306922376785;5224.190250511177;5224.555912747421;5280.260763493114;5015.924761128586;5112.642115051948;5114.795408183668;5157.200633901752;5163.561097306733;4774.140654682191;4820.180569303227;4825.30033145199;4829.806807727722;4884.511548845158;5029.597632189416;5191.922121168185;5328.200769884548;5333.653312534673;5341.465853414627;4988.825391111366;4997.7251251180805;5008.373953255843;5013.774380152902;5014.247862820606;5074.314967479343;5134.666246694028;5242.606804489602;5246.055709972242;5304.469553044664;5113.309703190096;5128.871778205575;5160.48395160481;5161.793528258828;5205.73971301441;4841.878953026132;4958.57852082577;5096.821611243588;5109.923351149661;5116.539511443988;4258.446401967786;4338.696291259645;4338.934915976263;4380.7371557706;4393.846215382447;3785.5835858055593;3790.639889210521;3792.7724336539895;3818.5990471000146;3831.214601006787;4269.316909294498;4366.781660916941;4370.672199585044;4530.79611417487;4543.522930092358;5077.39071311445;5131.897362052738;5144.099782538041;5157.922631160535;5186.066508028591;4446.599806017474;4462.419885414875;4464.129494748493;4474.306482495218;4502.279635258343;4378.868633940987;4472.753998530047;4556.997460558672;4563.110193512233;4588.220002599566;4824.831130910401;4836.419629644465;4846.5638092571835;4957.058158949788;4964.528369804862;5143.665661731976;5145.305383773292;5147.796904729867;5155.226715992481;5159.071367153948;4865.270209468466;4865.343178670834;4867.318575399518;4881.096997055556;4924.384451943507;4886.609071274361;4975.303457515878;4998.475160108136;5046.949530504648;5085.110105731556;5255.737213139404;5261.079311120615;5261.89476210466;5278.683279003272;5312.468753124656;4769.165396055746;5012.072766538202;5055.51972562606;5062.696238225718;5078.619103567321;4917.262410638433;4933.55597996182;5013.548780609763;5021.196608542616;5070.873228169177;4894.779734911866;4901.558859702502;4931.901361972812;4931.901361972812;4991.326170967018;4732.384789977418;4933.383327084114;5065.544101030925;5068.315777370155;5113.028524580318;4832.95167048325;4877.341558889504;4913.70517768935;4917.311576379238;4954.430240522242 03:41:59 INFO - 2015-12-17 03:41:59,811 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.9456033536281;560.6720068759776;567.4013915319338;569.345252959097;574.0499473371572;35996;37013.44479832801;37015.25969480609;37115.62884371156;37156.07109822256;41081.79459102708;41516.792416037955;41570.58429415705;41600.58399416005;41741.16517669645;7934.365250779938;8117.8782318264975;8134.877976830352;8144.6742130315015;8163.551004694739;7858.960705196495;7950.443468957175;7976.641051152712;7985.201479852027;7995.6801727930815;7919.326857217144;8015.198480151997;8036.196380361976;8037.95981020094;8046.919530804705;7985;8039.437239393244;8045.115037345888;8061.516309021448;8062.355011599058;7882.330001949841;8015.7595272141925;8015.998000249969;8023.197680231989;8041.437099403044;37203.25593488115;37254.441183382274;37465.62534374676;37711.245775084346;37728.62271377306;2820.1680504251294;2893.059755579445;2953.438846619157;2954.807937484078;3479.443289073761;27832.16503504898;28148.15555533337;28400;28590;29048.709512905025;3241.308487621993;3292.3615020901;3317.170707323169;3329.96670033299;3356.127406874206;204021;204818;205173;205469;206792.9999999985;38353;38918.22163556713;39189.80405097956;39229;55160;36129.819350903075;36411.27177456436;36503.634963650555;36621.08447288786;36715.63284367122;12457.06572007103;12546;12587.363642726386;12592.307423091817;12629.747405051847;10474.947625261977;10547.84178237327;10548.103411210133;10552.366857988392;10604.469776511143;13437.32813359328;13490.52783152585;13565.864341356657;13601.727965440834;13627;5435.728213589305;5478.150886612581;5496.367917689437;5536.861578460571;5539.723013849291;812.321711371;863.5164307987548;874.3879284500874;953.3136141977765;1023.3910823060268;26704.332391689975;26962.865185673945;30439;31160.68839311578;31347.686523134933;901.324006994754;975.6146322202691;978.4667356290838;1045.8326667733127;1078.6278733836814;13809.378577964017;13837.584872453843;14014.929925350309;14086.013979021574;14244.786328205086;295501;298328;298922;302100;302484;47297.763511182915;47363.289550656766;47490.28764568534;47781;47821.5217847824;1242.6334231401759;1245.5266998540678;1252.4614415801293;1257.1388598809845;1257.4530079415483;26025.21924342273;26229.606555902057;26627.33431664224;26724;27090.1872943812;40000.799995999834;40542.39186412265;40723.38914916338;40727.1854562913;40878.38682419706;249282;249997;250285;252656;252789;29567.704322956495;43675;43803.12393752171;44250.336244957;44645.10709785721;38949.415758763076;40281;47054.76472617752;48026.27960580664;48418.757906210245;33076.338473230884;33194.336113278085;33789.66210337865;34146.31707365789;34512.30975380528;33666;33718.8314058438;34091.82954085214;34170.31659366848;34210.31579368449;33469.49795753017;33816.49275260922;34190.82904585561;34221.31557368889;34280.48579271263;29320.560191596716;30180.84909575438;30922.226944326572;31245;31375.215619608778;23837.4672815655;24005.75994240105;24058.75941240635;24246.878765606765;24535.14127005546 03:41:59 INFO - 2015-12-17 03:41:59,811 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.7956336416468;341.3548393536217;341.7675980333372;343.06172617890064;346.07425137756496;14915.850841491581;14987.700245995073;15895.205239738025;15988.76016859748;16569;14892;14902.403903843833;15392.538223853275;15409;15490.225488725548;4385.254506733863;4584.770761461914;4590.770461476929;4596.6092882104895;4596.793144308497;4512.97743511282;4519.435070616173;4532.410786597738;4533.070720502289;4534.773261336936;3204.150900011499;3323.2854936188714;4532.070925460289;4554.931676024862;4989.800407983676;5124.8975020499565;5138.460461651547;5149.201873709581;5158.509941555546;5174.611904107188;4918.631102667278;4941.431735350445;4967.627427942919;5073.39119305682;5102.668326558799;10507.106895913856;10656.413897235649;10739.194560407923;10765.246432749711;16704.916475417667;1732.6274850907116;1746.0309528211965;1768.1689605885213;1857.5263307856546;1908.6564418404682;8755.693550725695;8759.51822649754;10907.018368346808;11364.602238921681;12635.936820315932;1720.2602880761267;1744.2325376834278;1749.5801007758046;1774.8846324988835;1776.1474492243794;53395.46604533944;53787;53953.1907021395;54277.1858422124;54301.72849135729;9999.850002249972;10014.198864090855;10021.39871607706;10092.596296148218;10108.938561450941;12469.937650311691;12622.684432889251;12640.6839829005;12682.048846336562;12684.556040538537;6946.235914049451;7114.648216838784;7173.5337203081635;7203.71185152588;7243.456740744466;6860.965695171492;6863.210730765926;6887.449004079662;6941.271166527543;6947.930520694829;3984.5816189300285;4027.9194416111513;4201.915961680749;4214.873553793391;4308.159908817751;1719.2950890134985;1744.5028166972352;1746.0571291502447;1766.0816375484676;1783.2153852304943;376.21183620315395;379.3778203745859;392.6387723294576;978.3885071830106;981.8281800684852;8985.685501007434;15182.316795744218;15616.843831561766;15656.530304090895;15705;816.0452270843127;829.3489610655727;836.0844874862016;874.1477059866579;879.6173664455982;8627.568621568897;9231.953840230755;9240.676576319931;9259.953700231456;9439.292053095907;473037;473049;477971;478155;487565;66388;67582.66208668925;67878.66060669665;69326.30673693199;69708.30291697018;1088.080571916745;1097.0400899213348;1097.8792332843382;1099.0932480703452;1099.8790133085354;14301.713965720835;14424;14494.782578261545;14651.780223296446;14677;29162.854185728935;29490.262743431587;29620;30729.078127656205;32164.19589510281;41143.7942810284;42428;42888;42895;43085.56914430941;8180.181981801772;8931.374803763674;8977.23693486061;9188.540572971191;9205.447673139633;9972.351797133164;10025.749356266151;10063.597456101674;15008.6998260032;16653.25060372262;12606.621801345975;13100.213987160801;13492.257925814174;13592.524261650795;13706;12763.106582539505;12763.617091487271;12817.42321595549;12909.806352904527;13083.934580327037;13438.932805335911;13654.522091726742;13661.86338136606;13836.308184590931;14065.929670351583;8649.870251946351;8744;8761.123887611187;8765.605547750494;8810.471371717718;13897.16617002983;13955.720885582434;14082.436702532194;14319.140851548524;14335.211563364115 03:41:59 INFO - 2015-12-17 03:41:59,811 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1460.247972294268;1641.9261133249004;1665.983340166598;1703.906285154316;1729.835665611767;6889.931100688992;7126.608036557987;7182.209956904743;7378.5203961742445;7403.555786652798;7184.712611495534;7301.1968683444775;7302.890456643155;7331.303526165006;7347.88978165328;2079.428157256755;2124.4370241885913;2126.00077963357;2130.38218916514;2132.605467988419;2129.957400851982;2137.3908436095717;2147.527543940331;2148.602508535926;2148.881811500367;2059.6910463430454;2072.968905466419;2112.6936594193835;2113.049127892447;2129.105775574255;2082.052666036957;2086.531751570136;2092.3618296419586;2095.434232757147;2107.104480595741;2056.92800751973;2070.037432593851;2076.262926661044;2080.833533317331;2091.5398612305266;6997.370236678723;7037.718491260343;7053.0830991971225;7060.364567188978;7099.858002839966;4197.223513649985;4265.232258193524;4284.100338928829;4288.035192081757;4304.978475107636;2668.21287720123;2718.8504632245217;2755.641766570353;2775.4587855368213;2782.874770635326;850.6427300533791;856.7686724584389;883.2007033634571;884.2483888694622;886.5655828643983;9310.162085412278;9340.906590934072;9404;9427.434353938786;9451.33840631156;3833.865814696472;3913.6477717005037;3936.7834769087403;3942.6845852331744;3992.261431635157;8230.506169629842;8317.126701696236;8356.415050946376;8367.163283671705;8368.995720513578;4167.499900012018;4175.478065241845;4179.498460184797;4185.581441855851;4200.243956087934;3826.4642949987024;3829.770213787126;3833.4058220975794;3847.615238476186;3851.1912498375095;3234.8706051758136;3348.8325583720716;3349.531065650811;3365.2932884094125;3380.428100933078;1052.2791887557048;1073.6778966310076;1076.155218153761;1078.8381742738652;1081.5295346524288;873.2926329672858;875.1292463998235;883.8143989762093;1035.9692106354225;1160.14729174057;6587.868242635121;6597;6622.1722284714415;6635.834104147435;6649.135612370361;961.5769061612868;1021.5913634546241;1041.5000799616075;1062.7608788022633;1065.0148612533376;4912.70523768575;4929.088118698052;4956.033573453142;4958.628102892298;4962.478939711278;8412.158784121539;8843.115688431235;8864.512451815212;8896.377253592187;8909.688160914466;8627.956860215785;8641.179087986631;8675.219230269306;8710.085441028728;8752.8687069694;6581.2102547694585;6592.208934927743;6773.796786096524;6820.522563420513;6828.795136145924;6317.557770955989;6334.113224148715;6346.365363463617;6351;6358.745650173942;7457.47797654159;7621.3902887769955;7636.160022397421;7687.615619219128;7696.499727517694;7789.922100779147;7836.177201393772;8000.439969202333;8005.279524842792;8012.639431225492;5716.9142462862255;6117.602355846856;6148.78479253224;6165.691715414301;6180.4746596538;6521.608703477807;6553.377429144223;6568.047633093271;6568.868622627616;6604.669766511559;6059.72731227087;6085.3306136325855;6146.139540464249;6209.937900621117;6266.060090986389;6004.969975150097;6057.394260573908;6099.3900609938655;6118.388161183846;6210.596311239755;6054.848628784315;6377.74489020434;6397.264314603694;6411.871762564816;6423.325550817097;6039.184710064085;6082.36135205797;6087;6093.05557638549;6094.878102437838;6143.385661433999;6158.753649853956;6163.630182189083;6166.136740856374;6174.073888916699 03:41:59 INFO - 2015-12-17 03:41:59,813 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.10269294808523;306.50040434092426;311.0450915688835;314.23170348497905;318.09184777460365;5564.888702225958;5708.600397972144;5720.399358067405;5748.798792042279;5749.022666146755;5511.063119269724;5588.497035266825;5590.91613625796;5603.523700485463;5614.775408983646;4154.771487568182;4287.164003019412;4351.6953813233085;4354.412154359153;4356.433663623732;4274.935875961863;4276.25165596021;4293.098449325646;4295.591918767712;4302.677299202556;4225.112726327475;4250.362445633149;4252.064545799919;4254.595813397737;4258.105797782469;4247.108107297456;4250.192463431938;4254.149170165979;4254.255505286563;4257.87226383209;3610.7291953103622;3688.188598508324;3689.4465830125696;3693.7968411737343;3695.61196074411;5254.789808407659;5399.541039011689;5406.972965135188;5408.45915408456;5413.404525502192;4882.902341953177;4887.120318342697;4890.070886531547;4890.315355850184;4901.240307752304;5860.677662728548;5870.002099643071;5882;5896.528277737771;5907.645541267538;3877.6316249956208;3981.581933896928;3981.601839816024;3984.2230765000836;3987.900302492432;6125.111858780497;6207.193064901579;6207.4723648489935;6209.59637623553;6209.658468784215;4131.648809851196;4148.605882441163;4162.167566486714;4162.583741625874;4163.5836416358725;4213.726107802983;4215.451991241119;4218.578142185757;4222.239996800544;4235.1953128906025;4679.9532004680195;4688.906221875543;4873.122837889143;4882.7314497702255;4890.559849613552;5900.380460051632;5901.498372638288;5904.645721256738;5916.970415147896;5917.171595976567;1457.205822826562;1475.7417451945867;1483.777433385001;1487.256371814093;1490.299559207171;951.6336210558985;953.2564599612314;954.4511905654276;960.558143254097;991.5587563534158;5086.338775959101;5132.589392848563;5150.742462876841;5151.175811870083;5153.098207813618;6132.50939924805;6146.385361463817;6149.2313460817395;6156.569040167145;6163;5118.232265160182;5139.58883289336;5146.356705411824;5146.87132821675;5149.510796474329;3234.498652708834;3280.245543524955;3305.5206994986074;3332.183615014337;3340.4154273002127;5845.357010728816;5866.178734977107;5872.882542349129;5887.381824908409;5888.970555147197;6336.714847831859;6368.713407896656;6380.234371875312;6392.328805475451;6417.9679101605125;5682.261306030272;5793.420657934173;5807.5644326675665;5811.912821307684;5886.05823068307;6206.72069756853;6209.316975132641;6209.441150296495;6232.314445411092;6237.875242495215;6045.727942242522;6053.3946605339115;6056.9091463628965;6066.757329706938;6082.665453399928;5758.539316854725;5851.561132915133;5861.9706901465215;5865.061590145727;5884.558658100746;4114.423980642772;4182.874513764592;4184.079502509443;4190.287651099259;4192.664586832985;5888.352281248974;6078.665673388006;6182.783602573888;6200.100985357189;6204.255489341308;5747.885042299215;5930.940690593039;5932.2584676915385;5936.1095835625;5941.7623295067715;5923.08192230205;5925.614835035709;5929.970350148222;5955.106733989763;5958.6424814511265;5671.829845104653;5818.359980402068;5821.592488525763;5822.679752613478;5838.2702162229725;5925.229720136354;5931.08068249422;5974.522038237017;5989.520838332835;6001.639901605918;5828.213191219131;5836.387179346108;5837.766489340379;5855.092460668603;5855.824325270249 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: |5;yui.html;566.5609152906497;635.6758053392771;637.2321352769912;656.5174596671449;659.9012643947825;10481.480185373117;10698.304610200332;10756.300840445385;10803.189760767935;10864.293820901647;10148;10178.643747468841;10196.439195844225;10207;10470;803.8070862992869;807.3783186946048;813.7721437997341;819.5697258939045;821.995890020549;803.5821372886124;803.6222975201675;806.9596520173997;810.4610434061342;815.1115284340068;848.8047749017729;851.0553285852699;856.4903882190087;857.4683696108422;858.8282343531318;838.861587838006;842.8862103615994;843.5992903370911;846.4667259626395;849.129642116829;627.7269387816315;629.471244154912;630.2374127305965;631.4317114596854;633.0314618633498;10927.672169834917;10951.780964380747;10952.178586605956;10993.395363255018;11047.779044419147;10771.946140269327;10808.945955270252;11069;11181.32912025281;11609.30344179352;8813.162749538847;9072.455652660861;9426.481543515103;9432.575534100983;9755.853662195073;3041.923951901198;3070.3859228154233;3085.598872146629;3091.4899041658323;3117.2206948262933;40891.182176356306;40953.59046409527;41162;41195.382069268984;41365;8051.194880511902;8152;8418.6211620476;8619.396642234984;8628.396012279205;14184.85815141856;14189.148651080968;14201.644958876112;14212.218327991854;14220.928895355664;5919.526437884959;5930;5947.583669143119;6105.145279660851;6110.419510146529;3486.33759585683;3492.7729697569575;3507.7895326280504;3542.8405721742583;3581.068922080226;2355.4817940053163;2365.6451532269953;2373.97626023741;2379.9762002380103;2392.79661228794;465.46471557708907;465.6368032934317;468.8265341823547;472.9739864307496;473.5998081621025;427.81390095308643;585.6603170161296;596.0998891673604;598.2611474828583;599.2299894635372;7636.770896873103;7669.923300767033;7696.191899850435;7795.454318197785;7932.444728869039;466.3936882053317;500.8447381311805;505.6207844116912;505.6460477665575;600.6332871561414;3585.8924232273075;3599.892003239907;3634.672879440863;3710.239400922804;3769.26499332633;46425.76787116043;46724;46891;46943.5305646946;47220.52779472162;42857;43286;43419;43829.34255986163;43878.561214388086;39360.409593856115;39575.80212098921;39667;39810.80094599567;40045.79977100096;7337.339639432476;7363.300486453778;7506.28690274423;7588.506747061423;7607.35337496319;29972.100836974925;30506.389872201988;30550.388992219585;31073.223169420944;31445.213869653442;33950.49074263938;34056;36894.262114758094;36998.26003479969;37278;8976.202993720788;9126.13301736334;9139.405938613969;9316;9358.204552612831;10161.796764064826;10226.335288206243;10307.793844122925;10341.224408169266;10343.431111288952;9284.814303714023;9596.9040309596;9943.950280248553;9998.500074996367;10007.499625018865;9151.542422878963;9575.616975320909;9590.760230994281;9717.41695498244;9734.123928846439;8982.416142950688;9182.586783594621;9271.443713377219;9320.580573874327;9441.339106262496;8145.918540814516;8465.66137354499;8552.786180345292;8681.262092722189;8837.955810220908;8187.467814592271;8194.50832950025;8342.207490288412;8366.24703776663;8619.956900215459 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,330 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: __startTimestamp1450352519805__endTimestamp 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-12-17 03:41:59,814 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4730.12 Median:4881.56 stddev:592.39 (12.1%) stddev-sans-first:571.82 03:41:59 INFO - 2015-12-17 03:41:59,815 DEBUG : BROWSER_OUTPUT: Values: 2673.7 2711.4 2750.8 2754.8 2769.2 4686.5 4820.9 4824.6 4881.6 4890.4 4738.1 4759.5 4772.4 4803.9 4934.3 4406.2 4467.6 4537.7 4539.3 4566.6 495.2 4414.1 4467.0 4531.4 4543.8 4437.1 4462.0 4463.6 4464.4 4517.5 4470.2 4483.4 4502.5 4503.3 4535.6 4282.0 4384.9 4385.6 4432.9 4467.6 4712.9 4773.1 4776.6 4785.1 4805.3 4940.2 5214.5 5224.2 5224.6 5280.3 5015.9 5112.6 5114.8 5157.2 5163.6 4774.1 4820.2 4825.3 4829.8 4884.5 5029.6 5191.9 5328.2 5333.7 5341.5 4988.8 4997.7 5008.4 5013.8 5014.2 5074.3 5134.7 5242.6 5246.1 5304.5 5113.3 5128.9 5160.5 5161.8 5205.7 4841.9 4958.6 5096.8 5109.9 5116.5 4258.4 4338.7 4338.9 4380.7 4393.8 3785.6 3790.6 3792.8 3818.6 3831.2 4269.3 4366.8 4370.7 4530.8 4543.5 5077.4 5131.9 5144.1 5157.9 5186.1 4446.6 4462.4 4464.1 4474.3 4502.3 4378.9 4472.8 4557.0 4563.1 4588.2 4824.8 4836.4 4846.6 4957.1 4964.5 5143.7 5145.3 5147.8 5155.2 5159.1 4865.3 4865.3 4867.3 4881.1 4924.4 4886.6 4975.3 4998.5 5046.9 5085.1 5255.7 5261.1 5261.9 5278.7 5312.5 4769.2 5012.1 5055.5 5062.7 5078.6 4917.3 4933.6 5013.5 5021.2 5070.9 4894.8 4901.6 4931.9 4931.9 4991.3 4732.4 4933.4 5065.5 5068.3 5113.0 4833.0 4877.3 4913.7 4917.3 4954.4 03:41:59 INFO - 2015-12-17 03:41:59,815 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-12-17 03:41:59,815 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40863.27 Median:34250.90 stddev:66507.55 (194.2%) stddev-sans-first:66625.26 03:41:59 INFO - 2015-12-17 03:41:59,815 DEBUG : BROWSER_OUTPUT: Values: 554.9 560.7 567.4 569.3 574.0 35996.0 37013.4 37015.3 37115.6 37156.1 41081.8 41516.8 41570.6 41600.6 41741.2 7934.4 8117.9 8134.9 8144.7 8163.6 7859.0 7950.4 7976.6 7985.2 7995.7 7919.3 8015.2 8036.2 8038.0 8046.9 7985.0 8039.4 8045.1 8061.5 8062.4 7882.3 8015.8 8016.0 8023.2 8041.4 37203.3 37254.4 37465.6 37711.2 37728.6 2820.2 2893.1 2953.4 2954.8 3479.4 27832.2 28148.2 28400.0 28590.0 29048.7 3241.3 3292.4 3317.2 3330.0 3356.1 204021.0 204818.0 205173.0 205469.0 206793.0 38353.0 38918.2 39189.8 39229.0 55160.0 36129.8 36411.3 36503.6 36621.1 36715.6 12457.1 12546.0 12587.4 12592.3 12629.7 10474.9 10547.8 10548.1 10552.4 10604.5 13437.3 13490.5 13565.9 13601.7 13627.0 5435.7 5478.2 5496.4 5536.9 5539.7 812.3 863.5 874.4 953.3 1023.4 26704.3 26962.9 30439.0 31160.7 31347.7 901.3 975.6 978.5 1045.8 1078.6 13809.4 13837.6 14014.9 14086.0 14244.8 295501.0 298328.0 298922.0 302100.0 302484.0 47297.8 47363.3 47490.3 47781.0 47821.5 1242.6 1245.5 1252.5 1257.1 1257.5 26025.2 26229.6 26627.3 26724.0 27090.2 40000.8 40542.4 40723.4 40727.2 40878.4 249282.0 249997.0 250285.0 252656.0 252789.0 29567.7 43675.0 43803.1 44250.3 44645.1 38949.4 40281.0 47054.8 48026.3 48418.8 33076.3 33194.3 33789.7 34146.3 34512.3 33666.0 33718.8 34091.8 34170.3 34210.3 33469.5 33816.5 34190.8 34221.3 34280.5 29320.6 30180.8 30922.2 31245.0 31375.2 23837.5 24005.8 24058.8 24246.9 24535.1 03:41:59 INFO - 2015-12-17 03:41:59,815 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-12-17 03:41:59,815 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25565.59 Median:344.57 stddev:78035.64 (22647.4%) stddev-sans-first:78231.56 03:41:59 INFO - 2015-12-17 03:41:59,816 DEBUG : BROWSER_OUTPUT: Values: 337.8 341.4 341.8 343.1 346.1 14915.9 14987.7 15895.2 15988.8 16569.0 14892.0 14902.4 15392.5 15409.0 15490.2 4385.3 4584.8 4590.8 4596.6 4596.8 4513.0 4519.4 4532.4 4533.1 4534.8 3204.2 3323.3 4532.1 4554.9 4989.8 5124.9 5138.5 5149.2 5158.5 5174.6 4918.6 4941.4 4967.6 5073.4 5102.7 10507.1 10656.4 10739.2 10765.2 16704.9 1732.6 1746.0 1768.2 1857.5 1908.7 8755.7 8759.5 10907.0 11364.6 12635.9 1720.3 1744.2 1749.6 1774.9 1776.1 53395.5 53787.0 53953.2 54277.2 54301.7 9999.9 10014.2 10021.4 10092.6 10108.9 12469.9 12622.7 12640.7 12682.0 12684.6 6946.2 7114.6 7173.5 7203.7 7243.5 6861.0 6863.2 6887.4 6941.3 6947.9 3984.6 4027.9 4201.9 4214.9 4308.2 1719.3 1744.5 1746.1 1766.1 1783.2 376.2 379.4 392.6 978.4 981.8 8985.7 15182.3 15616.8 15656.5 15705.0 816.0 829.3 836.1 874.1 879.6 8627.6 9232.0 9240.7 9260.0 9439.3 473037.0 473049.0 477971.0 478155.0 487565.0 66388.0 67582.7 67878.7 69326.3 69708.3 1088.1 1097.0 1097.9 1099.1 1099.9 14301.7 14424.0 14494.8 14651.8 14677.0 29162.9 29490.3 29620.0 30729.1 32164.2 41143.8 42428.0 42888.0 42895.0 43085.6 8180.2 8931.4 8977.2 9188.5 9205.4 9972.4 10025.7 10063.6 15008.7 16653.3 12606.6 13100.2 13492.3 13592.5 13706.0 12763.1 12763.6 12817.4 12909.8 13083.9 13438.9 13654.5 13661.9 13836.3 14065.9 8649.9 8744.0 8761.1 8765.6 8810.5 13897.2 13955.7 14082.4 14319.1 14335.2 03:41:59 INFO - 2015-12-17 03:41:59,816 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-12-17 03:41:59,816 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4965.05 Median:6144.76 stddev:2562.90 (41.7%) stddev-sans-first:2556.55 03:41:59 INFO - 2015-12-17 03:41:59,816 DEBUG : BROWSER_OUTPUT: Values: 1460.2 1641.9 1666.0 1703.9 1729.8 6889.9 7126.6 7182.2 7378.5 7403.6 7184.7 7301.2 7302.9 7331.3 7347.9 2079.4 2124.4 2126.0 2130.4 2132.6 2130.0 2137.4 2147.5 2148.6 2148.9 2059.7 2073.0 2112.7 2113.0 2129.1 2082.1 2086.5 2092.4 2095.4 2107.1 2056.9 2070.0 2076.3 2080.8 2091.5 6997.4 7037.7 7053.1 7060.4 7099.9 4197.2 4265.2 4284.1 4288.0 4305.0 2668.2 2718.9 2755.6 2775.5 2782.9 850.6 856.8 883.2 884.2 886.6 9310.2 9340.9 9404.0 9427.4 9451.3 3833.9 3913.6 3936.8 3942.7 3992.3 8230.5 8317.1 8356.4 8367.2 8369.0 4167.5 4175.5 4179.5 4185.6 4200.2 3826.5 3829.8 3833.4 3847.6 3851.2 3234.9 3348.8 3349.5 3365.3 3380.4 1052.3 1073.7 1076.2 1078.8 1081.5 873.3 875.1 883.8 1036.0 1160.1 6587.9 6597.0 6622.2 6635.8 6649.1 961.6 1021.6 1041.5 1062.8 1065.0 4912.7 4929.1 4956.0 4958.6 4962.5 8412.2 8843.1 8864.5 8896.4 8909.7 8628.0 8641.2 8675.2 8710.1 8752.9 6581.2 6592.2 6773.8 6820.5 6828.8 6317.6 6334.1 6346.4 6351.0 6358.7 7457.5 7621.4 7636.2 7687.6 7696.5 7789.9 7836.2 8000.4 8005.3 8012.6 5716.9 6117.6 6148.8 6165.7 6180.5 6521.6 6553.4 6568.0 6568.9 6604.7 6059.7 6085.3 6146.1 6209.9 6266.1 6005.0 6057.4 6099.4 6118.4 6210.6 6054.8 6377.7 6397.3 6411.9 6423.3 6039.2 6082.4 6087.0 6093.1 6094.9 6143.4 6158.8 6163.6 6166.1 6174.1 03:41:59 INFO - 2015-12-17 03:41:59,817 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-12-17 03:41:59,817 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4883.45 Median:5643.30 stddev:1469.85 (26.0%) stddev-sans-first:1433.15 03:41:59 INFO - 2015-12-17 03:41:59,817 DEBUG : BROWSER_OUTPUT: Values: 300.1 306.5 311.0 314.2 318.1 5564.9 5708.6 5720.4 5748.8 5749.0 5511.1 5588.5 5590.9 5603.5 5614.8 4154.8 4287.2 4351.7 4354.4 4356.4 4274.9 4276.3 4293.1 4295.6 4302.7 4225.1 4250.4 4252.1 4254.6 4258.1 4247.1 4250.2 4254.1 4254.3 4257.9 3610.7 3688.2 3689.4 3693.8 3695.6 5254.8 5399.5 5407.0 5408.5 5413.4 4882.9 4887.1 4890.1 4890.3 4901.2 5860.7 5870.0 5882.0 5896.5 5907.6 3877.6 3981.6 3981.6 3984.2 3987.9 6125.1 6207.2 6207.5 6209.6 6209.7 4131.6 4148.6 4162.2 4162.6 4163.6 4213.7 4215.5 4218.6 4222.2 4235.2 4680.0 4688.9 4873.1 4882.7 4890.6 5900.4 5901.5 5904.6 5917.0 5917.2 1457.2 1475.7 1483.8 1487.3 1490.3 951.6 953.3 954.5 960.6 991.6 5086.3 5132.6 5150.7 5151.2 5153.1 6132.5 6146.4 6149.2 6156.6 6163.0 5118.2 5139.6 5146.4 5146.9 5149.5 3234.5 3280.2 3305.5 3332.2 3340.4 5845.4 5866.2 5872.9 5887.4 5889.0 6336.7 6368.7 6380.2 6392.3 6418.0 5682.3 5793.4 5807.6 5811.9 5886.1 6206.7 6209.3 6209.4 6232.3 6237.9 6045.7 6053.4 6056.9 6066.8 6082.7 5758.5 5851.6 5862.0 5865.1 5884.6 4114.4 4182.9 4184.1 4190.3 4192.7 5888.4 6078.7 6182.8 6200.1 6204.3 5747.9 5930.9 5932.3 5936.1 5941.8 5923.1 5925.6 5930.0 5955.1 5958.6 5671.8 5818.4 5821.6 5822.7 5838.3 5925.2 5931.1 5974.5 5989.5 6001.6 5828.2 5836.4 5837.8 5855.1 5855.8 03:41:59 INFO - 2015-12-17 03:41:59,817 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-12-17 03:41:59,817 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11595.47 Median:536.10 stddev:13330.29 (2486.5%) stddev-sans-first:13341.95 03:41:59 INFO - 2015-12-17 03:41:59,818 DEBUG : BROWSER_OUTPUT: Values: 566.6 635.7 637.2 656.5 659.9 10481.5 10698.3 10756.3 10803.2 10864.3 10148.0 10178.6 10196.4 10207.0 10470.0 803.8 807.4 813.8 819.6 822.0 803.6 803.6 807.0 810.5 815.1 848.8 851.1 856.5 857.5 858.8 838.9 842.9 843.6 846.5 849.1 627.7 629.5 630.2 631.4 633.0 10927.7 10951.8 10952.2 10993.4 11047.8 10771.9 10808.9 11069.0 11181.3 11609.3 8813.2 9072.5 9426.5 9432.6 9755.9 3041.9 3070.4 3085.6 3091.5 3117.2 40891.2 40953.6 41162.0 41195.4 41365.0 8051.2 8152.0 8418.6 8619.4 8628.4 14184.9 14189.1 14201.6 14212.2 14220.9 5919.5 5930.0 5947.6 6105.1 6110.4 3486.3 3492.8 3507.8 3542.8 3581.1 2355.5 2365.6 2374.0 2380.0 2392.8 465.5 465.6 468.8 473.0 473.6 427.8 585.7 596.1 598.3 599.2 7636.8 7669.9 7696.2 7795.5 7932.4 466.4 500.8 505.6 505.6 600.6 3585.9 3599.9 3634.7 3710.2 3769.3 46425.8 46724.0 46891.0 46943.5 47220.5 42857.0 43286.0 43419.0 43829.3 43878.6 39360.4 39575.8 39667.0 39810.8 40045.8 7337.3 7363.3 7506.3 7588.5 7607.4 29972.1 30506.4 30550.4 31073.2 31445.2 33950.5 34056.0 36894.3 36998.3 37278.0 8976.2 9126.1 9139.4 9316.0 9358.2 10161.8 10226.3 10307.8 10341.2 10343.4 9284.8 9596.9 9944.0 9998.5 10007.5 9151.5 9575.6 9590.8 9717.4 9734.1 8982.4 9182.6 9271.4 9320.6 9441.3 8145.9 8465.7 8552.8 8681.3 8838.0 8187.5 8194.5 8342.2 8366.2 8620.0 03:41:59 INFO - 2015-12-17 03:41:59,819 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:41:59 INFO - 2015-12-17 03:41:59,819 DEBUG : BROWSER_OUTPUT: 03:42:00 INFO - 2015-12-17 03:42:00,553 INFO : Browser exited with error code: 0 03:42:00 INFO - 2015-12-17 03:42:00,572 INFO : Completed test dromaeo_css (00:18:34) 03:42:00 INFO - 2015-12-17 03:42:00,572 INFO : Starting test kraken 03:42:00 INFO - 2015-12-17 03:42:00,572 DEBUG : operating with platform_type : linux_ 03:42:00 INFO - 2015-12-17 03:42:00,573 INFO : Initialising browser for kraken test... 03:42:00 INFO - 2015-12-17 03:42:00,579 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSMQz2N/profile http://localhost:35343/getInfo.html 03:42:05 INFO - 2015-12-17 03:42:05,143 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:42:05 INFO - 2015-12-17 03:42:05,143 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:42:05 INFO - 2015-12-17 03:42:05,143 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:42:05 INFO - 2015-12-17 03:42:05,144 DEBUG : BROWSER_OUTPUT: __metrics 03:42:05 INFO - 2015-12-17 03:42:05,273 DEBUG : BROWSER_OUTPUT: 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:42:06 INFO - 2015-12-17 03:42:06,141 INFO : Browser initialized. 03:42:06 INFO - 2015-12-17 03:42:06,142 INFO : Running cycle 1/1 for kraken test... 03:42:06 INFO - 2015-12-17 03:42:06,142 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSMQz2N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:42:18 INFO - 2015-12-17 03:42:18,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 143458304 03:42:18 INFO - 2015-12-17 03:42:18,161 DEBUG : BROWSER_OUTPUT: 03:42:20 INFO - 2015-12-17 03:42:20,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35343/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:21 INFO - 2015-12-17 03:42:21,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 143609856 03:42:21 INFO - 2015-12-17 03:42:21,363 DEBUG : BROWSER_OUTPUT: 03:42:24 INFO - 2015-12-17 03:42:24,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35343/tests/kraken/driver.html?testName=audio-dft) 03:42:24 INFO - 2015-12-17 03:42:24,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 143671296 03:42:24 INFO - 2015-12-17 03:42:24,702 DEBUG : BROWSER_OUTPUT: 03:42:27 INFO - 2015-12-17 03:42:27,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35343/tests/kraken/driver.html?testName=audio-fft) 03:42:28 INFO - 2015-12-17 03:42:28,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 138641408 03:42:28 INFO - 2015-12-17 03:42:28,219 DEBUG : BROWSER_OUTPUT: 03:42:30 INFO - 2015-12-17 03:42:30,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35343/tests/kraken/driver.html?testName=audio-oscillator) 03:42:30 INFO - 2015-12-17 03:42:30,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 138452992 03:42:30 INFO - 2015-12-17 03:42:30,912 DEBUG : BROWSER_OUTPUT: 03:42:33 INFO - 2015-12-17 03:42:33,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:33 INFO - 2015-12-17 03:42:33,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 138477568 03:42:33 INFO - 2015-12-17 03:42:33,767 DEBUG : BROWSER_OUTPUT: 03:42:36 INFO - 2015-12-17 03:42:36,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35343/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:37 INFO - 2015-12-17 03:42:37,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 139395072 03:42:37 INFO - 2015-12-17 03:42:37,443 DEBUG : BROWSER_OUTPUT: 03:42:40 INFO - 2015-12-17 03:42:40,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35343/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:41 INFO - 2015-12-17 03:42:41,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 138084352 03:42:41 INFO - 2015-12-17 03:42:41,524 DEBUG : BROWSER_OUTPUT: 03:42:44 INFO - 2015-12-17 03:42:44,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35343/tests/kraken/driver.html?testName=json-parse-financial) 03:42:44 INFO - 2015-12-17 03:42:44,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 138842112 03:42:44 INFO - 2015-12-17 03:42:44,991 DEBUG : BROWSER_OUTPUT: 03:42:46 INFO - 2015-12-17 03:42:46,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:47 INFO - 2015-12-17 03:42:47,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 140722176 03:42:47 INFO - 2015-12-17 03:42:47,347 DEBUG : BROWSER_OUTPUT: 03:42:49 INFO - 2015-12-17 03:42:49,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35343/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:49 INFO - 2015-12-17 03:42:49,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 139816960 03:42:49 INFO - 2015-12-17 03:42:49,857 DEBUG : BROWSER_OUTPUT: 03:42:52 INFO - 2015-12-17 03:42:52,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:52 INFO - 2015-12-17 03:42:52,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 141443072 03:42:52 INFO - 2015-12-17 03:42:52,640 DEBUG : BROWSER_OUTPUT: 03:42:55 INFO - 2015-12-17 03:42:55,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:55 INFO - 2015-12-17 03:42:55,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 139988992 03:42:55 INFO - 2015-12-17 03:42:55,844 DEBUG : BROWSER_OUTPUT: 03:42:58 INFO - 2015-12-17 03:42:58,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:59 INFO - 2015-12-17 03:42:59,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 141651968 03:42:59 INFO - 2015-12-17 03:42:59,081 DEBUG : BROWSER_OUTPUT: 03:43:00 INFO - 2015-12-17 03:43:00,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35343/tests/kraken/driver.html?testName=ai-astar) 03:43:01 INFO - 2015-12-17 03:43:01,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 140398592 03:43:01 INFO - 2015-12-17 03:43:01,093 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,093 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:43:01 INFO - 2015-12-17 03:43:01,093 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:43:01 INFO - 2015-12-17 03:43:01,093 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:43:01 INFO - 2015-12-17 03:43:01,093 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:43:01 INFO - 2015-12-17 03:43:01,093 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;107;115;115;117;127;114;114;115;115 03:43:01 INFO - 2015-12-17 03:43:01,093 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;134;154;163;132;160;157;133;169;130 03:43:01 INFO - 2015-12-17 03:43:01,093 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;165;165;164;165;165;178;161;166;163 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;73;74;146;76;72;74;74;91 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;96;134;95;95;95;139;96;96;134 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;112;110;110;111;111;110;110;110 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;147;149;148;147;147;149;150 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;97;96;96;97;96;96;96 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;74;77;75;76;74;74;74;74;76 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;70;68;68;68;68;68;70;69 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;88;88;88;87;88;87;85;96 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;126;132;129;134;127;124;125;129;130 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;153;153;152;154;137;163;150;152;144 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;74;72;70;70;72;77;70;73 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:43:01 INFO - 2015-12-17 03:43:01,094 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:43:01 INFO - 2015-12-17 03:43:01,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,792 03:43:01 INFO - 2015-12-17 03:43:01,095 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:43:01 INFO - 2015-12-17 03:43:01,095 DEBUG : BROWSER_OUTPUT: __startTimestamp1450352581088__endTimestamp 03:43:01 INFO - 2015-12-17 03:43:01,095 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,096 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:43:01 INFO - 2015-12-17 03:43:01,096 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:43:01 INFO - 2015-12-17 03:43:01,096 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,096 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:4.86 (4.2%) stddev-sans-first:5.15 03:43:01 INFO - 2015-12-17 03:43:01,096 DEBUG : BROWSER_OUTPUT: Values: 115.0 107.0 115.0 115.0 117.0 127.0 114.0 114.0 115.0 115.0 03:43:01 INFO - 2015-12-17 03:43:01,096 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,096 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.50 Median:155.50 stddev:14.72 (9.5%) stddev-sans-first:15.52 03:43:01 INFO - 2015-12-17 03:43:01,097 DEBUG : BROWSER_OUTPUT: Values: 153.0 134.0 154.0 163.0 132.0 160.0 157.0 133.0 169.0 130.0 03:43:01 INFO - 2015-12-17 03:43:01,097 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,097 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.70 Median:165.00 stddev:4.55 (2.8%) stddev-sans-first:4.82 03:43:01 INFO - 2015-12-17 03:43:01,097 DEBUG : BROWSER_OUTPUT: Values: 165.0 165.0 165.0 164.0 165.0 165.0 178.0 161.0 166.0 163.0 03:43:01 INFO - 2015-12-17 03:43:01,097 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,097 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.50 Median:74.00 stddev:23.01 (31.1%) stddev-sans-first:24.09 03:43:01 INFO - 2015-12-17 03:43:01,098 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 73.0 74.0 146.0 76.0 72.0 74.0 74.0 91.0 03:43:01 INFO - 2015-12-17 03:43:01,098 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,098 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.70 Median:95.50 stddev:19.36 (20.3%) stddev-sans-first:20.14 03:43:01 INFO - 2015-12-17 03:43:01,098 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 134.0 95.0 95.0 95.0 139.0 96.0 96.0 134.0 03:43:01 INFO - 2015-12-17 03:43:01,098 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 112.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 147.0 149.0 148.0 147.0 147.0 149.0 150.0 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.90 Median:75.00 stddev:1.10 (1.5%) stddev-sans-first:1.17 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 77.0 75.0 76.0 74.0 74.0 74.0 74.0 76.0 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 70.0 68.0 68.0 68.0 68.0 68.0 70.0 69.0 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,099 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.00 stddev:3.20 (3.6%) stddev-sans-first:3.24 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 88.0 88.0 88.0 87.0 88.0 87.0 85.0 96.0 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:129.50 stddev:3.13 (2.4%) stddev-sans-first:3.28 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: Values: 130.0 126.0 132.0 129.0 134.0 127.0 124.0 125.0 129.0 130.0 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:152.50 stddev:7.88 (5.2%) stddev-sans-first:7.15 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: Values: 138.0 153.0 153.0 152.0 154.0 137.0 163.0 150.0 152.0 144.0 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:2.18 (3.0%) stddev-sans-first:2.28 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 74.0 72.0 70.0 70.0 72.0 77.0 70.0 73.0 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:43:01 INFO - 2015-12-17 03:43:01,100 DEBUG : BROWSER_OUTPUT: 03:43:02 INFO - 2015-12-17 03:43:02,013 INFO : Browser exited with error code: 0 03:43:02 INFO - 2015-12-17 03:43:02,079 INFO : Completed test kraken (00:01:01) 03:43:02 INFO - 2015-12-17 03:43:02,079 INFO : Starting test v8_7 03:43:02 INFO - 2015-12-17 03:43:02,079 DEBUG : operating with platform_type : linux_ 03:43:02 INFO - 2015-12-17 03:43:02,079 INFO : Initialising browser for v8_7 test... 03:43:02 INFO - 2015-12-17 03:43:02,085 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHGk8In/profile http://localhost:35343/getInfo.html 03:43:06 INFO - 2015-12-17 03:43:06,706 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:43:06 INFO - 2015-12-17 03:43:06,706 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:43:06 INFO - 2015-12-17 03:43:06,706 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:43:06 INFO - 2015-12-17 03:43:06,706 DEBUG : BROWSER_OUTPUT: __metrics 03:43:06 INFO - 2015-12-17 03:43:06,868 DEBUG : BROWSER_OUTPUT: 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:43:07 INFO - 2015-12-17 03:43:07,789 INFO : Browser initialized. 03:43:07 INFO - 2015-12-17 03:43:07,790 INFO : Running cycle 1/1 for v8_7 test... 03:43:07 INFO - 2015-12-17 03:43:07,790 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHGk8In/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:43:19 INFO - 2015-12-17 03:43:19,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 143384576 03:43:19 INFO - 2015-12-17 03:43:19,827 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35343/tests/v8_7/run.html (next: http://localhost:35343/tests/v8_7/run.html) 03:43:41 INFO - 2015-12-17 03:43:41,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 138067968 03:43:41 INFO - 2015-12-17 03:43:41,476 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,476 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:43:41 INFO - 2015-12-17 03:43:41,477 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:43:41 INFO - 2015-12-17 03:43:41,477 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:43:41 INFO - 2015-12-17 03:43:41,477 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:43:41 INFO - 2015-12-17 03:43:41,477 DEBUG : BROWSER_OUTPUT: |0;Richards;165.12549537648613 03:43:41 INFO - 2015-12-17 03:43:41,477 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.5341888527102 03:43:41 INFO - 2015-12-17 03:43:41,478 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 03:43:41 INFO - 2015-12-17 03:43:41,478 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 03:43:41 INFO - 2015-12-17 03:43:41,478 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1082.2510822510822 03:43:41 INFO - 2015-12-17 03:43:41,478 DEBUG : BROWSER_OUTPUT: |5;Earley;712.2507122507122 03:43:41 INFO - 2015-12-17 03:43:41,478 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 03:43:41 INFO - 2015-12-17 03:43:41,478 DEBUG : BROWSER_OUTPUT: |7;RegExp;26447.36842105263 03:43:41 INFO - 2015-12-17 03:43:41,478 DEBUG : BROWSER_OUTPUT: |8;Splay;592.0663114268798 03:43:41 INFO - 2015-12-17 03:43:41,478 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 03:43:41 INFO - 2015-12-17 03:43:41,478 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:43:41 INFO - 2015-12-17 03:43:41,478 DEBUG : BROWSER_OUTPUT: __startTimestamp1450352621473__endTimestamp 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.13 Median:165.13 stddev:0.00 (0.0%) 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: Values: 165.1 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.53 Median:191.53 stddev:0.00 (0.0%) 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: Values: 191.5 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: Values: 278.6 03:43:41 INFO - 2015-12-17 03:43:41,479 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: Values: 5143.6 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1082.25 Median:1082.25 stddev:0.00 (0.0%) 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: Values: 1082.3 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:712.25 Median:712.25 stddev:0.00 (0.0%) 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: Values: 712.3 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: Values: 12195.1 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26447.37 Median:26447.37 stddev:0.00 (0.0%) 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: Values: 26447.4 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,480 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:592.07 Median:592.07 stddev:0.00 (0.0%) 03:43:41 INFO - 2015-12-17 03:43:41,481 DEBUG : BROWSER_OUTPUT: Values: 592.1 03:43:41 INFO - 2015-12-17 03:43:41,481 DEBUG : BROWSER_OUTPUT: 03:43:41 INFO - 2015-12-17 03:43:41,481 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 03:43:41 INFO - 2015-12-17 03:43:41,481 DEBUG : BROWSER_OUTPUT: Values: 4854.4 03:43:41 INFO - 2015-12-17 03:43:41,481 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:43:41 INFO - 2015-12-17 03:43:41,481 DEBUG : BROWSER_OUTPUT: 03:43:42 INFO - 2015-12-17 03:43:42,402 INFO : Browser exited with error code: 0 03:43:42 INFO - 2015-12-17 03:43:42,414 INFO : Completed test v8_7 (00:00:40) 03:43:42 INFO - 2015-12-17 03:43:42,497 INFO : Completed test suite (00:20:16) 03:43:42 INFO - 2015-12-17 03:43:42,497 DEBUG : Working with test: dromaeo_css 03:43:42 INFO - 2015-12-17 03:43:42,497 DEBUG : Generating results file: dromaeo_css 03:43:42 INFO - 2015-12-17 03:43:42,499 DEBUG : Working with test: kraken 03:43:42 INFO - 2015-12-17 03:43:42,499 DEBUG : Generating results file: kraken 03:43:42 INFO - 2015-12-17 03:43:42,499 INFO : javascript benchmark 03:43:42 INFO - 2015-12-17 03:43:42,500 DEBUG : Working with test: v8_7 03:43:42 INFO - 2015-12-17 03:43:42,500 DEBUG : Generating results file: v8_7 03:43:42 INFO - 2015-12-17 03:43:42,500 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:42 INFO - 2015-12-17 03:43:42,552 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 03:43:42 INFO - 2015-12-17 03:43:42,552 DEBUG : process_Request line: dromaeo_css 6266.01 graph.html#tests=[[72,132,43]] 03:43:42 INFO - 2015-12-17 03:43:42,552 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:42 INFO - 2015-12-17 03:43:42,592 DEBUG : process_Request line: kraken 1556.10 graph.html#tests=[[232,132,43]] 03:43:42 INFO - 2015-12-17 03:43:42,593 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:42 INFO - 2015-12-17 03:43:42,702 DEBUG : process_Request line: v8_7 21303.92 graph.html#tests=[[230,132,43]] 03:43:42 INFO - 2015-12-17 03:43:42,703 INFO : javascript benchmark 03:43:42 INFO - 2015-12-17 03:43:42,707 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2673.7459941305574, 2711.4170453352526, 2750.834949903006, 2754.752072313491, 2769.169249225232, 4686.461056978448, 4820.915294058839, 4824.565789078983, 4881.560659540645, 4890.388701412324, 4738.123447162277, 4759.500252473493, 4772.403449568804, 4803.903921921559, 4934.309196712463, 4406.228909940755, 4467.620252278561, 4537.70504917181, 4539.341795439659, 4566.611837993774, 495.1517980821479, 4414.073044660625, 4466.977665111686, 4531.365608814768, 4543.840965566206, 4437.090396468732, 4461.955380446187, 4463.620592249663, 4464.374987501752, 4517.480489743656, 4470.240059189946, 4483.3947417098925, 4502.527234640348, 4503.324501324795, 4535.637149028103, 4281.957180428187, 4384.912301753979, 4385.56144385562, 4432.889177770581, 4467.6425885929375, 4712.929306060412, 4773.140834649762, 4776.641751868589, 4785.1024208566105, 4805.279208118775, 4940.209566469348, 5214.5306922376785, 5224.190250511177, 5224.555912747421, 5280.260763493114, 5015.924761128586, 5112.642115051948, 5114.795408183668, 5157.200633901752, 5163.561097306733, 4774.140654682191, 4820.180569303227, 4825.30033145199, 4829.806807727722, 4884.511548845158, 5029.597632189416, 5191.922121168185, 5328.200769884548, 5333.653312534673, 5341.465853414627, 4988.825391111366, 4997.7251251180805, 5008.373953255843, 5013.774380152902, 5014.247862820606, 5074.314967479343, 5134.666246694028, 5242.606804489602, 5246.055709972242, 5304.469553044664, 5113.309703190096, 5128.871778205575, 5160.48395160481, 5161.793528258828, 5205.73971301441, 4841.878953026132, 4958.57852082577, 5096.821611243588, 5109.923351149661, 5116.539511443988, 4258.446401967786, 4338.696291259645, 4338.934915976263, 4380.7371557706, 4393.846215382447, 3785.5835858055593, 3790.639889210521, 3792.7724336539895, 3818.5990471000146, 3831.214601006787, 4269.316909294498, 4366.781660916941, 4370.672199585044, 4530.79611417487, 4543.522930092358, 5077.39071311445, 5131.897362052738, 5144.099782538041, 5157.922631160535, 5186.066508028591, 4446.599806017474, 4462.419885414875, 4464.129494748493, 4474.306482495218, 4502.279635258343, 4378.868633940987, 4472.753998530047, 4556.997460558672, 4563.110193512233, 4588.220002599566, 4824.831130910401, 4836.419629644465, 4846.5638092571835, 4957.058158949788, 4964.528369804862, 5143.665661731976, 5145.305383773292, 5147.796904729867, 5155.226715992481, 5159.071367153948, 4865.270209468466, 4865.343178670834, 4867.318575399518, 4881.096997055556, 4924.384451943507, 4886.609071274361, 4975.303457515878, 4998.475160108136, 5046.949530504648, 5085.110105731556, 5255.737213139404, 5261.079311120615, 5261.89476210466, 5278.683279003272, 5312.468753124656, 4769.165396055746, 5012.072766538202, 5055.51972562606, 5062.696238225718, 5078.619103567321, 4917.262410638433, 4933.55597996182, 5013.548780609763, 5021.196608542616, 5070.873228169177, 4894.779734911866, 4901.558859702502, 4931.901361972812, 4931.901361972812, 4991.326170967018, 4732.384789977418, 4933.383327084114, 5065.544101030925, 5068.315777370155, 5113.028524580318, 4832.95167048325, 4877.341558889504, 4913.70517768935, 4917.311576379238, 4954.430240522242], "unit": "score", "name": "dojo.html", "value": 4695.943668766677}, {"lowerIsBetter": false, "replicates": [554.9456033536281, 560.6720068759776, 567.4013915319338, 569.345252959097, 574.0499473371572, 35996.0, 37013.44479832801, 37015.25969480609, 37115.62884371156, 37156.07109822256, 41081.79459102708, 41516.792416037955, 41570.58429415705, 41600.58399416005, 41741.16517669645, 7934.365250779938, 8117.8782318264975, 8134.877976830352, 8144.6742130315015, 8163.551004694739, 7858.960705196495, 7950.443468957175, 7976.641051152712, 7985.201479852027, 7995.6801727930815, 7919.326857217144, 8015.198480151997, 8036.196380361976, 8037.95981020094, 8046.919530804705, 7985.0, 8039.437239393244, 8045.115037345888, 8061.516309021448, 8062.355011599058, 7882.330001949841, 8015.7595272141925, 8015.998000249969, 8023.197680231989, 8041.437099403044, 37203.25593488115, 37254.441183382274, 37465.62534374676, 37711.245775084346, 37728.62271377306, 2820.1680504251294, 2893.059755579445, 2953.438846619157, 2954.807937484078, 3479.443289073761, 27832.16503504898, 28148.15555533337, 28400.0, 28590.0, 29048.709512905025, 3241.308487621993, 3292.3615020901, 3317.170707323169, 3329.96670033299, 3356.127406874206, 204021.0, 204818.0, 205173.0, 205469.0, 206792.9999999985, 38353.0, 38918.22163556713, 39189.80405097956, 39229.0, 55160.0, 36129.819350903075, 36411.27177456436, 36503.634963650555, 36621.08447288786, 36715.63284367122, 12457.06572007103, 12546.0, 12587.363642726386, 12592.307423091817, 12629.747405051847, 10474.947625261977, 10547.84178237327, 10548.103411210133, 10552.366857988392, 10604.469776511143, 13437.32813359328, 13490.52783152585, 13565.864341356657, 13601.727965440834, 13627.0, 5435.728213589305, 5478.150886612581, 5496.367917689437, 5536.861578460571, 5539.723013849291, 812.321711371, 863.5164307987548, 874.3879284500874, 953.3136141977765, 1023.3910823060268, 26704.332391689975, 26962.865185673945, 30439.0, 31160.68839311578, 31347.686523134933, 901.324006994754, 975.6146322202691, 978.4667356290838, 1045.8326667733127, 1078.6278733836814, 13809.378577964017, 13837.584872453843, 14014.929925350309, 14086.013979021574, 14244.786328205086, 295501.0, 298328.0, 298922.0, 302100.0, 302484.0, 47297.763511182915, 47363.289550656766, 47490.28764568534, 47781.0, 47821.5217847824, 1242.6334231401759, 1245.5266998540678, 1252.4614415801293, 1257.1388598809845, 1257.4530079415483, 26025.21924342273, 26229.606555902057, 26627.33431664224, 26724.0, 27090.1872943812, 40000.799995999834, 40542.39186412265, 40723.38914916338, 40727.1854562913, 40878.38682419706, 249282.0, 249997.0, 250285.0, 252656.0, 252789.0, 29567.704322956495, 43675.0, 43803.12393752171, 44250.336244957, 44645.10709785721, 38949.415758763076, 40281.0, 47054.76472617752, 48026.27960580664, 48418.757906210245, 33076.338473230884, 33194.336113278085, 33789.66210337865, 34146.31707365789, 34512.30975380528, 33666.0, 33718.8314058438, 34091.82954085214, 34170.31659366848, 34210.31579368449, 33469.49795753017, 33816.49275260922, 34190.82904585561, 34221.31557368889, 34280.48579271263, 29320.560191596716, 30180.84909575438, 30922.226944326572, 31245.0, 31375.215619608778, 23837.4672815655, 24005.75994240105, 24058.75941240635, 24246.878765606765, 24535.14127005546], "unit": "score", "name": "ext.html", "value": 16631.432646678386}, {"lowerIsBetter": false, "replicates": [337.7956336416468, 341.3548393536217, 341.7675980333372, 343.06172617890064, 346.07425137756496, 14915.850841491581, 14987.700245995073, 15895.205239738025, 15988.76016859748, 16569.0, 14892.0, 14902.403903843833, 15392.538223853275, 15409.0, 15490.225488725548, 4385.254506733863, 4584.770761461914, 4590.770461476929, 4596.6092882104895, 4596.793144308497, 4512.97743511282, 4519.435070616173, 4532.410786597738, 4533.070720502289, 4534.773261336936, 3204.150900011499, 3323.2854936188714, 4532.070925460289, 4554.931676024862, 4989.800407983676, 5124.8975020499565, 5138.460461651547, 5149.201873709581, 5158.509941555546, 5174.611904107188, 4918.631102667278, 4941.431735350445, 4967.627427942919, 5073.39119305682, 5102.668326558799, 10507.106895913856, 10656.413897235649, 10739.194560407923, 10765.246432749711, 16704.916475417667, 1732.6274850907116, 1746.0309528211965, 1768.1689605885213, 1857.5263307856546, 1908.6564418404682, 8755.693550725695, 8759.51822649754, 10907.018368346808, 11364.602238921681, 12635.936820315932, 1720.2602880761267, 1744.2325376834278, 1749.5801007758046, 1774.8846324988835, 1776.1474492243794, 53395.46604533944, 53787.0, 53953.1907021395, 54277.1858422124, 54301.72849135729, 9999.850002249972, 10014.198864090855, 10021.39871607706, 10092.596296148218, 10108.938561450941, 12469.937650311691, 12622.684432889251, 12640.6839829005, 12682.048846336562, 12684.556040538537, 6946.235914049451, 7114.648216838784, 7173.5337203081635, 7203.71185152588, 7243.456740744466, 6860.965695171492, 6863.210730765926, 6887.449004079662, 6941.271166527543, 6947.930520694829, 3984.5816189300285, 4027.9194416111513, 4201.915961680749, 4214.873553793391, 4308.159908817751, 1719.2950890134985, 1744.5028166972352, 1746.0571291502447, 1766.0816375484676, 1783.2153852304943, 376.21183620315395, 379.3778203745859, 392.6387723294576, 978.3885071830106, 981.8281800684852, 8985.685501007434, 15182.316795744218, 15616.843831561766, 15656.530304090895, 15705.0, 816.0452270843127, 829.3489610655727, 836.0844874862016, 874.1477059866579, 879.6173664455982, 8627.568621568897, 9231.953840230755, 9240.676576319931, 9259.953700231456, 9439.292053095907, 473037.0, 473049.0, 477971.0, 478155.0, 487565.0, 66388.0, 67582.66208668925, 67878.66060669665, 69326.30673693199, 69708.30291697018, 1088.080571916745, 1097.0400899213348, 1097.8792332843382, 1099.0932480703452, 1099.8790133085354, 14301.713965720835, 14424.0, 14494.782578261545, 14651.780223296446, 14677.0, 29162.854185728935, 29490.262743431587, 29620.0, 30729.078127656205, 32164.19589510281, 41143.7942810284, 42428.0, 42888.0, 42895.0, 43085.56914430941, 8180.181981801772, 8931.374803763674, 8977.23693486061, 9188.540572971191, 9205.447673139633, 9972.351797133164, 10025.749356266151, 10063.597456101674, 15008.6998260032, 16653.25060372262, 12606.621801345975, 13100.213987160801, 13492.257925814174, 13592.524261650795, 13706.0, 12763.106582539505, 12763.617091487271, 12817.42321595549, 12909.806352904527, 13083.934580327037, 13438.932805335911, 13654.522091726742, 13661.86338136606, 13836.308184590931, 14065.929670351583, 8649.870251946351, 8744.0, 8761.123887611187, 8765.605547750494, 8810.471371717718, 13897.16617002983, 13955.720885582434, 14082.436702532194, 14319.140851548524, 14335.211563364115], "unit": "score", "name": "jquery.html", "value": 7943.726737382744}, {"lowerIsBetter": false, "replicates": [1460.247972294268, 1641.9261133249004, 1665.983340166598, 1703.906285154316, 1729.835665611767, 6889.931100688992, 7126.608036557987, 7182.209956904743, 7378.5203961742445, 7403.555786652798, 7184.712611495534, 7301.1968683444775, 7302.890456643155, 7331.303526165006, 7347.88978165328, 2079.428157256755, 2124.4370241885913, 2126.00077963357, 2130.38218916514, 2132.605467988419, 2129.957400851982, 2137.3908436095717, 2147.527543940331, 2148.602508535926, 2148.881811500367, 2059.6910463430454, 2072.968905466419, 2112.6936594193835, 2113.049127892447, 2129.105775574255, 2082.052666036957, 2086.531751570136, 2092.3618296419586, 2095.434232757147, 2107.104480595741, 2056.92800751973, 2070.037432593851, 2076.262926661044, 2080.833533317331, 2091.5398612305266, 6997.370236678723, 7037.718491260343, 7053.0830991971225, 7060.364567188978, 7099.858002839966, 4197.223513649985, 4265.232258193524, 4284.100338928829, 4288.035192081757, 4304.978475107636, 2668.21287720123, 2718.8504632245217, 2755.641766570353, 2775.4587855368213, 2782.874770635326, 850.6427300533791, 856.7686724584389, 883.2007033634571, 884.2483888694622, 886.5655828643983, 9310.162085412278, 9340.906590934072, 9404.0, 9427.434353938786, 9451.33840631156, 3833.865814696472, 3913.6477717005037, 3936.7834769087403, 3942.6845852331744, 3992.261431635157, 8230.506169629842, 8317.126701696236, 8356.415050946376, 8367.163283671705, 8368.995720513578, 4167.499900012018, 4175.478065241845, 4179.498460184797, 4185.581441855851, 4200.243956087934, 3826.4642949987024, 3829.770213787126, 3833.4058220975794, 3847.615238476186, 3851.1912498375095, 3234.8706051758136, 3348.8325583720716, 3349.531065650811, 3365.2932884094125, 3380.428100933078, 1052.2791887557048, 1073.6778966310076, 1076.155218153761, 1078.8381742738652, 1081.5295346524288, 873.2926329672858, 875.1292463998235, 883.8143989762093, 1035.9692106354225, 1160.14729174057, 6587.868242635121, 6597.0, 6622.1722284714415, 6635.834104147435, 6649.135612370361, 961.5769061612868, 1021.5913634546241, 1041.5000799616075, 1062.7608788022633, 1065.0148612533376, 4912.70523768575, 4929.088118698052, 4956.033573453142, 4958.628102892298, 4962.478939711278, 8412.158784121539, 8843.115688431235, 8864.512451815212, 8896.377253592187, 8909.688160914466, 8627.956860215785, 8641.179087986631, 8675.219230269306, 8710.085441028728, 8752.8687069694, 6581.2102547694585, 6592.208934927743, 6773.796786096524, 6820.522563420513, 6828.795136145924, 6317.557770955989, 6334.113224148715, 6346.365363463617, 6351.0, 6358.745650173942, 7457.47797654159, 7621.3902887769955, 7636.160022397421, 7687.615619219128, 7696.499727517694, 7789.922100779147, 7836.177201393772, 8000.439969202333, 8005.279524842792, 8012.639431225492, 5716.9142462862255, 6117.602355846856, 6148.78479253224, 6165.691715414301, 6180.4746596538, 6521.608703477807, 6553.377429144223, 6568.047633093271, 6568.868622627616, 6604.669766511559, 6059.72731227087, 6085.3306136325855, 6146.139540464249, 6209.937900621117, 6266.060090986389, 6004.969975150097, 6057.394260573908, 6099.3900609938655, 6118.388161183846, 6210.596311239755, 6054.848628784315, 6377.74489020434, 6397.264314603694, 6411.871762564816, 6423.325550817097, 6039.184710064085, 6082.36135205797, 6087.0, 6093.05557638549, 6094.878102437838, 6143.385661433999, 6158.753649853956, 6163.630182189083, 6166.136740856374, 6174.073888916699], "unit": "score", "name": "mootools.html", "value": 4086.958248910751}, {"lowerIsBetter": false, "replicates": [300.10269294808523, 306.50040434092426, 311.0450915688835, 314.23170348497905, 318.09184777460365, 5564.888702225958, 5708.600397972144, 5720.399358067405, 5748.798792042279, 5749.022666146755, 5511.063119269724, 5588.497035266825, 5590.91613625796, 5603.523700485463, 5614.775408983646, 4154.771487568182, 4287.164003019412, 4351.6953813233085, 4354.412154359153, 4356.433663623732, 4274.935875961863, 4276.25165596021, 4293.098449325646, 4295.591918767712, 4302.677299202556, 4225.112726327475, 4250.362445633149, 4252.064545799919, 4254.595813397737, 4258.105797782469, 4247.108107297456, 4250.192463431938, 4254.149170165979, 4254.255505286563, 4257.87226383209, 3610.7291953103622, 3688.188598508324, 3689.4465830125696, 3693.7968411737343, 3695.61196074411, 5254.789808407659, 5399.541039011689, 5406.972965135188, 5408.45915408456, 5413.404525502192, 4882.902341953177, 4887.120318342697, 4890.070886531547, 4890.315355850184, 4901.240307752304, 5860.677662728548, 5870.002099643071, 5882.0, 5896.528277737771, 5907.645541267538, 3877.6316249956208, 3981.581933896928, 3981.601839816024, 3984.2230765000836, 3987.900302492432, 6125.111858780497, 6207.193064901579, 6207.4723648489935, 6209.59637623553, 6209.658468784215, 4131.648809851196, 4148.605882441163, 4162.167566486714, 4162.583741625874, 4163.5836416358725, 4213.726107802983, 4215.451991241119, 4218.578142185757, 4222.239996800544, 4235.1953128906025, 4679.9532004680195, 4688.906221875543, 4873.122837889143, 4882.7314497702255, 4890.559849613552, 5900.380460051632, 5901.498372638288, 5904.645721256738, 5916.970415147896, 5917.171595976567, 1457.205822826562, 1475.7417451945867, 1483.777433385001, 1487.256371814093, 1490.299559207171, 951.6336210558985, 953.2564599612314, 954.4511905654276, 960.558143254097, 991.5587563534158, 5086.338775959101, 5132.589392848563, 5150.742462876841, 5151.175811870083, 5153.098207813618, 6132.50939924805, 6146.385361463817, 6149.2313460817395, 6156.569040167145, 6163.0, 5118.232265160182, 5139.58883289336, 5146.356705411824, 5146.87132821675, 5149.510796474329, 3234.498652708834, 3280.245543524955, 3305.5206994986074, 3332.183615014337, 3340.4154273002127, 5845.357010728816, 5866.178734977107, 5872.882542349129, 5887.381824908409, 5888.970555147197, 6336.714847831859, 6368.713407896656, 6380.234371875312, 6392.328805475451, 6417.9679101605125, 5682.261306030272, 5793.420657934173, 5807.5644326675665, 5811.912821307684, 5886.05823068307, 6206.72069756853, 6209.316975132641, 6209.441150296495, 6232.314445411092, 6237.875242495215, 6045.727942242522, 6053.3946605339115, 6056.9091463628965, 6066.757329706938, 6082.665453399928, 5758.539316854725, 5851.561132915133, 5861.9706901465215, 5865.061590145727, 5884.558658100746, 4114.423980642772, 4182.874513764592, 4184.079502509443, 4190.287651099259, 4192.664586832985, 5888.352281248974, 6078.665673388006, 6182.783602573888, 6200.100985357189, 6204.255489341308, 5747.885042299215, 5930.940690593039, 5932.2584676915385, 5936.1095835625, 5941.7623295067715, 5923.08192230205, 5925.614835035709, 5929.970350148222, 5955.106733989763, 5958.6424814511265, 5671.829845104653, 5818.359980402068, 5821.592488525763, 5822.679752613478, 5838.2702162229725, 5925.229720136354, 5931.08068249422, 5974.522038237017, 5989.520838332835, 6001.639901605918, 5828.213191219131, 5836.387179346108, 5837.766489340379, 5855.092460668603, 5855.824325270249], "unit": "score", "name": "prototype.html", "value": 4403.6175016805355}, {"lowerIsBetter": false, "replicates": [566.5609152906497, 635.6758053392771, 637.2321352769912, 656.5174596671449, 659.9012643947825, 10481.480185373117, 10698.304610200332, 10756.300840445385, 10803.189760767935, 10864.293820901647, 10148.0, 10178.643747468841, 10196.439195844225, 10207.0, 10470.0, 803.8070862992869, 807.3783186946048, 813.7721437997341, 819.5697258939045, 821.995890020549, 803.5821372886124, 803.6222975201675, 806.9596520173997, 810.4610434061342, 815.1115284340068, 848.8047749017729, 851.0553285852699, 856.4903882190087, 857.4683696108422, 858.8282343531318, 838.861587838006, 842.8862103615994, 843.5992903370911, 846.4667259626395, 849.129642116829, 627.7269387816315, 629.471244154912, 630.2374127305965, 631.4317114596854, 633.0314618633498, 10927.672169834917, 10951.780964380747, 10952.178586605956, 10993.395363255018, 11047.779044419147, 10771.946140269327, 10808.945955270252, 11069.0, 11181.32912025281, 11609.30344179352, 8813.162749538847, 9072.455652660861, 9426.481543515103, 9432.575534100983, 9755.853662195073, 3041.923951901198, 3070.3859228154233, 3085.598872146629, 3091.4899041658323, 3117.2206948262933, 40891.182176356306, 40953.59046409527, 41162.0, 41195.382069268984, 41365.0, 8051.194880511902, 8152.0, 8418.6211620476, 8619.396642234984, 8628.396012279205, 14184.85815141856, 14189.148651080968, 14201.644958876112, 14212.218327991854, 14220.928895355664, 5919.526437884959, 5930.0, 5947.583669143119, 6105.145279660851, 6110.419510146529, 3486.33759585683, 3492.7729697569575, 3507.7895326280504, 3542.8405721742583, 3581.068922080226, 2355.4817940053163, 2365.6451532269953, 2373.97626023741, 2379.9762002380103, 2392.79661228794, 465.46471557708907, 465.6368032934317, 468.8265341823547, 472.9739864307496, 473.5998081621025, 427.81390095308643, 585.6603170161296, 596.0998891673604, 598.2611474828583, 599.2299894635372, 7636.770896873103, 7669.923300767033, 7696.191899850435, 7795.454318197785, 7932.444728869039, 466.3936882053317, 500.8447381311805, 505.6207844116912, 505.6460477665575, 600.6332871561414, 3585.8924232273075, 3599.892003239907, 3634.672879440863, 3710.239400922804, 3769.26499332633, 46425.76787116043, 46724.0, 46891.0, 46943.5305646946, 47220.52779472162, 42857.0, 43286.0, 43419.0, 43829.34255986163, 43878.561214388086, 39360.409593856115, 39575.80212098921, 39667.0, 39810.80094599567, 40045.79977100096, 7337.339639432476, 7363.300486453778, 7506.28690274423, 7588.506747061423, 7607.35337496319, 29972.100836974925, 30506.389872201988, 30550.388992219585, 31073.223169420944, 31445.213869653442, 33950.49074263938, 34056.0, 36894.262114758094, 36998.26003479969, 37278.0, 8976.202993720788, 9126.13301736334, 9139.405938613969, 9316.0, 9358.204552612831, 10161.796764064826, 10226.335288206243, 10307.793844122925, 10341.224408169266, 10343.431111288952, 9284.814303714023, 9596.9040309596, 9943.950280248553, 9998.500074996367, 10007.499625018865, 9151.542422878963, 9575.616975320909, 9590.760230994281, 9717.41695498244, 9734.123928846439, 8982.416142950688, 9182.586783594621, 9271.443713377219, 9320.580573874327, 9441.339106262496, 8145.918540814516, 8465.66137354499, 8552.786180345292, 8681.262092722189, 8837.955810220908, 8187.467814592271, 8194.50832950025, 8342.207490288412, 8366.24703776663, 8619.956900215459], "unit": "score", "name": "yui.html", "value": 5420.200322829395}], "name": "dromaeo_css", "value": 6266.00487787674}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 115.0, 115.0, 117.0, 127.0, 114.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.4}, {"lowerIsBetter": true, "replicates": [153.0, 134.0, 154.0, 163.0, 132.0, 160.0, 157.0, 133.0, 169.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [165.0, 165.0, 165.0, 164.0, 165.0, 165.0, 178.0, 161.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 165.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 74.0, 146.0, 76.0, 72.0, 74.0, 74.0, 91.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 134.0, 95.0, 95.0, 95.0, 139.0, 96.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 112.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 147.0, 147.0, 149.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 77.0, 75.0, 76.0, 74.0, 74.0, 74.0, 74.0, 76.0], "unit": "score", "name": "json-parse-financial", "value": 74.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 68.0, 68.0, 68.0, 68.0, 68.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 88.0, 88.0, 88.0, 87.0, 88.0, 87.0, 85.0, 96.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [130.0, 126.0, 132.0, 129.0, 134.0, 127.0, 124.0, 125.0, 129.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.6}, {"lowerIsBetter": true, "replicates": [138.0, 153.0, 153.0, 152.0, 154.0, 137.0, 163.0, 150.0, 152.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 74.0, 72.0, 70.0, 70.0, 72.0, 77.0, 70.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1556.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.12549537648613], "unit": "score", "name": "Richards", "value": 213.78891199999993}, {"lowerIsBetter": false, "replicates": [191.5341888527102], "unit": "score", "name": "DeltaBlue", "value": 345.2020779999999}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [1082.2510822510822], "unit": "score", "name": "RayTrace", "value": 683.7498360000003}, {"lowerIsBetter": false, "replicates": [712.2507122507122], "unit": "score", "name": "Earley", "value": 935.7140519999998}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [26447.36842105263], "unit": "score", "name": "RegExp", "value": 34.44520398009948}, {"lowerIsBetter": false, "replicates": [592.0663114268798], "unit": "score", "name": "Splay", "value": 137.63829900000002}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21303.920321744758}]} 03:43:42 INFO - RETURN: dromaeo_css: 6266.01 03:43:42 INFO - RETURN: kraken: 1556.10 03:43:42 INFO - RETURN: v8_7: 21303.92 03:43:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21303.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1556.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6266.01"}}} 03:43:42 INFO - Return code: 0 03:43:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:43:42 INFO - # TBPL SUCCESS # 03:43:42 INFO - Running post-action listener: _resource_record_post_action 03:43:42 INFO - Running post-run listener: _resource_record_post_run 03:43:43 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513548288; Read time: 12; Write time: 508312 03:43:43 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 238231552; Read time: 0; Write time: 344148 03:43:43 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275316736; Read time: 12; Write time: 164164 03:43:43 INFO - Running post-run listener: _upload_blobber_files 03:43:43 INFO - Blob upload gear active. 03:43:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:43:43 INFO - Copying logs to upload dir... 03:43:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.013693 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-17 03:43:43.245482) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:43:43.248854) ========= 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=edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009909 build_url: 'https://queue.taskcluster.net/v1/task/7fYncb0LQY2yVaxmVn27BA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:43:43.300949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:43:43.301358) ========= 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=edca6ca23558fe0608d91a4e00000196-1450351333.652183-2009455610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:43:43.351396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 03:43:43.351726) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 03:43:43.352033) ========= ========= Total master_lag: 0.23 =========