builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1449082008.29 results: success (0) buildid: 20151202101926 builduid: 53acef5bb1ea446d87c50cb2e790dec0 revision: 0ae21184dbe776ca22e68ff162428ac11348a030 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.292997) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.293444) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.293725) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006401 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.328332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.328634) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.371897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.372214) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.422944) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.423446) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.424003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 10:46:48.424337) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 10:46:48-- 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% 43.9M=0s 2015-12-02 10:46:49 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.150255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 10:46:49.589698) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:49.590250) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015438 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:49.640453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:49.640803) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ae21184dbe776ca22e68ff162428ac11348a030 --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 0ae21184dbe776ca22e68ff162428ac11348a030 --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=2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 10:46:49,769 truncating revision to first 12 chars 2015-12-02 10:46:49,769 Setting DEBUG logging. 2015-12-02 10:46:49,769 attempt 1/10 2015-12-02 10:46:49,769 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ae21184dbe7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 10:46:50,001 unpacking tar archive at: fx-team-0ae21184dbe7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524266 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:50.179268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:50.179616) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:50.189841) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:50.190197) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:50.190635) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-02 10:46:50.190912) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:46:50 INFO - MultiFileLogger online at 20151202 10:46:50 in /builds/slave/test 10:46:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:46:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:46:50 INFO - {'append_to_log': False, 10:46:50 INFO - 'base_work_dir': '/builds/slave/test', 10:46:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:46:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:46:50 INFO - 'branch': 'Fx-Team-Non-PGO', 10:46:50 INFO - 'buildbot_json_path': 'buildprops.json', 10:46:50 INFO - 'config_files': ('talos/linux_config.py',), 10:46:50 INFO - 'default_actions': ('clobber', 10:46:50 INFO - 'read-buildbot-config', 10:46:50 INFO - 'download-and-extract', 10:46:50 INFO - 'populate-webroot', 10:46:50 INFO - 'create-virtualenv', 10:46:50 INFO - 'install', 10:46:50 INFO - 'run-tests'), 10:46:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:46:50 INFO - 'download_minidump_stackwalk': True, 10:46:50 INFO - 'download_symbols': 'ondemand', 10:46:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:46:50 INFO - 'tooltool.py': '/tools/tooltool.py', 10:46:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:46:50 INFO - '/tools/misc-python/virtualenv.py')}, 10:46:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:46:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:46:50 INFO - 'installer_path': 'installer.exe', 10:46:50 INFO - 'log_level': 'info', 10:46:50 INFO - 'log_name': 'talos', 10:46:50 INFO - 'log_to_console': True, 10:46:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:46:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:46:50 INFO - 'opt_config_files': (), 10:46:50 INFO - 'pip_index': False, 10:46:50 INFO - 'sps_profile': False, 10:46:50 INFO - 'sps_profile_interval': 0, 10:46:50 INFO - 'suite': 'dromaeojs', 10:46:50 INFO - 'system_bits': '64', 10:46:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:46:50 INFO - 'title': 'talos-linux64-ix-032', 10:46:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:46:50 INFO - 'use_talos_json': True, 10:46:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:46:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:46:50 INFO - 'work_dir': 'build'} 10:46:50 INFO - ##### 10:46:50 INFO - ##### Running clobber step. 10:46:50 INFO - ##### 10:46:50 INFO - Running pre-action listener: _resource_record_pre_action 10:46:50 INFO - Running main action method: clobber 10:46:50 INFO - rmtree: /builds/slave/test/build 10:46:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:46:51 INFO - Running post-action listener: _resource_record_post_action 10:46:51 INFO - ##### 10:46:51 INFO - ##### Running read-buildbot-config step. 10:46:51 INFO - ##### 10:46:51 INFO - Running pre-action listener: _resource_record_pre_action 10:46:51 INFO - Running main action method: read_buildbot_config 10:46:51 INFO - Using buildbot properties: 10:46:51 INFO - { 10:46:51 INFO - "properties": { 10:46:51 INFO - "buildnumber": 970, 10:46:51 INFO - "product": "firefox", 10:46:51 INFO - "script_repo_revision": "production", 10:46:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:46:51 INFO - "repository": "", 10:46:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:46:51 INFO - "buildid": "20151202101926", 10:46:51 INFO - "slavename": "talos-linux64-ix-032", 10:46:51 INFO - "pgo_build": "False", 10:46:51 INFO - "basedir": "/builds/slave/test", 10:46:51 INFO - "project": "", 10:46:51 INFO - "platform": "ubuntu64_hw", 10:46:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:46:51 INFO - "slavebuilddir": "test", 10:46:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:46:51 INFO - "branch": "fx-team", 10:46:51 INFO - "repo_path": "integration/fx-team", 10:46:51 INFO - "stage_platform": "linux64", 10:46:51 INFO - "builduid": "53acef5bb1ea446d87c50cb2e790dec0", 10:46:51 INFO - "revision": "0ae21184dbe776ca22e68ff162428ac11348a030" 10:46:51 INFO - }, 10:46:51 INFO - "sourcestamp": { 10:46:51 INFO - "repository": "", 10:46:51 INFO - "hasPatch": false, 10:46:51 INFO - "project": "", 10:46:51 INFO - "branch": "fx-team-linux64-talos", 10:46:51 INFO - "changes": [ 10:46:51 INFO - { 10:46:51 INFO - "category": null, 10:46:51 INFO - "files": [ 10:46:51 INFO - { 10:46:51 INFO - "url": null, 10:46:51 INFO - "name": "https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:46:51 INFO - } 10:46:51 INFO - ], 10:46:51 INFO - "repository": "", 10:46:51 INFO - "rev": "0ae21184dbe776ca22e68ff162428ac11348a030", 10:46:51 INFO - "who": "dtownsend@mozilla.com", 10:46:51 INFO - "when": 1449081966, 10:46:51 INFO - "number": 6734241, 10:46:51 INFO - "comments": "Bug 1229097: Fix missed review comment by converting all rules to errors.", 10:46:51 INFO - "project": "", 10:46:51 INFO - "at": "Wed 02 Dec 2015 10:46:06", 10:46:51 INFO - "branch": "fx-team-linux64-talos", 10:46:51 INFO - "revlink": "", 10:46:51 INFO - "properties": [ 10:46:51 INFO - [ 10:46:51 INFO - "buildid", 10:46:51 INFO - "20151202101926", 10:46:51 INFO - "Change" 10:46:51 INFO - ], 10:46:51 INFO - [ 10:46:51 INFO - "builduid", 10:46:51 INFO - "53acef5bb1ea446d87c50cb2e790dec0", 10:46:51 INFO - "Change" 10:46:51 INFO - ], 10:46:51 INFO - [ 10:46:51 INFO - "pgo_build", 10:46:51 INFO - "False", 10:46:51 INFO - "Change" 10:46:51 INFO - ] 10:46:51 INFO - ], 10:46:51 INFO - "revision": "0ae21184dbe776ca22e68ff162428ac11348a030" 10:46:51 INFO - } 10:46:51 INFO - ], 10:46:51 INFO - "revision": "0ae21184dbe776ca22e68ff162428ac11348a030" 10:46:51 INFO - } 10:46:51 INFO - } 10:46:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:46:51 INFO - Running post-action listener: _resource_record_post_action 10:46:51 INFO - ##### 10:46:51 INFO - ##### Running download-and-extract step. 10:46:51 INFO - ##### 10:46:51 INFO - Running pre-action listener: _resource_record_pre_action 10:46:51 INFO - Running main action method: download_and_extract 10:46:51 INFO - mkdir: /builds/slave/test/build/tests 10:46:51 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')]} 10:46:51 INFO - https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:46:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/test_packages.json 10:46:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/test_packages.json 10:46:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:46:54 INFO - Downloaded 1302 bytes. 10:46:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:46:54 INFO - Using the following test package requirements: 10:46:54 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:46:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'jsshell-linux-x86_64.zip'], 10:46:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:46:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:46:54 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:46:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:46:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:46:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:46: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')]} 10:46:54 INFO - https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:46:56 INFO - Downloaded 21774978 bytes. 10:46:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:46:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:46:57 INFO - Return code: 0 10:46:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:46: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')]} 10:46:57 INFO - https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:46:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:47:04 INFO - Downloaded 21774978 bytes. 10:47:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:47:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:47:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:47:05 INFO - Return code: 0 10:47:05 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')]} 10:47:05 INFO - https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:47:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:47:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:47:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:47:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:47:06 INFO - Downloaded 11132001 bytes. 10:47:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 10:47:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:47:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:47:06 INFO - Return code: 0 10:47:06 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')]} 10:47:06 INFO - https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:47:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:47:07 INFO - Downloaded 57678286 bytes. 10:47:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:07 INFO - mkdir: /builds/slave/test/properties 10:47:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:47:07 INFO - Writing to file /builds/slave/test/properties/build_url 10:47:07 INFO - Contents: 10:47:07 INFO - build_url:https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:07 INFO - Running post-action listener: _resource_record_post_action 10:47:07 INFO - Running post-action listener: set_extra_try_arguments 10:47:07 INFO - ##### 10:47:07 INFO - ##### Running populate-webroot step. 10:47:07 INFO - ##### 10:47:07 INFO - Running pre-action listener: _resource_record_pre_action 10:47:07 INFO - Running main action method: populate_webroot 10:47:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:47:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:47:07 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:47:07 INFO - '../fennec_ids.txt'], 10:47:07 INFO - 'tests': ['tcheck2']}, 10:47:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:47:07 INFO - '--tppagecycles', 10:47:07 INFO - '7'], 10:47:07 INFO - 'tests': ['tsvgm']}}, 10:47:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:47:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:47:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:47:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:47:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:47:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:47:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:47:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:07 INFO - 'talos_options': ['--e10s'], 10:47:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:47:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:07 INFO - 'tests': ['damp', 'tps']}, 10:47:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:07 INFO - 'talos_options': ['--e10s'], 10:47:07 INFO - 'tests': ['damp', 'tps']}, 10:47:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:47:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:47:07 INFO - 'other': {'tests': ['a11yr', 10:47:07 INFO - 'ts_paint', 10:47:07 INFO - 'tpaint', 10:47:07 INFO - 'sessionrestore', 10:47:07 INFO - 'sessionrestore_no_auto_restore']}, 10:47:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:47:07 INFO - 'tests': ['a11yr', 10:47:07 INFO - 'ts_paint', 10:47:07 INFO - 'tpaint', 10:47:07 INFO - 'sessionrestore', 10:47:07 INFO - 'sessionrestore_no_auto_restore']}, 10:47:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:47:07 INFO - 'tests': ['a11yr', 10:47:07 INFO - 'ts_paint', 10:47:07 INFO - 'tpaint', 10:47:07 INFO - 'sessionrestore', 10:47:07 INFO - 'sessionrestore_no_auto_restore']}, 10:47:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:47:07 INFO - 'tests': ['a11yr', 10:47:07 INFO - 'ts_paint', 10:47:07 INFO - 'tpaint', 10:47:07 INFO - 'sessionrestore', 10:47:07 INFO - 'sessionrestore_no_auto_restore']}, 10:47:07 INFO - 'other_l64': {'tests': ['a11yr', 10:47:07 INFO - 'ts_paint', 10:47:07 INFO - 'tpaint', 10:47:07 INFO - 'sessionrestore', 10:47:07 INFO - 'sessionrestore_no_auto_restore']}, 10:47:07 INFO - 'other_nol64': {'tests': ['a11yr', 10:47:07 INFO - 'ts_paint', 10:47:07 INFO - 'tpaint', 10:47:07 INFO - 'sessionrestore', 10:47:07 INFO - 'sessionrestore_no_auto_restore']}, 10:47:07 INFO - 'svgr': {'tests': ['tsvgx', 10:47:07 INFO - 'tsvgr_opacity', 10:47:07 INFO - 'tart', 10:47:07 INFO - 'tscrollx', 10:47:07 INFO - 'cart']}, 10:47:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:47:07 INFO - 'tests': ['tsvgx', 10:47:07 INFO - 'tsvgr_opacity', 10:47:07 INFO - 'tart', 10:47:07 INFO - 'tscrollx', 10:47:07 INFO - 'cart']}, 10:47:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:07 INFO - 'tests': ['tp5o']}, 10:47:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:08 INFO - 'talos_options': ['--e10s'], 10:47:08 INFO - 'tests': ['tp5o']}, 10:47:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:08 INFO - 'talos_options': ['--xperf_path', 10:47:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:47:08 INFO - 'tests': ['tp5n']}, 10:47:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:08 INFO - 'talos_options': ['--e10s', 10:47:08 INFO - '--xperf_path', 10:47:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:47:08 INFO - 'tests': ['tp5n']}}, 10:47:08 INFO - 'talos.zip': {'path': '', 10:47:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:47:08 INFO - Running post-action listener: _resource_record_post_action 10:47:08 INFO - ##### 10:47:08 INFO - ##### Running create-virtualenv step. 10:47:08 INFO - ##### 10:47:08 INFO - Running pre-action listener: _resource_record_pre_action 10:47:08 INFO - Running main action method: create_virtualenv 10:47:08 INFO - Creating virtualenv /builds/slave/test/build/venv 10:47:08 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 10:47:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:47:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:47:08 INFO - Using real prefix '/usr' 10:47:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:47:08 INFO - Installing distribute.............................................................................................................................................................................................done. 10:47:10 INFO - Installing pip.................done. 10:47:10 INFO - Return code: 0 10:47:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:47:10 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')]} 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:10 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')]} 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:10 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 0x7fbd154bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b40b0>, '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 0x29b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b5440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', '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 10:47:10 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 10:47:10 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 10:47:10 INFO - Using env: {'DISPLAY': ':0', 10:47:10 INFO - 'HOME': '/home/cltbld', 10:47:10 INFO - 'LANG': 'en_US.UTF-8', 10:47:10 INFO - 'LANGUAGE': 'en_US:en', 10:47:10 INFO - 'LOGNAME': 'cltbld', 10:47:10 INFO - 'MAIL': '/var/mail/cltbld', 10:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:10 INFO - 'MOZ_NO_REMOTE': '1', 10:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:10 INFO - 'NO_EM_RESTART': '1', 10:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:10 INFO - 'PWD': '/builds/slave/test', 10:47:10 INFO - 'SHELL': '/bin/bash', 10:47:10 INFO - 'SHLVL': '1', 10:47:10 INFO - 'TERM': 'linux', 10:47:10 INFO - 'TMOUT': '86400', 10:47:10 INFO - 'USER': 'cltbld', 10:47:10 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', 10:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:10 INFO - '_': '/tools/buildbot/bin/python'} 10:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:11 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 10:47:11 INFO - Cleaning up... 10:47:11 INFO - Return code: 0 10:47:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbd154bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b40b0>, '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 0x29b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b5440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', '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 10:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:47:11 INFO - Using env: {'DISPLAY': ':0', 10:47:11 INFO - 'HOME': '/home/cltbld', 10:47:11 INFO - 'LANG': 'en_US.UTF-8', 10:47:11 INFO - 'LANGUAGE': 'en_US:en', 10:47:11 INFO - 'LOGNAME': 'cltbld', 10:47:11 INFO - 'MAIL': '/var/mail/cltbld', 10:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:11 INFO - 'MOZ_NO_REMOTE': '1', 10:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:11 INFO - 'NO_EM_RESTART': '1', 10:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:11 INFO - 'PWD': '/builds/slave/test', 10:47:11 INFO - 'SHELL': '/bin/bash', 10:47:11 INFO - 'SHLVL': '1', 10:47:11 INFO - 'TERM': 'linux', 10:47:11 INFO - 'TMOUT': '86400', 10:47:11 INFO - 'USER': 'cltbld', 10:47:11 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', 10:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:11 INFO - '_': '/tools/buildbot/bin/python'} 10:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:11 INFO - Downloading/unpacking psutil>=0.7.1 10:47:11 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 10:47:11 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 10:47:11 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 10:47:11 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 10:47:11 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 10:47:11 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 10:47:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:47:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:47:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:13 INFO - Installing collected packages: psutil 10:47:13 INFO - Running setup.py install for psutil 10:47:13 INFO - building 'psutil._psutil_linux' extension 10:47:13 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 10:47:13 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 10:47:13 INFO - building 'psutil._psutil_posix' extension 10:47:13 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 10:47:13 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 10:47:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:13 INFO - Successfully installed psutil 10:47:13 INFO - Cleaning up... 10:47:13 INFO - Return code: 0 10:47:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbd154bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b40b0>, '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 0x29b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b5440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', '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 10:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:47:13 INFO - Using env: {'DISPLAY': ':0', 10:47:13 INFO - 'HOME': '/home/cltbld', 10:47:13 INFO - 'LANG': 'en_US.UTF-8', 10:47:13 INFO - 'LANGUAGE': 'en_US:en', 10:47:13 INFO - 'LOGNAME': 'cltbld', 10:47:13 INFO - 'MAIL': '/var/mail/cltbld', 10:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:13 INFO - 'MOZ_NO_REMOTE': '1', 10:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:13 INFO - 'NO_EM_RESTART': '1', 10:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:13 INFO - 'PWD': '/builds/slave/test', 10:47:13 INFO - 'SHELL': '/bin/bash', 10:47:13 INFO - 'SHLVL': '1', 10:47:13 INFO - 'TERM': 'linux', 10:47:13 INFO - 'TMOUT': '86400', 10:47:13 INFO - 'USER': 'cltbld', 10:47:13 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', 10:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:13 INFO - '_': '/tools/buildbot/bin/python'} 10:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:47:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:47:15 INFO - Installing collected packages: mozsystemmonitor 10:47:15 INFO - Running setup.py install for mozsystemmonitor 10:47:15 INFO - Successfully installed mozsystemmonitor 10:47:15 INFO - Cleaning up... 10:47:15 INFO - Return code: 0 10:47:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:15 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 0x7fbd154bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b40b0>, '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 0x29b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b5440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', '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 10:47:15 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 10:47:15 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 10:47:15 INFO - Using env: {'DISPLAY': ':0', 10:47:15 INFO - 'HOME': '/home/cltbld', 10:47:15 INFO - 'LANG': 'en_US.UTF-8', 10:47:15 INFO - 'LANGUAGE': 'en_US:en', 10:47:15 INFO - 'LOGNAME': 'cltbld', 10:47:15 INFO - 'MAIL': '/var/mail/cltbld', 10:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:15 INFO - 'MOZ_NO_REMOTE': '1', 10:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:15 INFO - 'NO_EM_RESTART': '1', 10:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:15 INFO - 'PWD': '/builds/slave/test', 10:47:15 INFO - 'SHELL': '/bin/bash', 10:47:15 INFO - 'SHLVL': '1', 10:47:15 INFO - 'TERM': 'linux', 10:47:15 INFO - 'TMOUT': '86400', 10:47:15 INFO - 'USER': 'cltbld', 10:47:15 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', 10:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:15 INFO - '_': '/tools/buildbot/bin/python'} 10:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:15 INFO - Downloading/unpacking blobuploader==1.2.4 10:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:17 INFO - Downloading blobuploader-1.2.4.tar.gz 10:47:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:47:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:47:17 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 10:47:17 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 10:47:17 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 10:47:17 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 10:47:17 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 10:47:17 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 10:47:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:47:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:47:18 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 10:47:18 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 10:47:18 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 10:47:18 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 10:47:18 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 10:47:18 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 10:47:18 INFO - Downloading docopt-0.6.1.tar.gz 10:47:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:47:18 INFO - Installing collected packages: blobuploader, requests, docopt 10:47:18 INFO - Running setup.py install for blobuploader 10:47:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:47:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:47:18 INFO - Running setup.py install for requests 10:47:18 INFO - Running setup.py install for docopt 10:47:18 INFO - Successfully installed blobuploader requests docopt 10:47:18 INFO - Cleaning up... 10:47:18 INFO - Return code: 0 10:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:18 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')]} 10:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:18 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')]} 10:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:18 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 0x7fbd154bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b40b0>, '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 0x29b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b5440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', '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 10:47:18 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 10:47:18 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 10:47:18 INFO - Using env: {'DISPLAY': ':0', 10:47:18 INFO - 'HOME': '/home/cltbld', 10:47:18 INFO - 'LANG': 'en_US.UTF-8', 10:47:18 INFO - 'LANGUAGE': 'en_US:en', 10:47:18 INFO - 'LOGNAME': 'cltbld', 10:47:18 INFO - 'MAIL': '/var/mail/cltbld', 10:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:18 INFO - 'MOZ_NO_REMOTE': '1', 10:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:18 INFO - 'NO_EM_RESTART': '1', 10:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:18 INFO - 'PWD': '/builds/slave/test', 10:47:18 INFO - 'SHELL': '/bin/bash', 10:47:18 INFO - 'SHLVL': '1', 10:47:18 INFO - 'TERM': 'linux', 10:47:18 INFO - 'TMOUT': '86400', 10:47:18 INFO - 'USER': 'cltbld', 10:47:18 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', 10:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:18 INFO - '_': '/tools/buildbot/bin/python'} 10:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:19 INFO - Running setup.py (path:/tmp/pip-alEaWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:19 INFO - Running setup.py (path:/tmp/pip-7In_G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:19 INFO - Running setup.py (path:/tmp/pip-tLgB9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:19 INFO - Running setup.py (path:/tmp/pip-nxj2pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:19 INFO - Running setup.py (path:/tmp/pip-w7wQej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:19 INFO - Running setup.py (path:/tmp/pip-Tg5mwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:19 INFO - Running setup.py (path:/tmp/pip-FQlXao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:19 INFO - Running setup.py (path:/tmp/pip-UPhNFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:19 INFO - Running setup.py (path:/tmp/pip-Ys69vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:19 INFO - Running setup.py (path:/tmp/pip-vKbOyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:19 INFO - Running setup.py (path:/tmp/pip-BDVkgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:19 INFO - Running setup.py (path:/tmp/pip-fBRjp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:19 INFO - Running setup.py (path:/tmp/pip-dJQ8pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:20 INFO - Running setup.py (path:/tmp/pip-9hsn24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:20 INFO - Running setup.py (path:/tmp/pip-Jp30uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:20 INFO - Running setup.py (path:/tmp/pip-qqoOhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:20 INFO - Running setup.py (path:/tmp/pip-0YQZwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:47:20 INFO - Running setup.py install for manifestparser 10:47:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Running setup.py install for mozcrash 10:47:20 INFO - Running setup.py install for mozdebug 10:47:20 INFO - Running setup.py install for mozdevice 10:47:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Running setup.py install for mozfile 10:47:20 INFO - Running setup.py install for mozhttpd 10:47:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Running setup.py install for mozinfo 10:47:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Running setup.py install for mozInstall 10:47:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Running setup.py install for mozleak 10:47:21 INFO - Running setup.py install for mozlog 10:47:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Running setup.py install for moznetwork 10:47:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Running setup.py install for mozprocess 10:47:21 INFO - Running setup.py install for mozprofile 10:47:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Running setup.py install for mozrunner 10:47:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Running setup.py install for mozscreenshot 10:47:21 INFO - Running setup.py install for moztest 10:47:21 INFO - Running setup.py install for mozversion 10:47:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:47:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:47:22 INFO - Cleaning up... 10:47:22 INFO - Return code: 0 10:47:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:22 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 0x7fbd154bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b40b0>, '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 0x29b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b5440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', '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 10:47:22 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 10:47:22 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 10:47:22 INFO - Using env: {'DISPLAY': ':0', 10:47:22 INFO - 'HOME': '/home/cltbld', 10:47:22 INFO - 'LANG': 'en_US.UTF-8', 10:47:22 INFO - 'LANGUAGE': 'en_US:en', 10:47:22 INFO - 'LOGNAME': 'cltbld', 10:47:22 INFO - 'MAIL': '/var/mail/cltbld', 10:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:22 INFO - 'MOZ_NO_REMOTE': '1', 10:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:22 INFO - 'NO_EM_RESTART': '1', 10:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:22 INFO - 'PWD': '/builds/slave/test', 10:47:22 INFO - 'SHELL': '/bin/bash', 10:47:22 INFO - 'SHLVL': '1', 10:47:22 INFO - 'TERM': 'linux', 10:47:22 INFO - 'TMOUT': '86400', 10:47:22 INFO - 'USER': 'cltbld', 10:47:22 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', 10:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:22 INFO - '_': '/tools/buildbot/bin/python'} 10:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:22 INFO - Running setup.py (path:/tmp/pip-rVAP7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:22 INFO - Running setup.py (path:/tmp/pip-NHhrOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:22 INFO - Running setup.py (path:/tmp/pip-6759q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:22 INFO - Running setup.py (path:/tmp/pip-Uh_qoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:22 INFO - Running setup.py (path:/tmp/pip-T3Buxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:22 INFO - Running setup.py (path:/tmp/pip-qruWro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:22 INFO - Running setup.py (path:/tmp/pip-znGV2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:22 INFO - Running setup.py (path:/tmp/pip-NqucAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:22 INFO - Running setup.py (path:/tmp/pip-qyEuzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:22 INFO - Running setup.py (path:/tmp/pip-kugRSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:23 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)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:23 INFO - Running setup.py (path:/tmp/pip-IMHtT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:23 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)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:23 INFO - Running setup.py (path:/tmp/pip-iwozUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:23 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)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:23 INFO - Running setup.py (path:/tmp/pip-0d2g4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:23 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)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:23 INFO - Running setup.py (path:/tmp/pip-DMvdBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:23 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)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:23 INFO - Running setup.py (path:/tmp/pip-FvGk8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:23 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)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:23 INFO - Running setup.py (path:/tmp/pip-oymW0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:23 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)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:23 INFO - Running setup.py (path:/tmp/pip-IM_wrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:23 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)) 10:47:23 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)) 10:47:23 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)) 10:47:23 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)) 10:47:23 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)) 10:47:23 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)) 10:47:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47:23 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 10:47:23 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 10:47:23 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 10:47:23 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 10:47:23 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 10:47:23 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 10:47:25 INFO - Downloading blessings-1.5.1.tar.gz 10:47:25 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 10:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:47:25 INFO - Installing collected packages: blessings 10:47:25 INFO - Running setup.py install for blessings 10:47:25 INFO - Successfully installed blessings 10:47:25 INFO - Cleaning up... 10:47:25 INFO - Return code: 0 10:47:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:47:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:25 INFO - Reading from file tmpfile_stdout 10:47:25 INFO - Current package versions: 10:47:25 INFO - argparse == 1.2.1 10:47:25 INFO - blessings == 1.5.1 10:47:25 INFO - blobuploader == 1.2.4 10:47:25 INFO - docopt == 0.6.1 10:47:25 INFO - manifestparser == 1.1 10:47:25 INFO - mozInstall == 1.12 10:47:25 INFO - mozcrash == 0.16 10:47:25 INFO - mozdebug == 0.1 10:47:25 INFO - mozdevice == 0.47 10:47:25 INFO - mozfile == 1.2 10:47:25 INFO - mozhttpd == 0.7 10:47:25 INFO - mozinfo == 0.9 10:47:25 INFO - mozleak == 0.1 10:47:25 INFO - mozlog == 3.1 10:47:25 INFO - moznetwork == 0.27 10:47:25 INFO - mozprocess == 0.22 10:47:25 INFO - mozprofile == 0.27 10:47:25 INFO - mozrunner == 6.11 10:47:25 INFO - mozscreenshot == 0.1 10:47:25 INFO - mozsystemmonitor == 0.0 10:47:25 INFO - moztest == 0.7 10:47:25 INFO - mozversion == 1.4 10:47:25 INFO - psutil == 3.1.1 10:47:25 INFO - requests == 1.2.3 10:47:25 INFO - wsgiref == 0.1.2 10:47:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:25 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')]} 10:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:25 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')]} 10:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:25 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 0x7fbd154bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b40b0>, '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 0x29b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b5440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', '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 10:47:25 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 10:47:25 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 10:47:25 INFO - Using env: {'DISPLAY': ':0', 10:47:25 INFO - 'HOME': '/home/cltbld', 10:47:25 INFO - 'LANG': 'en_US.UTF-8', 10:47:25 INFO - 'LANGUAGE': 'en_US:en', 10:47:25 INFO - 'LOGNAME': 'cltbld', 10:47:25 INFO - 'MAIL': '/var/mail/cltbld', 10:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:25 INFO - 'MOZ_NO_REMOTE': '1', 10:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:25 INFO - 'NO_EM_RESTART': '1', 10:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:25 INFO - 'PWD': '/builds/slave/test', 10:47:25 INFO - 'SHELL': '/bin/bash', 10:47:25 INFO - 'SHLVL': '1', 10:47:25 INFO - 'TERM': 'linux', 10:47:25 INFO - 'TMOUT': '86400', 10:47:25 INFO - 'USER': 'cltbld', 10:47:25 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', 10:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:25 INFO - '_': '/tools/buildbot/bin/python'} 10:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:25 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)) 10:47:25 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)) 10:47:25 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)) 10:47:25 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)) 10:47:25 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)) 10:47:25 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)) 10:47:25 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)) 10:47:25 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)) 10:47:25 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)) 10:47:25 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)) 10:47:25 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)) 10:47:25 INFO - Cleaning up... 10:47:25 INFO - Return code: 0 10:47:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:47:25 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')]} 10:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:25 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')]} 10:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:25 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 0x7fbd154bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b40b0>, '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 0x29b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b5440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', '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 10:47:25 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 10:47:25 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 10:47:25 INFO - Using env: {'DISPLAY': ':0', 10:47:25 INFO - 'HOME': '/home/cltbld', 10:47:25 INFO - 'LANG': 'en_US.UTF-8', 10:47:25 INFO - 'LANGUAGE': 'en_US:en', 10:47:25 INFO - 'LOGNAME': 'cltbld', 10:47:25 INFO - 'MAIL': '/var/mail/cltbld', 10:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:25 INFO - 'MOZ_NO_REMOTE': '1', 10:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:25 INFO - 'NO_EM_RESTART': '1', 10:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:25 INFO - 'PWD': '/builds/slave/test', 10:47:25 INFO - 'SHELL': '/bin/bash', 10:47:25 INFO - 'SHLVL': '1', 10:47:25 INFO - 'TERM': 'linux', 10:47:25 INFO - 'TMOUT': '86400', 10:47:25 INFO - 'USER': 'cltbld', 10:47:25 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', 10:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:25 INFO - '_': '/tools/buildbot/bin/python'} 10:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:26 INFO - Downloading/unpacking jsonschema 10:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:47:27 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 10:47:27 INFO - Downloading/unpacking functools32 (from jsonschema) 10:47:27 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 10:47:27 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 10:47:27 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 10:47:27 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 10:47:27 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 10:47:27 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 10:47:27 INFO - Downloading functools32-3.2.3-2.tar.gz 10:47:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:47:27 INFO - warning: no files found matching '*.txt' 10:47:27 INFO - no previously-included directories found matching 'build' 10:47:27 INFO - no previously-included directories found matching 'dist' 10:47:27 INFO - no previously-included directories found matching '.git*' 10:47:27 INFO - Installing collected packages: jsonschema, functools32 10:47:28 INFO - Running setup.py install for functools32 10:47:28 INFO - warning: no files found matching '*.txt' 10:47:28 INFO - no previously-included directories found matching 'build' 10:47:28 INFO - no previously-included directories found matching 'dist' 10:47:28 INFO - no previously-included directories found matching '.git*' 10:47:28 INFO - Successfully installed jsonschema functools32 10:47:28 INFO - Cleaning up... 10:47:28 INFO - Return code: 0 10:47:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:47:28 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')]} 10:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:28 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')]} 10:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:28 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 0x7fbd154bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b40b0>, '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 0x29b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b5440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', '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 10:47:28 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 10:47:28 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 10:47:28 INFO - Using env: {'DISPLAY': ':0', 10:47:28 INFO - 'HOME': '/home/cltbld', 10:47:28 INFO - 'LANG': 'en_US.UTF-8', 10:47:28 INFO - 'LANGUAGE': 'en_US:en', 10:47:28 INFO - 'LOGNAME': 'cltbld', 10:47:28 INFO - 'MAIL': '/var/mail/cltbld', 10:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:28 INFO - 'MOZ_NO_REMOTE': '1', 10:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:28 INFO - 'NO_EM_RESTART': '1', 10:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:28 INFO - 'PWD': '/builds/slave/test', 10:47:28 INFO - 'SHELL': '/bin/bash', 10:47:28 INFO - 'SHLVL': '1', 10:47:28 INFO - 'TERM': 'linux', 10:47:28 INFO - 'TMOUT': '86400', 10:47:28 INFO - 'USER': 'cltbld', 10:47:28 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', 10:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:28 INFO - '_': '/tools/buildbot/bin/python'} 10:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:28 INFO - Downloading/unpacking flake8 10:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:47:30 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 10:47:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:47:30 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 10:47:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 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 10:47:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:47:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:47:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:47:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:47:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:47:30 INFO - no previously-included directories found matching 'docs/_build' 10:47:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:47:30 INFO - Running setup.py install for pep8 10:47:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:47:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:47:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:47:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:47:30 INFO - no previously-included directories found matching 'docs/_build' 10:47:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:47:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:47:30 INFO - Cleaning up... 10:47:30 INFO - Return code: 0 10:47:30 INFO - Running post-action listener: _resource_record_post_action 10:47:30 INFO - Running post-action listener: _start_resource_monitoring 10:47:30 INFO - Starting resource monitoring. 10:47:30 INFO - ##### 10:47:30 INFO - ##### Running install step. 10:47:30 INFO - ##### 10:47:30 INFO - Running pre-action listener: _resource_record_pre_action 10:47:30 INFO - Running main action method: install 10:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:31 INFO - Reading from file tmpfile_stdout 10:47:31 INFO - Detecting whether we're running mozinstall >=1.0... 10:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:47:31 INFO - Reading from file tmpfile_stdout 10:47:31 INFO - Output received: 10:47:31 INFO - Usage: mozinstall [options] installer 10:47:31 INFO - Options: 10:47:31 INFO - -h, --help show this help message and exit 10:47:31 INFO - -d DEST, --destination=DEST 10:47:31 INFO - Directory to install application into. [default: 10:47:31 INFO - "/builds/slave/test"] 10:47:31 INFO - --app=APP Application being installed. [default: firefox] 10:47:31 INFO - mkdir: /builds/slave/test/build/application 10:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:47:45 INFO - Reading from file tmpfile_stdout 10:47:45 INFO - Output received: 10:47:45 INFO - /builds/slave/test/build/application/firefox/firefox 10:47:45 INFO - Running post-action listener: _resource_record_post_action 10:47:45 INFO - ##### 10:47:45 INFO - ##### Running run-tests step. 10:47:45 INFO - ##### 10:47:45 INFO - Running pre-action listener: _resource_record_pre_action 10:47:45 INFO - Running main action method: run_tests 10:47:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:47:45 INFO - Python 2.7.3 10:47:45 INFO - Return code: 0 10:47:45 INFO - grabbing minidump binary from tooltool 10:47: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')]} 10:47:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b40b0>, '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 0x29b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b5440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:47:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:47:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:47:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:47:45 INFO - Return code: 0 10:47:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:47:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:47:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:47:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:47:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:47:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:47:46 INFO - Return code: 0 10:47:46 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] in /builds/slave/test/build 10:47:46 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost 10:47:46 INFO - Using env: {'DISPLAY': ':0', 10:47:46 INFO - 'HOME': '/home/cltbld', 10:47:46 INFO - 'LANG': 'en_US.UTF-8', 10:47:46 INFO - 'LANGUAGE': 'en_US:en', 10:47:46 INFO - 'LOGNAME': 'cltbld', 10:47:46 INFO - 'MAIL': '/var/mail/cltbld', 10:47:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:47:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:46 INFO - 'MOZ_NO_REMOTE': '1', 10:47:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:46 INFO - 'NO_EM_RESTART': '1', 10:47:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:46 INFO - 'PWD': '/builds/slave/test', 10:47:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:47:46 INFO - 'SHELL': '/bin/bash', 10:47:46 INFO - 'SHLVL': '1', 10:47:46 INFO - 'TERM': 'linux', 10:47:46 INFO - 'TMOUT': '86400', 10:47:46 INFO - 'USER': 'cltbld', 10:47:46 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179', 10:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:46 INFO - '_': '/tools/buildbot/bin/python'} 10:47:46 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] with output_timeout 3600 10:47:47 INFO - mozversion INFO | application_buildid: 20151202101926 10:47:47 INFO - mozversion INFO | application_changeset: 0ae21184dbe776ca22e68ff162428ac11348a030 10:47:47 INFO - mozversion INFO | application_display_name: Nightly 10:47:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:47:47 INFO - mozversion INFO | application_name: Firefox 10:47:47 INFO - mozversion INFO | application_remotingname: firefox 10:47:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:47:47 INFO - mozversion INFO | application_vendor: Mozilla 10:47:47 INFO - mozversion INFO | application_version: 45.0a1 10:47:47 INFO - mozversion INFO | platform_buildid: 20151202101926 10:47:47 INFO - mozversion INFO | platform_changeset: 0ae21184dbe776ca22e68ff162428ac11348a030 10:47:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:47:47 INFO - mozversion INFO | platform_version: 45.0a1 10:47:47 INFO - 2015-12-02 10:47:47,023 DEBUG : using testdate: 1449082067 10:47:47 INFO - 2015-12-02 10:47:47,023 DEBUG : actual date: 1449082067 10:47:47 INFO - 2015-12-02 10:47:47,038 INFO : starting webserver on 'localhost:53893' 10:47:47 INFO - 2015-12-02 10:47:47,039 INFO : Starting test suite talos-linux64-ix-032 10:47:47 INFO - 2015-12-02 10:47:47,039 INFO : Starting test dromaeo_css 10:47:47 INFO - 2015-12-02 10:47:47,039 DEBUG : operating with platform_type : linux_ 10:47:47 INFO - 2015-12-02 10:47:47,040 INFO : Initialising browser for dromaeo_css test... 10:47:47 INFO - 2015-12-02 10:47:47,056 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDs9pJh/profile http://localhost:53893/getInfo.html 10:47:52 INFO - 2015-12-02 10:47:52,584 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:47:52 INFO - 2015-12-02 10:47:52,585 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:47:52 INFO - 2015-12-02 10:47:52,585 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:47:52 INFO - 2015-12-02 10:47:52,585 DEBUG : BROWSER_OUTPUT: __metrics 10:47:52 INFO - 2015-12-02 10:47:52,734 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] 10:47:52 INFO - 2015-12-02 10:47:52,734 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:47:54 INFO - 2015-12-02 10:47:54,176 INFO : Browser initialized. 10:47:54 INFO - 2015-12-02 10:47:54,176 INFO : Running cycle 1/1 for dromaeo_css test... 10:47:54 INFO - 2015-12-02 10:47:54,177 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDs9pJh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:48:06 INFO - 2015-12-02 10:48:06,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 142991360 10:48:06 INFO - 2015-12-02 10:48:06,150 DEBUG : BROWSER_OUTPUT: 10:48:57 INFO - 2015-12-02 10:48:57,400 DEBUG : BROWSER_OUTPUT: 1449082137399 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] 10:51:09 INFO - 2015-12-02 10:51:09,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53893/tests/dromaeo/cssquery-ext.html) 10:51:10 INFO - 2015-12-02 10:51:10,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 246538240 10:51:10 INFO - 2015-12-02 10:51:10,741 DEBUG : BROWSER_OUTPUT: 10:54:13 INFO - 2015-12-02 10:54:13,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/dromaeo/cssquery-ext.html (next: http://localhost:53893/tests/dromaeo/cssquery-jquery.html) 10:54:13 INFO - 2015-12-02 10:54:13,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 220540928 10:54:13 INFO - 2015-12-02 10:54:13,943 DEBUG : BROWSER_OUTPUT: 10:57:15 INFO - 2015-12-02 10:57:15,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53893/tests/dromaeo/cssquery-mootools.html) 10:57:16 INFO - 2015-12-02 10:57:16,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 222130176 10:57:16 INFO - 2015-12-02 10:57:16,526 DEBUG : BROWSER_OUTPUT: 11:00:18 INFO - 2015-12-02 11:00:18,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53893/tests/dromaeo/cssquery-prototype.html) 11:00:19 INFO - 2015-12-02 11:00:19,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 206278656 11:00:19 INFO - 2015-12-02 11:00:19,065 DEBUG : BROWSER_OUTPUT: 11:03:21 INFO - 2015-12-02 11:03:21,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53893/tests/dromaeo/cssquery-yui.html) 11:03:22 INFO - 2015-12-02 11:03:22,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 209309696 11:03:22 INFO - 2015-12-02 11:03:22,487 DEBUG : BROWSER_OUTPUT: 11:06:25 INFO - 2015-12-02 11:06:25,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/dromaeo/cssquery-yui.html (next: http://localhost:53893/tests/dromaeo/cssquery-dojo.html) 11:06:25 INFO - 2015-12-02 11:06:25,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 258781184 11:06:25 INFO - 2015-12-02 11:06:25,289 DEBUG : BROWSER_OUTPUT: 11:06:25 INFO - 2015-12-02 11:06:25,289 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:06:25 INFO - 2015-12-02 11:06:25,289 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:06:25 INFO - 2015-12-02 11:06:25,289 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:06:25 INFO - 2015-12-02 11:06:25,289 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:06:25 INFO - 2015-12-02 11:06:25,289 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2610.4518051209243;2689.085710858309;2691.825031372962;2708.64787577615;2718.537848565744;4624.699394539352;4664.3703100081475;4684.9765751171235;4730.432348118222;4773.665843390955;4703.012367402849;4711.175544279746;4759.571638552529;4763.214069678507;4763.476017638066;4256.914861702764;4344.695871289011;4351.825926962918;4423.093265880487;4470.552944705536;4157.251694694954;4384.868453946387;4418.3372494125815;4441.800118994637;4504.121696269229;4231.91536169278;4237.152569486099;4272.359146128075;4322.589354011364;4362.411074504965;4296.2481565725875;4335.436393268887;4336.891577710582;4366.366876802877;4391.451068616423;4170.124273902454;4322.265214913441;4325.697201195918;4328.935065974013;4379.255526560492;4519.909601807978;4565.223911934979;4581.4502259728715;4581.908361832778;4630.560096790799;4998.10034193845;5080.61895357846;5081.237814327844;5084.949150508484;5113.258577506278;4894.804207831682;5080.872978175538;5095.082885080684;5112.156494178456;5112.974435127838;4626.583607475343;4651.5813576778255;4657.813687452532;4676.789544470507;4738.360321356573;5087.516685914832;5127.3847138343635;5128.153854614022;5129.846104616868;5165.070287348313;4782.0914026334885;4916.532929371704;4917.975410122926;4918.409790825124;4968.925466118011;4785.3300537924715;4878.926816097762;4894.975525122423;4950.8267210647455;4980.427250866124;4995.125852975715;5023;5024.824131155392;5028.371453568304;5080.009398167395;4977.776000080005;4983.50164983506;4983.975080124576;4986.127427700138;5029.974850125799;4000.459937908345;4058.492688413948;4096.365063415175;4103.363978583325;4147.274227010261;3682.0426689061037;3686.963130368662;3706.4069748840056;3711.9443208351895;3737.32728108943;4376.431063961728;4387.583179597933;4389.846355377546;4394.494633117169;4428.579284967923;4786.0667169901535;4886.438059623118;4886.902261954741;5098.643094983389;5126.948730512721;4208.38978348144;4280.058387154821;4296.0978194578865;4333.414988976511;4334.566543345641;4465.866024019285;4484.260097084009;4487.798049087799;4488.0126372198065;4527.479339875957;4624.098300831306;4739.028499157595;4742.952570474389;4839.733814640158;4846.321514987904;4984.651074424755;5054.82308119214;5068.594512438923;5082.313887625123;5118.257852611425;4809.711417314972;4813.879653008703;4816;4816.735079570657;4861.854144375674;4809.5430934061205;4909.3126962224605;4916.311716359784;4979.950200497949;5018;4948.653594248368;5032.924506132485;5044.747762611782;5064.18972964324;5070.645054846125;4876.756162191805;4882.487338829372;4883.218685010382;4885.560299573055;4932.358793356841;4768.4754676986195;4892.951070489249;4892.951070489249;4894.2169252920785;4895.583875370491;4684.156851766715;4753.453352864327;4753.619710423227;4759.143354196278;4811.470738218723;4935.407751069894;4954.529319714621;4962.851114466572;4971.130052240771;5014.623903207347;4637.953620463887;4750.263709125091;4830.396200474941;4835.274708793709;4883.243097319921 11:06:25 INFO - 2015-12-02 11:06:25,290 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.3002676680917;581.546393812826;588.1765528260433;590.9793157239498;603.7826382502299;25537.233882983517;36243.63756362439;36933.63066369335;36938.81530592347;36939.4459083114;40083.799581002124;40306;40559.39160912589;40582.7970860146;40598.188036239255;6983.127109111361;7094.7871563852905;7908.723194688201;8073.596320183997;8074.394420418463;9700.854487182698;9999.10008099271;10003.499825008757;10005.54975026122;10010.04904534068;10064.74838129049;10170.288079834414;10171.288009839314;10177.26986412308;10177.491125443697;7163.606001669906;7307.634618269065;9988.500574971222;10171.288009839314;10459;9864.062914023156;10010.749731256705;10011.799764004752;10012.849807252824;10020.549075291628;28373.432531349463;36863;37159.256814863824;37304;37371;2418.830681852271;2832.8017038807293;2886.4515742008953;2928.3996780659913;2968.2134234427895;26974.325641858915;27112.32219194516;27112.32219194516;27160.592591111148;27370.33703171399;3218.9678103218903;3272.8363581820813;3280.1799550112473;3318.5188147718445;3407.16524451511;216299;217444;217565;217670.99999999843;217899;55230;55582;55636.72181639066;55754;55817.44182558123;48215.75892120517;49341.25988110181;58922.70538647279;59204;65437.67281163659;12193.45129469176;12285.69285767845;12353.691157721129;12366.690832729073;12372.690682733004;9868.753281167885;9883.802323953625;9996.750081247881;10000.699979000641;10002.699919002442;19284.1322140504;19499.61000780005;19513.707294390595;19520.41438756811;19582.118804653826;7571.167171611119;7873.25204105609;7873.645685944146;7919.722809701748;7969.800754981172;840.3739214285397;887.316766090107;933.7945651956694;1049.7113293844254;1081.3674000709673;26379.604305935427;28467.430651386858;29832.254193644898;31497.52753708696;31674.841625791723;922.7508572685338;979.8726165598426;1001.7245257554085;1016.0905989139826;1065.504540388723;13691.794623080661;13973.650658733613;14008.719825603432;14159.362828672734;14227.78658320126;303256;308023;308072;308686;309724;46119.077618448115;46474;46506.302405463946;46577;46671.5332846674;1214.3199808107488;1222.9633111006863;1224.6081253998634;1225.3689349984766;1231.8090695942144;25318.746812531637;25841.353966150997;26396.07613733587;26421.075262366492;26444.603330949667;38499.615003850726;39410.211795764495;40743.1851362977;41639.37540936949;41716.3742543856;209386;209721;210909;212144;212493;25449.87275063613;25977.350566235997;29016.564751529168;29343.85328073346;29392.11823645294;35676.46485302671;36833.447498288086;37464.250714985;39638.60361396349;41374.58625413707;30620.387592247585;30887;31493.8425307872;31570;31684.83151684813;31381.8430907844;31494.842525787226;31576.684233158292;31663.683363166074;31679.84160079185;31477;31739.68260317367;31923.201919952186;32013.199670008435;32100.518492223102;31798.682013180496;32473.350532988734;34994.475082873265;35382.29235415226;35492.29015419626;23561.528769424174;23598.764012360345;23724.406889827893;23907.16324928619;23945.64081538813 11:06:25 INFO - 2015-12-02 11:06:25,290 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.9655636158202;328.06992177177716;328.1746407784422;333.00431709189525;333.73801565770873;8366.37252206084;8707;10062.446565438908;14866.77699834502;16619.916900415497;12037.699057523567;14289.857101428983;14572.562823115297;15238.161901095464;15278.236088195574;5354.22363757255;5464.9180262296095;5484.561235101182;5490.450954904518;6394.7761828336015;3923.509561304837;4073.5926407359175;6469.8706025879455;6624.171978502687;6641.402273795357;6623.834404139887;6643.568168069084;6644;6655.767048153316;6656.534042617019;6119.082137679339;6120.173776540155;6122.816315510542;6122.938770612282;6349.492040636738;6276.780312689079;6330.430261276461;6422;6437.420632143129;6443.9355606443805;22009.22967696123;22034.11863525457;22106.88946555273;22501.774982250296;22695;1916.8945707986056;1941.7766956799867;1955.1788248935482;2001.3895761792648;2148.3125399872047;13859.722805543934;13930.233837138954;13990.383173552806;14177.503787367496;14200.715985680228;1888.518427800902;1903.3623736048303;1910.2836436336374;1912.5696718238423;1916.1856211110223;57625.42374576285;65337.3466265336;66021.339786602;66135.99999999952;66198.3380166197;15409.84590154084;15592.220388980506;15604.297806598503;15612.843871561367;15616.609584760472;23672.17147399833;23738.169164079176;23894.402639933793;23906.28281151568;23930.40173995629;7910.5649189295145;7986.0816006158875;8010.158933312035;8030.397720170894;8200.220979006985;6552.836179095465;6561.704723287464;6583.934160658428;6592.24189218246;6599;7601.277878601524;7623.275788800166;7625.322429065597;7625.618719064025;7637.618119094023;1657.9005259684457;1689.374931275436;1698.100006996294;2135.8825264610286;2883.596296518489;369.6950016236562;371.8809980806116;382.4091778202683;389.2642904909723;977.731123940922;9455.76360590977;9766.658166964122;13877.37551810171;15043;15836.76244856328;844.7888027993001;869.3914260018013;874.9912500875037;905.9411138275991;912.2610685344891;8750.387472876964;9242.857428474352;9252.861207081765;9306;9349.719508414759;477885;482192;483473;485394;490162;68384;70671;70766;71431;73420.26579734134;1076.7092884921028;1077.2674581284803;1162.5582278734196;1174.723939874129;1175.9235649682744;14255.786163207353;14261.095209325638;14448.349824257723;14588.781168282272;14610.561683149523;29328.85335573394;29817.5527367094;29985.850070749508;29999.70000299969;30286.54570181493;43089.78455107704;43503.78248108739;44161.558384415745;44375;46963;8477.40658153948;8649.1350864913;8785.25325347327;8792.296616270554;8808.383413161017;10282.897171028193;10313.845292320471;11822.763544728885;16052.277647506124;16399.098049607386;13789.172649641054;13847.792283115963;13873.861261387257;14049.719005620034;14093.859061409665;13374.598762037154;13389.799153012518;13430.798538021741;13947.442102315794;14025.228612426006;13636.045476816527;13873.375698093409;14111.929440352733;14473.276336183359;14547.345369458611;8654.22112009922;8661.826763464822;8665.0035245945;8800.47197168172;8988.280937525113;13051.21692698441;13586.45654173822;13685.86314136846;13892.097013694078;14005.929970350084 11:06:25 INFO - 2015-12-02 11:06:25,290 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1203.476487727839;1374.0999645232375;1388.0491863073796;1671.456776547622;1730.4549067043881;6102.17620621216;6383.58506697065;6942.236354001062;7055.329743674356;7058.188308344542;7105.8223544411285;7106.573605583669;7183.066201393812;7192.460565457599;7204.927950720491;2025.2304124432733;2052.2406709517427;2053.5995480881234;2054.6301665700166;2055.1368425261353;2023.5649335392889;2057.5987682401865;2060.4642792873888;2082.323244945399;2082.79172082792;2015.8488113391481;2031.8069783370556;2050.9950124439065;2054;2055.434755442258;2012.1850650486504;2033.4408037789651;2034.3896830950803;2035.6132334856404;2039.5207126325301;1998.3005947918257;2035.4402539301661;2047.7645070816898;2051.3435700575824;2052.0252879882087;6049.062395328687;7099.964500177466;7178;7185.748498802517;7188.13742350916;3681.6134305897763;4013.3177359848896;4151.813168407429;4154.376843473473;4155.252054630166;2615.2285075902655;2617.3849145450804;2672.7594516493414;2681.6647919010124;2718.836869787819;803.0243254445876;808.086861846116;812.8496228197803;845.8435189489902;857.3826844671827;9451.858222126673;9547.665831695927;9558.426494410358;9570.90429095707;9599.904000960041;3836.865709700147;3859.8456061757215;3875.9418608720894;3888.4944957155953;3970.682345412418;8519.318454523624;8528.061913189544;8534.359923005799;8553.700620478254;8555.957220213859;4226.964393723496;4234.78826058702;4237.152569486054;4238.597333253336;4243.7029407941145;3797.3924172132324;3798.2213646202463;3803.1442925341576;3804.087019115392;3805.9343383852565;3296.35721034396;3311.2715202655377;3317.518959750871;3325.6840600142946;3345.0299413170396;1036.1917704190744;1045.5504133222635;1048.224314007629;1048.3919326790444;1051.495282264502;1212.5574165429555;1214.2107630040543;1229.7540491901655;1231.132051903406;1231.6736064942797;6798.728050878009;6808;6866.210385805596;6882.070920425678;6960.199577048603;414.13239263743014;422.2378606615028;423.75422255091974;425.28552032584935;425.62757587111275;4893.779779909913;5350.9732451337495;5394.056040192951;5408.729563521887;5408.864778380572;7619.885701714478;8044.798880028046;8274.710385136492;8321.83494310785;8325.750227493185;8129.349652027942;8162.836743265101;8165.061017982889;8166.060902996232;8172.346212303001;6134.6625935573975;6566.212054553484;6588.604683718896;6624.503162262849;6640.236372817091;6764.2559318475915;6794.592324460548;6795.864082718219;6809.285025072494;6813.591184528944;7312.96343518279;7619.69521219145;7664.080310362792;7664.846703065796;7668;7371.115466144097;7555.206703296295;7606.733764318223;7653.387728981556;7665.463417560717;6188.319284878569;6207.348228435949;6230.813075607739;6267.780627678009;6273.090401891792;6780.796576102724;6792.728290868507;6808.761693340709;6809.795706128824;6840.384365407137;6386.712597933197;6452.7741529048135;6496.967515162394;6599.637019963756;6603.735850566116;6356.491480681627;6367.52243581724;6443.548951573533;6498.935010649833;6518.217813862367;6487.124238227968;6532.738690452328;6545.2800191979795;6553.770618028346;6557.377049180321;6009.579329446897;6060.151578778887;6069.150318955438;6206.813795586139;6226.937730622636;6286.308506064238;6327.3988971047675;6345.270293916259;6346.555741098079;6347.365263473615 11:06:25 INFO - 2015-12-02 11:06:25,293 DEBUG : BROWSER_OUTPUT: |4;prototype.html;286.4085663105687;296.4515646054798;297.97169268919447;305.421226775261;306.4988743404534;5165.457626949173;5234.633575649701;5250.317458730369;5279.524842764151;5370.140777475604;5064.265681476184;5147.81982630608;5203.687778733279;5207.906339668664;5217.269582258477;4120.773357465338;4125.154343359604;4126.649234815044;4133.863187623412;4134.111166099288;3955.6439920407156;4044.635982761551;4060.309747342944;4123.835046598132;4141.440905477767;4111.239420707164;4121.093359460914;4122.4228607994755;4129.050318426764;4139.917201655965;4111.239420707178;4118.588141185887;4120.75275483472;4129.905575022622;4134.937975930364;3648.431174594923;3649.8540058397634;3651.7626354287154;3656.725745569093;3659;4936.160852655022;5054.064997975386;5057.544820966131;5063.341765570489;5123.923141152885;4740.028294199681;4752.405949256343;4756.952430475685;4763.237881938873;4763.404574428197;5575.303087114111;5597.3003374578175;5600.215969764236;5605.607607467479;5615.494605485526;3762.5861155272896;3841.327767640652;3852.6339997700175;3916.686665066788;3945.2701250268506;5764.798232061899;5826.242588463515;5852.385499522574;5852.941470585325;5854.268216472941;4090.6727461802984;4091.3249313863475;4093.0790572121036;4094.201630682048;4094.447249621263;4160.043190066302;4161.126163505698;4161.958380416218;4162.084341444877;4164.146349998243;4588.449386073693;4707.058588282357;4726.291056341576;4733.95266047342;4739.597134243559;5544.528715059185;5544.667319960815;5546.278983732089;5551.472610102034;5555.2222688823595;1456.2936975566843;1474.2776039740666;1474.565003324022;1475.0338528264003;1475.6605980624302;1003.1824063388315;1006.104566935428;1008.1531513528524;1027.085893554737;1027.984580231297;4914.189158788831;4918.508149185053;4921.532454416824;4921.655484116078;4925.990172014728;5761.5102716269585;5763.221965034751;5768.567357448208;5770.807093304517;5772.134179872969;4890.95109048912;4894.535019173244;4895.290182923456;4898.608111351084;4904.975475122602;3029.545568164749;3080.614923134608;3107.440660681099;3108.2695566541843;3118.8596513156963;5559.916601250984;5569.526590239875;5576.581756368208;5579.860503487364;5585.106382978704;5993.970030149909;5994.28068631767;6000.159977603139;6004.0693692477735;6004.7598096076545;5552.056150454432;5569.55443564522;5569.749361278833;5569.777208911598;5572.328301509531;5681.886362272814;5845.8538536535225;5846.41535846412;5848.56135789826;5848.736806843617;5462.426445223195;5546.223528705904;5581.079121944834;5675.545956323402;5683.460071293221;5522.088855338985;5539.806106786243;5549.556035517068;5552.69460179694;5554.527865131509;3939.3697008478507;3959.5248570171766;3964.6630036447227;3966.821493032878;3972.3445631470486;5619.409961953936;5777.653340799566;5813.680247586423;5814;5823.242978412779;5612.130119831432;5614.438556144353;5616.382197958303;5618.073017951992;5622.128570071645;5578.330600327987;5597.076482380362;5615.073512870331;5615.18579805934;5616.4383561645145;5499.230107784833;5502.862428439321;5503.7798488060025;5509.614326997072;5512.5314348280845;5524.530414914777;5641.12562552805;5644.491995720241;5655.971720141373;5659.660420374791;5440.646357986719;5474.343078830566;5474.42518535564;5481.616286859881;5484.095124304445 11:06:25 INFO - 2015-12-02 11:06:25,295 DEBUG : BROWSER_OUTPUT: |5;yui.html;676.5602358466997;695.5930780493411;788.6017561131628;804.4007214625105;807.9838403231936;10957.452127393628;11105.222634415593;11108.888911110897;11183.776324473505;11222.158338124642;10880;11993.460294286757;12169.695757606041;12263.877361226407;12296.323702196398;793.1275596843469;811.4238890387832;811.691557208263;811.7077851973285;811.9025716913949;796.303234669664;802.5385403393043;804.5092493578942;804.6258489802241;804.9074356449024;846.2510678049939;848.2662496940134;848.6478111583716;849.1381248033221;849.2611428057598;837.0415873824497;838.714836955435;838.7316058861167;838.8364268967554;839.1776059461731;622.0110025060176;622.5579838314802;622.6575383539035;624.9062640603901;625.4839757200328;9559.235261179088;9679.274054445945;9687.225021998223;9694.17599504043;9699.224062075016;9700.417974921527;9941.850872236922;10109.797804043952;10210.387376757344;10327.431991240479;8298.668053277861;8402.327813774944;8465;8504.149585041509;8585.270252028586;3213.405519978788;3219.4205043092234;3248.7238584720326;3290.045886692856;3329.8335083245984;33354.83322583372;34013.6598634013;36486;36942.445863312074;39923.20153596912;8794.164554367326;9147.54262286883;9155.176034156957;9232.353735238468;9536.046395360408;15985.520434386986;16017.839821601634;16031.278592463133;16060.357585696442;16099.517014489584;6447.774327898501;6474.870502589922;6521.804345869631;6565.704543295563;6568.277489476154;3593.7843729376323;3614.3857339476867;3630.9092272692865;3652.9634703653155;3697.7781333120097;2769.819961702483;2782.5687018512162;2784.2343355577377;2787.484315401657;2791.413803101331;480.5962991087503;483.7363636817943;491.22386629125896;491.2361278212414;493.2084005171719;515.3277614142132;596.2636144361796;597.5010865927;600.7506884642912;610.4353473037422;7429.702811887572;7474.85050298991;7545.170031296553;7583.2416758323725;7611.581363025087;549.9037668408013;556.9470900264549;576.1760682224376;585.7656937225144;599.3137857153534;3565.893023209308;3672.761270517461;3701.1672373715696;3769.6041915598466;3796.9430458543143;51096;51694;51749.2237616436;51803.74098129485;52039;45016.099678006256;45539;45792.313115303295;45852.3122153168;46070;34957.126071847895;35003;39758;45077.323840142424;45356.54643453523;7865.803354915944;7932.881006785018;7995.080565734782;8113.438723366228;8256.463329883778;31384.84307578539;31930;32236.19409514781;32414.351712965137;33000.834995824865;37292.44061339028;37382.813085934395;39134.412983804694;40744.185116298104;41145.1770964585;10306.896931030593;10335.22485813582;10383.740406489898;10399.27205095636;10414;11000.834987475035;11042.227044106836;11226.270292431293;11692;12066.879331206575;10831.228005737528;11047.392393418118;11055.391953442639;11479.655610331703;11487.13846461502;10834.512446939749;10850.907491364924;11182.049525790399;11236.157288203254;11615.070794336601;10555.94722026385;10639.680809575726;10838.512266947848;10951.288166269167;11014.944925275322;8926.86609700868;9193.816123677356;9222.538873056454;9224.953875230582;9460.621575137193;8611.181937715906;9081.273498120267;9347.345685801929;9497.810043799223;9547.761305967406 11:06:25 INFO - 2015-12-02 11:06:25,295 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:06:25 INFO - 2015-12-02 11:06:25,295 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:06:25 INFO - 2015-12-02 11:06:25,295 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,951 11:06:25 INFO - 2015-12-02 11:06:25,295 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:06:25 INFO - 2015-12-02 11:06:25,296 DEBUG : BROWSER_OUTPUT: __startTimestamp1449083185281__endTimestamp 11:06:25 INFO - 2015-12-02 11:06:25,296 DEBUG : BROWSER_OUTPUT: 11:06:25 INFO - 2015-12-02 11:06:25,296 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:06:25 INFO - 2015-12-02 11:06:25,296 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:06:25 INFO - 2015-12-02 11:06:25,296 DEBUG : BROWSER_OUTPUT: 11:06:25 INFO - 2015-12-02 11:06:25,297 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4634.02 Median:4763.48 stddev:482.51 (10.1%) stddev-sans-first:457.13 11:06:25 INFO - 2015-12-02 11:06:25,298 DEBUG : BROWSER_OUTPUT: Values: 2610.5 2689.1 2691.8 2708.6 2718.5 4624.7 4664.4 4685.0 4730.4 4773.7 4703.0 4711.2 4759.6 4763.2 4763.5 4256.9 4344.7 4351.8 4423.1 4470.6 4157.3 4384.9 4418.3 4441.8 4504.1 4231.9 4237.2 4272.4 4322.6 4362.4 4296.2 4335.4 4336.9 4366.4 4391.5 4170.1 4322.3 4325.7 4328.9 4379.3 4519.9 4565.2 4581.5 4581.9 4630.6 4998.1 5080.6 5081.2 5084.9 5113.3 4894.8 5080.9 5095.1 5112.2 5113.0 4626.6 4651.6 4657.8 4676.8 4738.4 5087.5 5127.4 5128.2 5129.8 5165.1 4782.1 4916.5 4918.0 4918.4 4968.9 4785.3 4878.9 4895.0 4950.8 4980.4 4995.1 5023.0 5024.8 5028.4 5080.0 4977.8 4983.5 4984.0 4986.1 5030.0 4000.5 4058.5 4096.4 4103.4 4147.3 3682.0 3687.0 3706.4 3711.9 3737.3 4376.4 4387.6 4389.8 4394.5 4428.6 4786.1 4886.4 4886.9 5098.6 5126.9 4208.4 4280.1 4296.1 4333.4 4334.6 4465.9 4484.3 4487.8 4488.0 4527.5 4624.1 4739.0 4743.0 4839.7 4846.3 4984.7 5054.8 5068.6 5082.3 5118.3 4809.7 4813.9 4816.0 4816.7 4861.9 4809.5 4909.3 4916.3 4980.0 5018.0 4948.7 5032.9 5044.7 5064.2 5070.6 4876.8 4882.5 4883.2 4885.6 4932.4 4768.5 4893.0 4893.0 4894.2 4895.6 4684.2 4753.5 4753.6 4759.1 4811.5 4935.4 4954.5 4962.9 4971.1 5014.6 4638.0 4750.3 4830.4 4835.3 4883.2 11:06:25 INFO - 2015-12-02 11:06:25,298 DEBUG : BROWSER_OUTPUT: 11:06:25 INFO - 2015-12-02 11:06:25,298 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40732.87 Median:31494.34 stddev:65034.02 (206.5%) stddev-sans-first:65146.53 11:06:25 INFO - 2015-12-02 11:06:25,299 DEBUG : BROWSER_OUTPUT: Values: 564.3 581.5 588.2 591.0 603.8 25537.2 36243.6 36933.6 36938.8 36939.4 40083.8 40306.0 40559.4 40582.8 40598.2 6983.1 7094.8 7908.7 8073.6 8074.4 9700.9 9999.1 10003.5 10005.5 10010.0 10064.7 10170.3 10171.3 10177.3 10177.5 7163.6 7307.6 9988.5 10171.3 10459.0 9864.1 10010.7 10011.8 10012.8 10020.5 28373.4 36863.0 37159.3 37304.0 37371.0 2418.8 2832.8 2886.5 2928.4 2968.2 26974.3 27112.3 27112.3 27160.6 27370.3 3219.0 3272.8 3280.2 3318.5 3407.2 216299.0 217444.0 217565.0 217671.0 217899.0 55230.0 55582.0 55636.7 55754.0 55817.4 48215.8 49341.3 58922.7 59204.0 65437.7 12193.5 12285.7 12353.7 12366.7 12372.7 9868.8 9883.8 9996.8 10000.7 10002.7 19284.1 19499.6 19513.7 19520.4 19582.1 7571.2 7873.3 7873.6 7919.7 7969.8 840.4 887.3 933.8 1049.7 1081.4 26379.6 28467.4 29832.3 31497.5 31674.8 922.8 979.9 1001.7 1016.1 1065.5 13691.8 13973.7 14008.7 14159.4 14227.8 303256.0 308023.0 308072.0 308686.0 309724.0 46119.1 46474.0 46506.3 46577.0 46671.5 1214.3 1223.0 1224.6 1225.4 1231.8 25318.7 25841.4 26396.1 26421.1 26444.6 38499.6 39410.2 40743.2 41639.4 41716.4 209386.0 209721.0 210909.0 212144.0 212493.0 25449.9 25977.4 29016.6 29343.9 29392.1 35676.5 36833.4 37464.3 39638.6 41374.6 30620.4 30887.0 31493.8 31570.0 31684.8 31381.8 31494.8 31576.7 31663.7 31679.8 31477.0 31739.7 31923.2 32013.2 32100.5 31798.7 32473.4 34994.5 35382.3 35492.3 23561.5 23598.8 23724.4 23907.2 23945.6 11:06:25 INFO - 2015-12-02 11:06:25,300 DEBUG : BROWSER_OUTPUT: 11:06:25 INFO - 2015-12-02 11:06:25,300 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27182.34 Median:351.72 stddev:78981.84 (22456.1%) stddev-sans-first:79177.66 11:06:25 INFO - 2015-12-02 11:06:25,301 DEBUG : BROWSER_OUTPUT: Values: 328.0 328.1 328.2 333.0 333.7 8366.4 8707.0 10062.4 14866.8 16619.9 12037.7 14289.9 14572.6 15238.2 15278.2 5354.2 5464.9 5484.6 5490.5 6394.8 3923.5 4073.6 6469.9 6624.2 6641.4 6623.8 6643.6 6644.0 6655.8 6656.5 6119.1 6120.2 6122.8 6122.9 6349.5 6276.8 6330.4 6422.0 6437.4 6443.9 22009.2 22034.1 22106.9 22501.8 22695.0 1916.9 1941.8 1955.2 2001.4 2148.3 13859.7 13930.2 13990.4 14177.5 14200.7 1888.5 1903.4 1910.3 1912.6 1916.2 57625.4 65337.3 66021.3 66136.0 66198.3 15409.8 15592.2 15604.3 15612.8 15616.6 23672.2 23738.2 23894.4 23906.3 23930.4 7910.6 7986.1 8010.2 8030.4 8200.2 6552.8 6561.7 6583.9 6592.2 6599.0 7601.3 7623.3 7625.3 7625.6 7637.6 1657.9 1689.4 1698.1 2135.9 2883.6 369.7 371.9 382.4 389.3 977.7 9455.8 9766.7 13877.4 15043.0 15836.8 844.8 869.4 875.0 905.9 912.3 8750.4 9242.9 9252.9 9306.0 9349.7 477885.0 482192.0 483473.0 485394.0 490162.0 68384.0 70671.0 70766.0 71431.0 73420.3 1076.7 1077.3 1162.6 1174.7 1175.9 14255.8 14261.1 14448.3 14588.8 14610.6 29328.9 29817.6 29985.9 29999.7 30286.5 43089.8 43503.8 44161.6 44375.0 46963.0 8477.4 8649.1 8785.3 8792.3 8808.4 10282.9 10313.8 11822.8 16052.3 16399.1 13789.2 13847.8 13873.9 14049.7 14093.9 13374.6 13389.8 13430.8 13947.4 14025.2 13636.0 13873.4 14111.9 14473.3 14547.3 8654.2 8661.8 8665.0 8800.5 8988.3 13051.2 13586.5 13685.9 13892.1 14005.9 11:06:25 INFO - 2015-12-02 11:06:25,301 DEBUG : BROWSER_OUTPUT: 11:06:25 INFO - 2015-12-02 11:06:25,302 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4941.55 Median:6249.30 stddev:2581.05 (41.3%) stddev-sans-first:2572.99 11:06:25 INFO - 2015-12-02 11:06:25,302 DEBUG : BROWSER_OUTPUT: Values: 1203.5 1374.1 1388.0 1671.5 1730.5 6102.2 6383.6 6942.2 7055.3 7058.2 7105.8 7106.6 7183.1 7192.5 7204.9 2025.2 2052.2 2053.6 2054.6 2055.1 2023.6 2057.6 2060.5 2082.3 2082.8 2015.8 2031.8 2051.0 2054.0 2055.4 2012.2 2033.4 2034.4 2035.6 2039.5 1998.3 2035.4 2047.8 2051.3 2052.0 6049.1 7100.0 7178.0 7185.7 7188.1 3681.6 4013.3 4151.8 4154.4 4155.3 2615.2 2617.4 2672.8 2681.7 2718.8 803.0 808.1 812.8 845.8 857.4 9451.9 9547.7 9558.4 9570.9 9599.9 3836.9 3859.8 3875.9 3888.5 3970.7 8519.3 8528.1 8534.4 8553.7 8556.0 4227.0 4234.8 4237.2 4238.6 4243.7 3797.4 3798.2 3803.1 3804.1 3805.9 3296.4 3311.3 3317.5 3325.7 3345.0 1036.2 1045.6 1048.2 1048.4 1051.5 1212.6 1214.2 1229.8 1231.1 1231.7 6798.7 6808.0 6866.2 6882.1 6960.2 414.1 422.2 423.8 425.3 425.6 4893.8 5351.0 5394.1 5408.7 5408.9 7619.9 8044.8 8274.7 8321.8 8325.8 8129.3 8162.8 8165.1 8166.1 8172.3 6134.7 6566.2 6588.6 6624.5 6640.2 6764.3 6794.6 6795.9 6809.3 6813.6 7313.0 7619.7 7664.1 7664.8 7668.0 7371.1 7555.2 7606.7 7653.4 7665.5 6188.3 6207.3 6230.8 6267.8 6273.1 6780.8 6792.7 6808.8 6809.8 6840.4 6386.7 6452.8 6497.0 6599.6 6603.7 6356.5 6367.5 6443.5 6498.9 6518.2 6487.1 6532.7 6545.3 6553.8 6557.4 6009.6 6060.2 6069.2 6206.8 6226.9 6286.3 6327.4 6345.3 6346.6 6347.4 11:06:25 INFO - 2015-12-02 11:06:25,302 DEBUG : BROWSER_OUTPUT: 11:06:25 INFO - 2015-12-02 11:06:25,302 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4644.95 Median:5135.87 stddev:1356.20 (26.4%) stddev-sans-first:1319.96 11:06:25 INFO - 2015-12-02 11:06:25,304 DEBUG : BROWSER_OUTPUT: Values: 286.4 296.5 298.0 305.4 306.5 5165.5 5234.6 5250.3 5279.5 5370.1 5064.3 5147.8 5203.7 5207.9 5217.3 4120.8 4125.2 4126.6 4133.9 4134.1 3955.6 4044.6 4060.3 4123.8 4141.4 4111.2 4121.1 4122.4 4129.1 4139.9 4111.2 4118.6 4120.8 4129.9 4134.9 3648.4 3649.9 3651.8 3656.7 3659.0 4936.2 5054.1 5057.5 5063.3 5123.9 4740.0 4752.4 4757.0 4763.2 4763.4 5575.3 5597.3 5600.2 5605.6 5615.5 3762.6 3841.3 3852.6 3916.7 3945.3 5764.8 5826.2 5852.4 5852.9 5854.3 4090.7 4091.3 4093.1 4094.2 4094.4 4160.0 4161.1 4162.0 4162.1 4164.1 4588.4 4707.1 4726.3 4734.0 4739.6 5544.5 5544.7 5546.3 5551.5 5555.2 1456.3 1474.3 1474.6 1475.0 1475.7 1003.2 1006.1 1008.2 1027.1 1028.0 4914.2 4918.5 4921.5 4921.7 4926.0 5761.5 5763.2 5768.6 5770.8 5772.1 4891.0 4894.5 4895.3 4898.6 4905.0 3029.5 3080.6 3107.4 3108.3 3118.9 5559.9 5569.5 5576.6 5579.9 5585.1 5994.0 5994.3 6000.2 6004.1 6004.8 5552.1 5569.6 5569.7 5569.8 5572.3 5681.9 5845.9 5846.4 5848.6 5848.7 5462.4 5546.2 5581.1 5675.5 5683.5 5522.1 5539.8 5549.6 5552.7 5554.5 3939.4 3959.5 3964.7 3966.8 3972.3 5619.4 5777.7 5813.7 5814.0 5823.2 5612.1 5614.4 5616.4 5618.1 5622.1 5578.3 5597.1 5615.1 5615.2 5616.4 5499.2 5502.9 5503.8 5509.6 5512.5 5524.5 5641.1 5644.5 5656.0 5659.7 5440.6 5474.3 5474.4 5481.6 5484.1 11:06:25 INFO - 2015-12-02 11:06:25,304 DEBUG : BROWSER_OUTPUT: 11:06:25 INFO - 2015-12-02 11:06:25,304 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12121.12 Median:491.23 stddev:13815.35 (2812.4%) stddev-sans-first:13827.37 11:06:25 INFO - 2015-12-02 11:06:25,305 DEBUG : BROWSER_OUTPUT: Values: 676.6 695.6 788.6 804.4 808.0 10957.5 11105.2 11108.9 11183.8 11222.2 10880.0 11993.5 12169.7 12263.9 12296.3 793.1 811.4 811.7 811.7 811.9 796.3 802.5 804.5 804.6 804.9 846.3 848.3 848.6 849.1 849.3 837.0 838.7 838.7 838.8 839.2 622.0 622.6 622.7 624.9 625.5 9559.2 9679.3 9687.2 9694.2 9699.2 9700.4 9941.9 10109.8 10210.4 10327.4 8298.7 8402.3 8465.0 8504.1 8585.3 3213.4 3219.4 3248.7 3290.0 3329.8 33354.8 34013.7 36486.0 36942.4 39923.2 8794.2 9147.5 9155.2 9232.4 9536.0 15985.5 16017.8 16031.3 16060.4 16099.5 6447.8 6474.9 6521.8 6565.7 6568.3 3593.8 3614.4 3630.9 3653.0 3697.8 2769.8 2782.6 2784.2 2787.5 2791.4 480.6 483.7 491.2 491.2 493.2 515.3 596.3 597.5 600.8 610.4 7429.7 7474.9 7545.2 7583.2 7611.6 549.9 556.9 576.2 585.8 599.3 3565.9 3672.8 3701.2 3769.6 3796.9 51096.0 51694.0 51749.2 51803.7 52039.0 45016.1 45539.0 45792.3 45852.3 46070.0 34957.1 35003.0 39758.0 45077.3 45356.5 7865.8 7932.9 7995.1 8113.4 8256.5 31384.8 31930.0 32236.2 32414.4 33000.8 37292.4 37382.8 39134.4 40744.2 41145.2 10306.9 10335.2 10383.7 10399.3 10414.0 11000.8 11042.2 11226.3 11692.0 12066.9 10831.2 11047.4 11055.4 11479.7 11487.1 10834.5 10850.9 11182.0 11236.2 11615.1 10555.9 10639.7 10838.5 10951.3 11014.9 8926.9 9193.8 9222.5 9225.0 9460.6 8611.2 9081.3 9347.3 9497.8 9547.8 11:06:25 INFO - 2015-12-02 11:06:25,305 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:06:25 INFO - 2015-12-02 11:06:25,305 DEBUG : BROWSER_OUTPUT: 11:06:26 INFO - 2015-12-02 11:06:26,108 INFO : Browser exited with error code: 0 11:06:26 INFO - 2015-12-02 11:06:26,129 INFO : Completed test dromaeo_css (00:18:39) 11:06:26 INFO - 2015-12-02 11:06:26,129 INFO : Starting test kraken 11:06:26 INFO - 2015-12-02 11:06:26,129 DEBUG : operating with platform_type : linux_ 11:06:26 INFO - 2015-12-02 11:06:26,129 INFO : Initialising browser for kraken test... 11:06:26 INFO - 2015-12-02 11:06:26,136 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3FjVcx/profile http://localhost:53893/getInfo.html 11:06:31 INFO - 2015-12-02 11:06:31,594 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:06:31 INFO - 2015-12-02 11:06:31,594 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:06:31 INFO - 2015-12-02 11:06:31,594 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:06:31 INFO - 2015-12-02 11:06:31,594 DEBUG : BROWSER_OUTPUT: __metrics 11:06:31 INFO - 2015-12-02 11:06:31,716 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] 11:06:31 INFO - 2015-12-02 11:06:31,716 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:31 ERROR - 2015-12-02 11:06:31,784 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 11:06:32 INFO - 2015-12-02 11:06:32,756 INFO : Browser initialized. 11:06:32 INFO - 2015-12-02 11:06:32,756 INFO : Running cycle 1/1 for kraken test... 11:06:32 INFO - 2015-12-02 11:06:32,756 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3FjVcx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:06:44 INFO - 2015-12-02 11:06:44,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 142659584 11:06:44 INFO - 2015-12-02 11:06:44,840 DEBUG : BROWSER_OUTPUT: 11:06:47 INFO - 2015-12-02 11:06:47,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53893/tests/kraken/driver.html?testName=audio-beat-detection) 11:06:48 INFO - 2015-12-02 11:06:48,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 183865344 11:06:48 INFO - 2015-12-02 11:06:48,007 DEBUG : BROWSER_OUTPUT: 11:06:50 INFO - 2015-12-02 11:06:50,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53893/tests/kraken/driver.html?testName=audio-dft) 11:06:51 INFO - 2015-12-02 11:06:51,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 170401792 11:06:51 INFO - 2015-12-02 11:06:51,257 DEBUG : BROWSER_OUTPUT: 11:06:54 INFO - 2015-12-02 11:06:54,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53893/tests/kraken/driver.html?testName=audio-fft) 11:06:54 INFO - 2015-12-02 11:06:54,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 155037696 11:06:54 INFO - 2015-12-02 11:06:54,788 DEBUG : BROWSER_OUTPUT: 11:06:56 INFO - 2015-12-02 11:06:56,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53893/tests/kraken/driver.html?testName=audio-oscillator) 11:06:57 INFO - 2015-12-02 11:06:57,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 157483008 11:06:57 INFO - 2015-12-02 11:06:57,413 DEBUG : BROWSER_OUTPUT: 11:06:59 INFO - 2015-12-02 11:06:59,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53893/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:07:00 INFO - 2015-12-02 11:07:00,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 158093312 11:07:00 INFO - 2015-12-02 11:07:00,237 DEBUG : BROWSER_OUTPUT: 11:07:03 INFO - 2015-12-02 11:07:03,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53893/tests/kraken/driver.html?testName=imaging-darkroom) 11:07:03 INFO - 2015-12-02 11:07:03,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 156741632 11:07:03 INFO - 2015-12-02 11:07:03,819 DEBUG : BROWSER_OUTPUT: 11:07:07 INFO - 2015-12-02 11:07:07,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53893/tests/kraken/driver.html?testName=imaging-desaturate) 11:07:07 INFO - 2015-12-02 11:07:07,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 158240768 11:07:07 INFO - 2015-12-02 11:07:07,875 DEBUG : BROWSER_OUTPUT: 11:07:10 INFO - 2015-12-02 11:07:10,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53893/tests/kraken/driver.html?testName=json-parse-financial) 11:07:11 INFO - 2015-12-02 11:07:11,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 157249536 11:07:11 INFO - 2015-12-02 11:07:11,282 DEBUG : BROWSER_OUTPUT: 11:07:13 INFO - 2015-12-02 11:07:13,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53893/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:07:13 INFO - 2015-12-02 11:07:13,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 168419328 11:07:13 INFO - 2015-12-02 11:07:13,613 DEBUG : BROWSER_OUTPUT: 11:07:15 INFO - 2015-12-02 11:07:15,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53893/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:07:16 INFO - 2015-12-02 11:07:16,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 167309312 11:07:16 INFO - 2015-12-02 11:07:16,090 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-02 11:07:18,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53893/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:07:18 INFO - 2015-12-02 11:07:18,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 181243904 11:07:18 INFO - 2015-12-02 11:07:18,815 DEBUG : BROWSER_OUTPUT: 11:07:21 INFO - 2015-12-02 11:07:21,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:07:21 INFO - 2015-12-02 11:07:21,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 186892288 11:07:21 INFO - 2015-12-02 11:07:21,952 DEBUG : BROWSER_OUTPUT: 11:07:24 INFO - 2015-12-02 11:07:24,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:07:25 INFO - 2015-12-02 11:07:25,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 184958976 11:07:25 INFO - 2015-12-02 11:07:25,161 DEBUG : BROWSER_OUTPUT: 11:07:26 INFO - 2015-12-02 11:07:26,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53893/tests/kraken/driver.html?testName=ai-astar) 11:07:27 INFO - 2015-12-02 11:07:27,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 241446912 11:07:27 INFO - 2015-12-02 11:07:27,167 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,169 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:07:27 INFO - 2015-12-02 11:07:27,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:07:27 INFO - 2015-12-02 11:07:27,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:07:27 INFO - 2015-12-02 11:07:27,169 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:07:27 INFO - 2015-12-02 11:07:27,170 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;112;103;110;110;111;99;111;111;101 11:07:27 INFO - 2015-12-02 11:07:27,170 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;127;153;162;130;155;154;129;170;129 11:07:27 INFO - 2015-12-02 11:07:27,170 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;161;163;161;162;163;161;162 11:07:27 INFO - 2015-12-02 11:07:27,170 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;78;88;93;72;71;72;103;86;72 11:07:27 INFO - 2015-12-02 11:07:27,171 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;132;94;94;95;135;95;96;130 11:07:27 INFO - 2015-12-02 11:07:27,171 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;110;110;110;112;109 11:07:27 INFO - 2015-12-02 11:07:27,171 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;147;147;147;147;146;146 11:07:27 INFO - 2015-12-02 11:07:27,171 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;96;95;95;95;95 11:07:27 INFO - 2015-12-02 11:07:27,171 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;75;71;71;69;70;70;71;75;68 11:07:27 INFO - 2015-12-02 11:07:27,172 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;69;70;69;69;69;69 11:07:27 INFO - 2015-12-02 11:07:27,172 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;92;84;84;83;84;85;84;83 11:07:27 INFO - 2015-12-02 11:07:27,172 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;122;124;134;125;117;123;128;121;128 11:07:27 INFO - 2015-12-02 11:07:27,172 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;147;148;150;146;137;145;145;143;137 11:07:27 INFO - 2015-12-02 11:07:27,172 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;69;69;70;69;68;68;68;68 11:07:27 INFO - 2015-12-02 11:07:27,172 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:07:27 INFO - 2015-12-02 11:07:27,173 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:07:27 INFO - 2015-12-02 11:07:27,173 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1005 11:07:27 INFO - 2015-12-02 11:07:27,173 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:07:27 INFO - 2015-12-02 11:07:27,173 DEBUG : BROWSER_OUTPUT: __startTimestamp1449083247168__endTimestamp 11:07:27 INFO - 2015-12-02 11:07:27,173 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,176 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:111.00 stddev:4.77 (4.3%) stddev-sans-first:5.05 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: Values: 108.0 112.0 103.0 110.0 110.0 111.0 99.0 111.0 111.0 101.0 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.70 Median:154.50 stddev:16.19 (10.5%) stddev-sans-first:16.65 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: Values: 158.0 127.0 153.0 162.0 130.0 155.0 154.0 129.0 170.0 129.0 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 161.0 163.0 161.0 162.0 163.0 161.0 162.0 11:07:27 INFO - 2015-12-02 11:07:27,177 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:11.32 (15.1%) stddev-sans-first:11.46 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: Values: 71.0 78.0 88.0 93.0 72.0 71.0 72.0 103.0 86.0 72.0 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:18.29 (19.5%) stddev-sans-first:18.89 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 132.0 94.0 94.0 95.0 135.0 95.0 96.0 130.0 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 112.0 109.0 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 146.0 11:07:27 INFO - 2015-12-02 11:07:27,178 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.00 Median:71.00 stddev:2.31 (3.3%) stddev-sans-first:2.42 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: Values: 70.0 75.0 71.0 71.0 69.0 70.0 70.0 71.0 75.0 68.0 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 69.0 70.0 69.0 69.0 69.0 69.0 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.80 (3.3%) stddev-sans-first:2.83 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 92.0 84.0 84.0 83.0 84.0 85.0 84.0 83.0 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:126.50 stddev:5.03 (4.0%) stddev-sans-first:4.90 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: Values: 131.0 122.0 124.0 134.0 125.0 117.0 123.0 128.0 121.0 128.0 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,179 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:145.50 stddev:4.30 (3.0%) stddev-sans-first:4.55 11:07:27 INFO - 2015-12-02 11:07:27,180 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 148.0 150.0 146.0 137.0 145.0 145.0 143.0 137.0 11:07:27 INFO - 2015-12-02 11:07:27,180 DEBUG : BROWSER_OUTPUT: 11:07:27 INFO - 2015-12-02 11:07:27,180 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 11:07:27 INFO - 2015-12-02 11:07:27,180 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 70.0 69.0 68.0 68.0 68.0 68.0 11:07:27 INFO - 2015-12-02 11:07:27,180 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:07:27 INFO - 2015-12-02 11:07:27,180 DEBUG : BROWSER_OUTPUT: 11:07:28 INFO - 2015-12-02 11:07:28,120 INFO : Browser exited with error code: 0 11:07:28 INFO - 2015-12-02 11:07:28,173 INFO : Completed test kraken (00:01:02) 11:07:28 INFO - 2015-12-02 11:07:28,173 INFO : Starting test v8_7 11:07:28 INFO - 2015-12-02 11:07:28,173 DEBUG : operating with platform_type : linux_ 11:07:28 INFO - 2015-12-02 11:07:28,173 INFO : Initialising browser for v8_7 test... 11:07:28 INFO - 2015-12-02 11:07:28,179 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvS2q5p/profile http://localhost:53893/getInfo.html 11:07:33 INFO - 2015-12-02 11:07:33,110 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:07:33 INFO - 2015-12-02 11:07:33,110 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:07:33 INFO - 2015-12-02 11:07:33,110 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:07:33 INFO - 2015-12-02 11:07:33,110 DEBUG : BROWSER_OUTPUT: __metrics 11:07:33 INFO - 2015-12-02 11:07:33,393 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] 11:07:33 INFO - 2015-12-02 11:07:33,394 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:07:34 INFO - 2015-12-02 11:07:34,800 INFO : Browser initialized. 11:07:34 INFO - 2015-12-02 11:07:34,800 INFO : Running cycle 1/1 for v8_7 test... 11:07:34 INFO - 2015-12-02 11:07:34,801 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvS2q5p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:07:46 INFO - 2015-12-02 11:07:46,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 143298560 11:07:46 INFO - 2015-12-02 11:07:46,840 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53893/tests/v8_7/run.html (next: http://localhost:53893/tests/v8_7/run.html) 11:08:08 INFO - 2015-12-02 11:08:08,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 447758336 11:08:08 INFO - 2015-12-02 11:08:08,555 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,556 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:08:08 INFO - 2015-12-02 11:08:08,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:08:08 INFO - 2015-12-02 11:08:08,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:08:08 INFO - 2015-12-02 11:08:08,556 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:08:08 INFO - 2015-12-02 11:08:08,556 DEBUG : BROWSER_OUTPUT: |0;Richards;166.14055490945339 11:08:08 INFO - 2015-12-02 11:08:08,557 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.56318426424198 11:08:08 INFO - 2015-12-02 11:08:08,557 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 11:08:08 INFO - 2015-12-02 11:08:08,557 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 11:08:08 INFO - 2015-12-02 11:08:08,557 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 11:08:08 INFO - 2015-12-02 11:08:08,557 DEBUG : BROWSER_OUTPUT: |5;Earley;783.0853563038371 11:08:08 INFO - 2015-12-02 11:08:08,558 DEBUG : BROWSER_OUTPUT: |6;Boyer;12060.240963855422 11:08:08 INFO - 2015-12-02 11:08:08,558 DEBUG : BROWSER_OUTPUT: |7;RegExp;26128.20512820513 11:08:08 INFO - 2015-12-02 11:08:08,558 DEBUG : BROWSER_OUTPUT: |8;Splay;636.5372374283895 11:08:08 INFO - 2015-12-02 11:08:08,558 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 11:08:08 INFO - 2015-12-02 11:08:08,558 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:08:08 INFO - 2015-12-02 11:08:08,558 DEBUG : BROWSER_OUTPUT: __startTimestamp1449083288555__endTimestamp 11:08:08 INFO - 2015-12-02 11:08:08,558 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,560 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:08:08 INFO - 2015-12-02 11:08:08,560 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:08:08 INFO - 2015-12-02 11:08:08,560 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,560 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.14 Median:166.14 stddev:0.00 (0.0%) 11:08:08 INFO - 2015-12-02 11:08:08,560 DEBUG : BROWSER_OUTPUT: Values: 166.1 11:08:08 INFO - 2015-12-02 11:08:08,561 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,561 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.56 Median:185.56 stddev:0.00 (0.0%) 11:08:08 INFO - 2015-12-02 11:08:08,561 DEBUG : BROWSER_OUTPUT: Values: 185.6 11:08:08 INFO - 2015-12-02 11:08:08,561 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,561 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 11:08:08 INFO - 2015-12-02 11:08:08,562 DEBUG : BROWSER_OUTPUT: Values: 278.1 11:08:08 INFO - 2015-12-02 11:08:08,562 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,562 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 11:08:08 INFO - 2015-12-02 11:08:08,562 DEBUG : BROWSER_OUTPUT: Values: 5138.5 11:08:08 INFO - 2015-12-02 11:08:08,562 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,563 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 11:08:08 INFO - 2015-12-02 11:08:08,563 DEBUG : BROWSER_OUTPUT: Values: 1986.1 11:08:08 INFO - 2015-12-02 11:08:08,563 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,563 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 11:08:08 INFO - 2015-12-02 11:08:08,563 DEBUG : BROWSER_OUTPUT: Values: 783.1 11:08:08 INFO - 2015-12-02 11:08:08,563 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,563 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12060.24 Median:12060.24 stddev:0.00 (0.0%) 11:08:08 INFO - 2015-12-02 11:08:08,563 DEBUG : BROWSER_OUTPUT: Values: 12060.2 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26128.21 Median:26128.21 stddev:0.00 (0.0%) 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: Values: 26128.2 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:636.54 Median:636.54 stddev:0.00 (0.0%) 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: Values: 636.5 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: Values: 4840.6 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:08:08 INFO - 2015-12-02 11:08:08,564 DEBUG : BROWSER_OUTPUT: 11:08:09 INFO - 2015-12-02 11:08:09,489 INFO : Browser exited with error code: 0 11:08:09 INFO - 2015-12-02 11:08:09,503 INFO : Completed test v8_7 (00:00:41) 11:08:09 INFO - 2015-12-02 11:08:09,511 INFO : Completed test suite (00:20:22) 11:08:09 INFO - 2015-12-02 11:08:09,511 DEBUG : Working with test: dromaeo_css 11:08:09 INFO - 2015-12-02 11:08:09,512 DEBUG : Generating results file: dromaeo_css 11:08:09 INFO - 2015-12-02 11:08:09,513 DEBUG : Working with test: kraken 11:08:09 INFO - 2015-12-02 11:08:09,513 DEBUG : Generating results file: kraken 11:08:09 INFO - 2015-12-02 11:08:09,513 INFO : javascript benchmark 11:08:09 INFO - 2015-12-02 11:08:09,513 DEBUG : Working with test: v8_7 11:08:09 INFO - 2015-12-02 11:08:09,513 DEBUG : Generating results file: v8_7 11:08:09 INFO - 2015-12-02 11:08:09,514 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:08:09 INFO - 2015-12-02 11:08:09,564 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:08:09 INFO - 2015-12-02 11:08:09,564 DEBUG : process_Request line: dromaeo_css 6373.01 graph.html#tests=[[72,132,35]] 11:08:09 INFO - 2015-12-02 11:08:09,564 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:08:09 INFO - 2015-12-02 11:08:09,591 DEBUG : process_Request line: kraken 1517.00 graph.html#tests=[[232,132,35]] 11:08:09 INFO - 2015-12-02 11:08:09,591 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:08:09 INFO - 2015-12-02 11:08:09,625 DEBUG : process_Request line: v8_7 19819.92 graph.html#tests=[[230,132,35]] 11:08:09 INFO - 2015-12-02 11:08:09,627 INFO : javascript benchmark 11:08:09 INFO - 2015-12-02 11:08:09,630 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2610.4518051209243, 2689.085710858309, 2691.825031372962, 2708.64787577615, 2718.537848565744, 4624.699394539352, 4664.3703100081475, 4684.9765751171235, 4730.432348118222, 4773.665843390955, 4703.012367402849, 4711.175544279746, 4759.571638552529, 4763.214069678507, 4763.476017638066, 4256.914861702764, 4344.695871289011, 4351.825926962918, 4423.093265880487, 4470.552944705536, 4157.251694694954, 4384.868453946387, 4418.3372494125815, 4441.800118994637, 4504.121696269229, 4231.91536169278, 4237.152569486099, 4272.359146128075, 4322.589354011364, 4362.411074504965, 4296.2481565725875, 4335.436393268887, 4336.891577710582, 4366.366876802877, 4391.451068616423, 4170.124273902454, 4322.265214913441, 4325.697201195918, 4328.935065974013, 4379.255526560492, 4519.909601807978, 4565.223911934979, 4581.4502259728715, 4581.908361832778, 4630.560096790799, 4998.10034193845, 5080.61895357846, 5081.237814327844, 5084.949150508484, 5113.258577506278, 4894.804207831682, 5080.872978175538, 5095.082885080684, 5112.156494178456, 5112.974435127838, 4626.583607475343, 4651.5813576778255, 4657.813687452532, 4676.789544470507, 4738.360321356573, 5087.516685914832, 5127.3847138343635, 5128.153854614022, 5129.846104616868, 5165.070287348313, 4782.0914026334885, 4916.532929371704, 4917.975410122926, 4918.409790825124, 4968.925466118011, 4785.3300537924715, 4878.926816097762, 4894.975525122423, 4950.8267210647455, 4980.427250866124, 4995.125852975715, 5023.0, 5024.824131155392, 5028.371453568304, 5080.009398167395, 4977.776000080005, 4983.50164983506, 4983.975080124576, 4986.127427700138, 5029.974850125799, 4000.459937908345, 4058.492688413948, 4096.365063415175, 4103.363978583325, 4147.274227010261, 3682.0426689061037, 3686.963130368662, 3706.4069748840056, 3711.9443208351895, 3737.32728108943, 4376.431063961728, 4387.583179597933, 4389.846355377546, 4394.494633117169, 4428.579284967923, 4786.0667169901535, 4886.438059623118, 4886.902261954741, 5098.643094983389, 5126.948730512721, 4208.38978348144, 4280.058387154821, 4296.0978194578865, 4333.414988976511, 4334.566543345641, 4465.866024019285, 4484.260097084009, 4487.798049087799, 4488.0126372198065, 4527.479339875957, 4624.098300831306, 4739.028499157595, 4742.952570474389, 4839.733814640158, 4846.321514987904, 4984.651074424755, 5054.82308119214, 5068.594512438923, 5082.313887625123, 5118.257852611425, 4809.711417314972, 4813.879653008703, 4816.0, 4816.735079570657, 4861.854144375674, 4809.5430934061205, 4909.3126962224605, 4916.311716359784, 4979.950200497949, 5018.0, 4948.653594248368, 5032.924506132485, 5044.747762611782, 5064.18972964324, 5070.645054846125, 4876.756162191805, 4882.487338829372, 4883.218685010382, 4885.560299573055, 4932.358793356841, 4768.4754676986195, 4892.951070489249, 4892.951070489249, 4894.2169252920785, 4895.583875370491, 4684.156851766715, 4753.453352864327, 4753.619710423227, 4759.143354196278, 4811.470738218723, 4935.407751069894, 4954.529319714621, 4962.851114466572, 4971.130052240771, 5014.623903207347, 4637.953620463887, 4750.263709125091, 4830.396200474941, 4835.274708793709, 4883.243097319921], "unit": "ms", "name": "dojo.html", "value": 4604.020605386929}, {"lowerIsBetter": false, "replicates": [564.3002676680917, 581.546393812826, 588.1765528260433, 590.9793157239498, 603.7826382502299, 25537.233882983517, 36243.63756362439, 36933.63066369335, 36938.81530592347, 36939.4459083114, 40083.799581002124, 40306.0, 40559.39160912589, 40582.7970860146, 40598.188036239255, 6983.127109111361, 7094.7871563852905, 7908.723194688201, 8073.596320183997, 8074.394420418463, 9700.854487182698, 9999.10008099271, 10003.499825008757, 10005.54975026122, 10010.04904534068, 10064.74838129049, 10170.288079834414, 10171.288009839314, 10177.26986412308, 10177.491125443697, 7163.606001669906, 7307.634618269065, 9988.500574971222, 10171.288009839314, 10459.0, 9864.062914023156, 10010.749731256705, 10011.799764004752, 10012.849807252824, 10020.549075291628, 28373.432531349463, 36863.0, 37159.256814863824, 37304.0, 37371.0, 2418.830681852271, 2832.8017038807293, 2886.4515742008953, 2928.3996780659913, 2968.2134234427895, 26974.325641858915, 27112.32219194516, 27112.32219194516, 27160.592591111148, 27370.33703171399, 3218.9678103218903, 3272.8363581820813, 3280.1799550112473, 3318.5188147718445, 3407.16524451511, 216299.0, 217444.0, 217565.0, 217670.99999999843, 217899.0, 55230.0, 55582.0, 55636.72181639066, 55754.0, 55817.44182558123, 48215.75892120517, 49341.25988110181, 58922.70538647279, 59204.0, 65437.67281163659, 12193.45129469176, 12285.69285767845, 12353.691157721129, 12366.690832729073, 12372.690682733004, 9868.753281167885, 9883.802323953625, 9996.750081247881, 10000.699979000641, 10002.699919002442, 19284.1322140504, 19499.61000780005, 19513.707294390595, 19520.41438756811, 19582.118804653826, 7571.167171611119, 7873.25204105609, 7873.645685944146, 7919.722809701748, 7969.800754981172, 840.3739214285397, 887.316766090107, 933.7945651956694, 1049.7113293844254, 1081.3674000709673, 26379.604305935427, 28467.430651386858, 29832.254193644898, 31497.52753708696, 31674.841625791723, 922.7508572685338, 979.8726165598426, 1001.7245257554085, 1016.0905989139826, 1065.504540388723, 13691.794623080661, 13973.650658733613, 14008.719825603432, 14159.362828672734, 14227.78658320126, 303256.0, 308023.0, 308072.0, 308686.0, 309724.0, 46119.077618448115, 46474.0, 46506.302405463946, 46577.0, 46671.5332846674, 1214.3199808107488, 1222.9633111006863, 1224.6081253998634, 1225.3689349984766, 1231.8090695942144, 25318.746812531637, 25841.353966150997, 26396.07613733587, 26421.075262366492, 26444.603330949667, 38499.615003850726, 39410.211795764495, 40743.1851362977, 41639.37540936949, 41716.3742543856, 209386.0, 209721.0, 210909.0, 212144.0, 212493.0, 25449.87275063613, 25977.350566235997, 29016.564751529168, 29343.85328073346, 29392.11823645294, 35676.46485302671, 36833.447498288086, 37464.250714985, 39638.60361396349, 41374.58625413707, 30620.387592247585, 30887.0, 31493.8425307872, 31570.0, 31684.83151684813, 31381.8430907844, 31494.842525787226, 31576.684233158292, 31663.683363166074, 31679.84160079185, 31477.0, 31739.68260317367, 31923.201919952186, 32013.199670008435, 32100.518492223102, 31798.682013180496, 32473.350532988734, 34994.475082873265, 35382.29235415226, 35492.29015419626, 23561.528769424174, 23598.764012360345, 23724.406889827893, 23907.16324928619, 23945.64081538813], "unit": "ms", "name": "ext.html", "value": 17144.01148384063}, {"lowerIsBetter": false, "replicates": [327.9655636158202, 328.06992177177716, 328.1746407784422, 333.00431709189525, 333.73801565770873, 8366.37252206084, 8707.0, 10062.446565438908, 14866.77699834502, 16619.916900415497, 12037.699057523567, 14289.857101428983, 14572.562823115297, 15238.161901095464, 15278.236088195574, 5354.22363757255, 5464.9180262296095, 5484.561235101182, 5490.450954904518, 6394.7761828336015, 3923.509561304837, 4073.5926407359175, 6469.8706025879455, 6624.171978502687, 6641.402273795357, 6623.834404139887, 6643.568168069084, 6644.0, 6655.767048153316, 6656.534042617019, 6119.082137679339, 6120.173776540155, 6122.816315510542, 6122.938770612282, 6349.492040636738, 6276.780312689079, 6330.430261276461, 6422.0, 6437.420632143129, 6443.9355606443805, 22009.22967696123, 22034.11863525457, 22106.88946555273, 22501.774982250296, 22695.0, 1916.8945707986056, 1941.7766956799867, 1955.1788248935482, 2001.3895761792648, 2148.3125399872047, 13859.722805543934, 13930.233837138954, 13990.383173552806, 14177.503787367496, 14200.715985680228, 1888.518427800902, 1903.3623736048303, 1910.2836436336374, 1912.5696718238423, 1916.1856211110223, 57625.42374576285, 65337.3466265336, 66021.339786602, 66135.99999999952, 66198.3380166197, 15409.84590154084, 15592.220388980506, 15604.297806598503, 15612.843871561367, 15616.609584760472, 23672.17147399833, 23738.169164079176, 23894.402639933793, 23906.28281151568, 23930.40173995629, 7910.5649189295145, 7986.0816006158875, 8010.158933312035, 8030.397720170894, 8200.220979006985, 6552.836179095465, 6561.704723287464, 6583.934160658428, 6592.24189218246, 6599.0, 7601.277878601524, 7623.275788800166, 7625.322429065597, 7625.618719064025, 7637.618119094023, 1657.9005259684457, 1689.374931275436, 1698.100006996294, 2135.8825264610286, 2883.596296518489, 369.6950016236562, 371.8809980806116, 382.4091778202683, 389.2642904909723, 977.731123940922, 9455.76360590977, 9766.658166964122, 13877.37551810171, 15043.0, 15836.76244856328, 844.7888027993001, 869.3914260018013, 874.9912500875037, 905.9411138275991, 912.2610685344891, 8750.387472876964, 9242.857428474352, 9252.861207081765, 9306.0, 9349.719508414759, 477885.0, 482192.0, 483473.0, 485394.0, 490162.0, 68384.0, 70671.0, 70766.0, 71431.0, 73420.26579734134, 1076.7092884921028, 1077.2674581284803, 1162.5582278734196, 1174.723939874129, 1175.9235649682744, 14255.786163207353, 14261.095209325638, 14448.349824257723, 14588.781168282272, 14610.561683149523, 29328.85335573394, 29817.5527367094, 29985.850070749508, 29999.70000299969, 30286.54570181493, 43089.78455107704, 43503.78248108739, 44161.558384415745, 44375.0, 46963.0, 8477.40658153948, 8649.1350864913, 8785.25325347327, 8792.296616270554, 8808.383413161017, 10282.897171028193, 10313.845292320471, 11822.763544728885, 16052.277647506124, 16399.098049607386, 13789.172649641054, 13847.792283115963, 13873.861261387257, 14049.719005620034, 14093.859061409665, 13374.598762037154, 13389.799153012518, 13430.798538021741, 13947.442102315794, 14025.228612426006, 13636.045476816527, 13873.375698093409, 14111.929440352733, 14473.276336183359, 14547.345369458611, 8654.22112009922, 8661.826763464822, 8665.0035245945, 8800.47197168172, 8988.280937525113, 13051.21692698441, 13586.45654173822, 13685.86314136846, 13892.097013694078, 14005.929970350084], "unit": "ms", "name": "jquery.html", "value": 8890.93015550748}, {"lowerIsBetter": false, "replicates": [1203.476487727839, 1374.0999645232375, 1388.0491863073796, 1671.456776547622, 1730.4549067043881, 6102.17620621216, 6383.58506697065, 6942.236354001062, 7055.329743674356, 7058.188308344542, 7105.8223544411285, 7106.573605583669, 7183.066201393812, 7192.460565457599, 7204.927950720491, 2025.2304124432733, 2052.2406709517427, 2053.5995480881234, 2054.6301665700166, 2055.1368425261353, 2023.5649335392889, 2057.5987682401865, 2060.4642792873888, 2082.323244945399, 2082.79172082792, 2015.8488113391481, 2031.8069783370556, 2050.9950124439065, 2054.0, 2055.434755442258, 2012.1850650486504, 2033.4408037789651, 2034.3896830950803, 2035.6132334856404, 2039.5207126325301, 1998.3005947918257, 2035.4402539301661, 2047.7645070816898, 2051.3435700575824, 2052.0252879882087, 6049.062395328687, 7099.964500177466, 7178.0, 7185.748498802517, 7188.13742350916, 3681.6134305897763, 4013.3177359848896, 4151.813168407429, 4154.376843473473, 4155.252054630166, 2615.2285075902655, 2617.3849145450804, 2672.7594516493414, 2681.6647919010124, 2718.836869787819, 803.0243254445876, 808.086861846116, 812.8496228197803, 845.8435189489902, 857.3826844671827, 9451.858222126673, 9547.665831695927, 9558.426494410358, 9570.90429095707, 9599.904000960041, 3836.865709700147, 3859.8456061757215, 3875.9418608720894, 3888.4944957155953, 3970.682345412418, 8519.318454523624, 8528.061913189544, 8534.359923005799, 8553.700620478254, 8555.957220213859, 4226.964393723496, 4234.78826058702, 4237.152569486054, 4238.597333253336, 4243.7029407941145, 3797.3924172132324, 3798.2213646202463, 3803.1442925341576, 3804.087019115392, 3805.9343383852565, 3296.35721034396, 3311.2715202655377, 3317.518959750871, 3325.6840600142946, 3345.0299413170396, 1036.1917704190744, 1045.5504133222635, 1048.224314007629, 1048.3919326790444, 1051.495282264502, 1212.5574165429555, 1214.2107630040543, 1229.7540491901655, 1231.132051903406, 1231.6736064942797, 6798.728050878009, 6808.0, 6866.210385805596, 6882.070920425678, 6960.199577048603, 414.13239263743014, 422.2378606615028, 423.75422255091974, 425.28552032584935, 425.62757587111275, 4893.779779909913, 5350.9732451337495, 5394.056040192951, 5408.729563521887, 5408.864778380572, 7619.885701714478, 8044.798880028046, 8274.710385136492, 8321.83494310785, 8325.750227493185, 8129.349652027942, 8162.836743265101, 8165.061017982889, 8166.060902996232, 8172.346212303001, 6134.6625935573975, 6566.212054553484, 6588.604683718896, 6624.503162262849, 6640.236372817091, 6764.2559318475915, 6794.592324460548, 6795.864082718219, 6809.285025072494, 6813.591184528944, 7312.96343518279, 7619.69521219145, 7664.080310362792, 7664.846703065796, 7668.0, 7371.115466144097, 7555.206703296295, 7606.733764318223, 7653.387728981556, 7665.463417560717, 6188.319284878569, 6207.348228435949, 6230.813075607739, 6267.780627678009, 6273.090401891792, 6780.796576102724, 6792.728290868507, 6808.761693340709, 6809.795706128824, 6840.384365407137, 6386.712597933197, 6452.7741529048135, 6496.967515162394, 6599.637019963756, 6603.735850566116, 6356.491480681627, 6367.52243581724, 6443.548951573533, 6498.935010649833, 6518.217813862367, 6487.124238227968, 6532.738690452328, 6545.2800191979795, 6553.770618028346, 6557.377049180321, 6009.579329446897, 6060.151578778887, 6069.150318955438, 6206.813795586139, 6226.937730622636, 6286.308506064238, 6327.3988971047675, 6345.270293916259, 6346.555741098079, 6347.365263473615], "unit": "ms", "name": "mootools.html", "value": 3979.2289186084035}, {"lowerIsBetter": false, "replicates": [286.4085663105687, 296.4515646054798, 297.97169268919447, 305.421226775261, 306.4988743404534, 5165.457626949173, 5234.633575649701, 5250.317458730369, 5279.524842764151, 5370.140777475604, 5064.265681476184, 5147.81982630608, 5203.687778733279, 5207.906339668664, 5217.269582258477, 4120.773357465338, 4125.154343359604, 4126.649234815044, 4133.863187623412, 4134.111166099288, 3955.6439920407156, 4044.635982761551, 4060.309747342944, 4123.835046598132, 4141.440905477767, 4111.239420707164, 4121.093359460914, 4122.4228607994755, 4129.050318426764, 4139.917201655965, 4111.239420707178, 4118.588141185887, 4120.75275483472, 4129.905575022622, 4134.937975930364, 3648.431174594923, 3649.8540058397634, 3651.7626354287154, 3656.725745569093, 3659.0, 4936.160852655022, 5054.064997975386, 5057.544820966131, 5063.341765570489, 5123.923141152885, 4740.028294199681, 4752.405949256343, 4756.952430475685, 4763.237881938873, 4763.404574428197, 5575.303087114111, 5597.3003374578175, 5600.215969764236, 5605.607607467479, 5615.494605485526, 3762.5861155272896, 3841.327767640652, 3852.6339997700175, 3916.686665066788, 3945.2701250268506, 5764.798232061899, 5826.242588463515, 5852.385499522574, 5852.941470585325, 5854.268216472941, 4090.6727461802984, 4091.3249313863475, 4093.0790572121036, 4094.201630682048, 4094.447249621263, 4160.043190066302, 4161.126163505698, 4161.958380416218, 4162.084341444877, 4164.146349998243, 4588.449386073693, 4707.058588282357, 4726.291056341576, 4733.95266047342, 4739.597134243559, 5544.528715059185, 5544.667319960815, 5546.278983732089, 5551.472610102034, 5555.2222688823595, 1456.2936975566843, 1474.2776039740666, 1474.565003324022, 1475.0338528264003, 1475.6605980624302, 1003.1824063388315, 1006.104566935428, 1008.1531513528524, 1027.085893554737, 1027.984580231297, 4914.189158788831, 4918.508149185053, 4921.532454416824, 4921.655484116078, 4925.990172014728, 5761.5102716269585, 5763.221965034751, 5768.567357448208, 5770.807093304517, 5772.134179872969, 4890.95109048912, 4894.535019173244, 4895.290182923456, 4898.608111351084, 4904.975475122602, 3029.545568164749, 3080.614923134608, 3107.440660681099, 3108.2695566541843, 3118.8596513156963, 5559.916601250984, 5569.526590239875, 5576.581756368208, 5579.860503487364, 5585.106382978704, 5993.970030149909, 5994.28068631767, 6000.159977603139, 6004.0693692477735, 6004.7598096076545, 5552.056150454432, 5569.55443564522, 5569.749361278833, 5569.777208911598, 5572.328301509531, 5681.886362272814, 5845.8538536535225, 5846.41535846412, 5848.56135789826, 5848.736806843617, 5462.426445223195, 5546.223528705904, 5581.079121944834, 5675.545956323402, 5683.460071293221, 5522.088855338985, 5539.806106786243, 5549.556035517068, 5552.69460179694, 5554.527865131509, 3939.3697008478507, 3959.5248570171766, 3964.6630036447227, 3966.821493032878, 3972.3445631470486, 5619.409961953936, 5777.653340799566, 5813.680247586423, 5814.0, 5823.242978412779, 5612.130119831432, 5614.438556144353, 5616.382197958303, 5618.073017951992, 5622.128570071645, 5578.330600327987, 5597.076482380362, 5615.073512870331, 5615.18579805934, 5616.4383561645145, 5499.230107784833, 5502.862428439321, 5503.7798488060025, 5509.614326997072, 5512.5314348280845, 5524.530414914777, 5641.12562552805, 5644.491995720241, 5655.971720141373, 5659.660420374791, 5440.646357986719, 5474.343078830566, 5474.42518535564, 5481.616286859881, 5484.095124304445], "unit": "ms", "name": "prototype.html", "value": 4210.3495267172275}, {"lowerIsBetter": false, "replicates": [676.5602358466997, 695.5930780493411, 788.6017561131628, 804.4007214625105, 807.9838403231936, 10957.452127393628, 11105.222634415593, 11108.888911110897, 11183.776324473505, 11222.158338124642, 10880.0, 11993.460294286757, 12169.695757606041, 12263.877361226407, 12296.323702196398, 793.1275596843469, 811.4238890387832, 811.691557208263, 811.7077851973285, 811.9025716913949, 796.303234669664, 802.5385403393043, 804.5092493578942, 804.6258489802241, 804.9074356449024, 846.2510678049939, 848.2662496940134, 848.6478111583716, 849.1381248033221, 849.2611428057598, 837.0415873824497, 838.714836955435, 838.7316058861167, 838.8364268967554, 839.1776059461731, 622.0110025060176, 622.5579838314802, 622.6575383539035, 624.9062640603901, 625.4839757200328, 9559.235261179088, 9679.274054445945, 9687.225021998223, 9694.17599504043, 9699.224062075016, 9700.417974921527, 9941.850872236922, 10109.797804043952, 10210.387376757344, 10327.431991240479, 8298.668053277861, 8402.327813774944, 8465.0, 8504.149585041509, 8585.270252028586, 3213.405519978788, 3219.4205043092234, 3248.7238584720326, 3290.045886692856, 3329.8335083245984, 33354.83322583372, 34013.6598634013, 36486.0, 36942.445863312074, 39923.20153596912, 8794.164554367326, 9147.54262286883, 9155.176034156957, 9232.353735238468, 9536.046395360408, 15985.520434386986, 16017.839821601634, 16031.278592463133, 16060.357585696442, 16099.517014489584, 6447.774327898501, 6474.870502589922, 6521.804345869631, 6565.704543295563, 6568.277489476154, 3593.7843729376323, 3614.3857339476867, 3630.9092272692865, 3652.9634703653155, 3697.7781333120097, 2769.819961702483, 2782.5687018512162, 2784.2343355577377, 2787.484315401657, 2791.413803101331, 480.5962991087503, 483.7363636817943, 491.22386629125896, 491.2361278212414, 493.2084005171719, 515.3277614142132, 596.2636144361796, 597.5010865927, 600.7506884642912, 610.4353473037422, 7429.702811887572, 7474.85050298991, 7545.170031296553, 7583.2416758323725, 7611.581363025087, 549.9037668408013, 556.9470900264549, 576.1760682224376, 585.7656937225144, 599.3137857153534, 3565.893023209308, 3672.761270517461, 3701.1672373715696, 3769.6041915598466, 3796.9430458543143, 51096.0, 51694.0, 51749.2237616436, 51803.74098129485, 52039.0, 45016.099678006256, 45539.0, 45792.313115303295, 45852.3122153168, 46070.0, 34957.126071847895, 35003.0, 39758.0, 45077.323840142424, 45356.54643453523, 7865.803354915944, 7932.881006785018, 7995.080565734782, 8113.438723366228, 8256.463329883778, 31384.84307578539, 31930.0, 32236.19409514781, 32414.351712965137, 33000.834995824865, 37292.44061339028, 37382.813085934395, 39134.412983804694, 40744.185116298104, 41145.1770964585, 10306.896931030593, 10335.22485813582, 10383.740406489898, 10399.27205095636, 10414.0, 11000.834987475035, 11042.227044106836, 11226.270292431293, 11692.0, 12066.879331206575, 10831.228005737528, 11047.392393418118, 11055.391953442639, 11479.655610331703, 11487.13846461502, 10834.512446939749, 10850.907491364924, 11182.049525790399, 11236.157288203254, 11615.070794336601, 10555.94722026385, 10639.680809575726, 10838.512266947848, 10951.288166269167, 11014.944925275322, 8926.86609700868, 9193.816123677356, 9222.538873056454, 9224.953875230582, 9460.621575137193, 8611.181937715906, 9081.273498120267, 9347.345685801929, 9497.810043799223, 9547.761305967406], "unit": "ms", "name": "yui.html", "value": 5697.774186319618}], "name": "dromaeo_css", "value": 6373.009376039409}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 112.0, 103.0, 110.0, 110.0, 111.0, 99.0, 111.0, 111.0, 101.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [158.0, 127.0, 153.0, 162.0, 130.0, 155.0, 154.0, 129.0, 170.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 161.0, 163.0, 161.0, 162.0, 163.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [71.0, 78.0, 88.0, 93.0, 72.0, 71.0, 72.0, 103.0, 86.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 132.0, 94.0, 94.0, 95.0, 135.0, 95.0, 96.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 112.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [70.0, 75.0, 71.0, 71.0, 69.0, 70.0, 70.0, 71.0, 75.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 92.0, 84.0, 84.0, 83.0, 84.0, 85.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [131.0, 122.0, 124.0, 134.0, 125.0, 117.0, 123.0, 128.0, 121.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 148.0, 150.0, 146.0, 137.0, 145.0, 145.0, 143.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 70.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1517.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.14055490945339], "unit": "score", "name": "Richards", "value": 212.48273800000004}, {"lowerIsBetter": false, "replicates": [185.56318426424198], "unit": "score", "name": "DeltaBlue", "value": 356.309902}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1986.111111111111], "unit": "score", "name": "RayTrace", "value": 372.5818741258742}, {"lowerIsBetter": false, "replicates": [783.0853563038371], "unit": "score", "name": "Earley", "value": 851.0732510000003}, {"lowerIsBetter": false, "replicates": [12060.240963855422], "unit": "score", "name": "Boyer", "value": 55.2611678321678}, {"lowerIsBetter": false, "replicates": [26128.20512820513], "unit": "score", "name": "RegExp", "value": 34.86596172718352}, {"lowerIsBetter": false, "replicates": [636.5372374283895], "unit": "score", "name": "Splay", "value": 128.02236099999996}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19819.918757020943}]} 11:08:09 INFO - RETURN: dromaeo_css: 6373.01 11:08:09 INFO - RETURN: kraken: 1517.00 11:08:09 INFO - RETURN: v8_7: 19819.92 11:08:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19819.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1517.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6373.01"}}} 11:08:09 INFO - Return code: 0 11:08:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:08:09 ERROR - # TBPL SUCCESS # 11:08:09 INFO - Running post-action listener: _resource_record_post_action 11:08:09 INFO - Running post-run listener: _resource_record_post_run 11:08:10 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 69632; Write bytes: 503459840; Read time: 464; Write time: 1055288 11:08:10 INFO - install - Wall time: 15s; CPU: 18.0%; Read bytes: 57344; Write bytes: 231088128; Read time: 428; Write time: 764264 11:08:10 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 12288; Write bytes: 272367616; Read time: 36; Write time: 289632 11:08:10 INFO - Running post-run listener: _upload_blobber_files 11:08:10 INFO - Blob upload gear active. 11:08:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:08:10 INFO - Copying logs to upload dir... 11:08:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.626742 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-02 11:08:10.834708) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 11:08:10.838769) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009958 build_url: 'https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.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-02 11:08:10.890355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 11:08:10.890736) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1449081938.969902-148480179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 11:08:10.940854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 11:08:10.941240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 11:08:10.941598) ========= ========= Total master_lag: 0.24 =========