builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1454764541.72 results: success (0) buildid: 20160203070736 builduid: 019b7fca185e4b33adf5c590d5ec532e revision: 97c27a348f0963da5bce6b667612e7ba2d209078 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.720879) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.721317) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.721600) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006246 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.800121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.800423) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.814839) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.815214) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.863548) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.863858) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.864218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:41.864483) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-06 05:15:41-- 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% 96.5M=0s 2016-02-06 05:15:42 (96.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161525 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:42.038112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:42.038418) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014621 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:42.124590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:42.124948) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 97c27a348f0963da5bce6b667612e7ba2d209078 --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 97c27a348f0963da5bce6b667612e7ba2d209078 --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=edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-06 05:15:42,239 truncating revision to first 12 chars 2016-02-06 05:15:42,239 Setting DEBUG logging. 2016-02-06 05:15:42,239 attempt 1/10 2016-02-06 05:15:42,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/97c27a348f09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 05:15:42,496 unpacking tar archive at: fx-team-97c27a348f09/testing/mozharness/ program finished with exit code 0 elapsedTime=0.533966 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:42.672094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:42.672606) ========= echo 97c27a348f0963da5bce6b667612e7ba2d209078 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'97c27a348f0963da5bce6b667612e7ba2d209078'] 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=edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 97c27a348f0963da5bce6b667612e7ba2d209078 program finished with exit code 0 elapsedTime=0.004627 script_repo_revision: '97c27a348f0963da5bce6b667612e7ba2d209078' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:42.723484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:42.723821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 05:15:42.733669) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-06 05:15:42.734034) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:42 INFO - MultiFileLogger online at 20160206 05:15:42 in /builds/slave/test 05:15:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:15:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:42 INFO - {'append_to_log': False, 05:15:42 INFO - 'base_work_dir': '/builds/slave/test', 05:15:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:15:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:42 INFO - 'branch': 'Fx-Team-Non-PGO', 05:15:42 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:42 INFO - 'config_files': ('talos/linux_config.py',), 05:15:42 INFO - 'default_actions': ('clobber', 05:15:42 INFO - 'read-buildbot-config', 05:15:42 INFO - 'download-and-extract', 05:15:42 INFO - 'populate-webroot', 05:15:42 INFO - 'create-virtualenv', 05:15:42 INFO - 'install', 05:15:42 INFO - 'run-tests'), 05:15:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:42 INFO - 'download_minidump_stackwalk': True, 05:15:42 INFO - 'download_symbols': 'ondemand', 05:15:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:42 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:42 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:42 INFO - 'installer_path': 'installer.exe', 05:15:42 INFO - 'log_level': 'info', 05:15:42 INFO - 'log_name': 'talos', 05:15:42 INFO - 'log_to_console': True, 05:15:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:42 INFO - 'opt_config_files': (), 05:15:42 INFO - 'pip_index': False, 05:15:42 INFO - 'sps_profile': False, 05:15:42 INFO - 'sps_profile_interval': 0, 05:15:42 INFO - 'suite': 'dromaeojs-e10s', 05:15:42 INFO - 'system_bits': '32', 05:15:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:42 INFO - 'title': 'talos-linux64-ix-033', 05:15:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:42 INFO - 'use_talos_json': True, 05:15:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:42 INFO - 'work_dir': 'build'} 05:15:42 INFO - ##### 05:15:42 INFO - ##### Running clobber step. 05:15:42 INFO - ##### 05:15:42 INFO - Running pre-action listener: _resource_record_pre_action 05:15:42 INFO - Running main action method: clobber 05:15:42 INFO - rmtree: /builds/slave/test/build 05:15:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:43 INFO - Running post-action listener: _resource_record_post_action 05:15:43 INFO - ##### 05:15:43 INFO - ##### Running read-buildbot-config step. 05:15:43 INFO - ##### 05:15:43 INFO - Running pre-action listener: _resource_record_pre_action 05:15:43 INFO - Running main action method: read_buildbot_config 05:15:43 INFO - Using buildbot properties: 05:15:43 INFO - { 05:15:43 INFO - "project": "", 05:15:43 INFO - "product": "firefox", 05:15:43 INFO - "script_repo_revision": "production", 05:15:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:15:43 INFO - "repository": "", 05:15:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:15:43 INFO - "buildid": "20160203070736", 05:15:43 INFO - "pgo_build": "False", 05:15:43 INFO - "basedir": "/builds/slave/test", 05:15:43 INFO - "buildnumber": 858, 05:15:43 INFO - "slavename": "talos-linux64-ix-033", 05:15:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:15:43 INFO - "platform": "ubuntu64_hw", 05:15:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:15:43 INFO - "branch": "fx-team", 05:15:43 INFO - "repo_path": "integration/fx-team", 05:15:43 INFO - "revision": "97c27a348f0963da5bce6b667612e7ba2d209078", 05:15:43 INFO - "stage_platform": "linux64", 05:15:43 INFO - "builduid": "019b7fca185e4b33adf5c590d5ec532e", 05:15:43 INFO - "slavebuilddir": "test" 05:15:43 INFO - } 05:15:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:15:43 INFO - Running post-action listener: _resource_record_post_action 05:15:43 INFO - ##### 05:15:43 INFO - ##### Running download-and-extract step. 05:15:43 INFO - ##### 05:15:43 INFO - Running pre-action listener: _resource_record_pre_action 05:15:43 INFO - Running main action method: download_and_extract 05:15:43 INFO - mkdir: /builds/slave/test/build/tests 05:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:43 INFO - https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/test_packages.json 05:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/test_packages.json 05:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:15:44 INFO - Downloaded 1448 bytes. 05:15:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:15:44 INFO - Using the following test package requirements: 05:15:44 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:44 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:15:44 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:15:44 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:44 INFO - u'jsshell-linux-x86_64.zip'], 05:15:44 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:15:44 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:44 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:15:44 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:15:44 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:15:44 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:44 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:15:44 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:15:44 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')]} 05:15:44 INFO - https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:15:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:15:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:15:45 INFO - Downloaded 21672518 bytes. 05:15:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:15:46 INFO - Return code: 0 05:15:46 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:15:46 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')]} 05:15:46 INFO - https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:15:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:15:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:15:47 INFO - Downloaded 21672518 bytes. 05:15:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:15:48 INFO - Return code: 0 05:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:48 INFO - https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:15:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:15:49 INFO - Downloaded 10706582 bytes. 05:15:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:15:50 INFO - Return code: 0 05:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:50 INFO - https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:15:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:15:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:15:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:15:51 INFO - Downloaded 54228511 bytes. 05:15:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:15:51 INFO - mkdir: /builds/slave/test/properties 05:15:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:51 INFO - Contents: 05:15:51 INFO - build_url:https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:15:52 INFO - Running post-action listener: _resource_record_post_action 05:15:52 INFO - Running post-action listener: set_extra_try_arguments 05:15:52 INFO - ##### 05:15:52 INFO - ##### Running populate-webroot step. 05:15:52 INFO - ##### 05:15:52 INFO - Running pre-action listener: _resource_record_pre_action 05:15:52 INFO - Running main action method: populate_webroot 05:15:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:52 INFO - '--tppagecycles', 05:15:52 INFO - '7'], 05:15:52 INFO - 'tests': ['tsvgm']}}, 05:15:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:15:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:15:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:15:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:15:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:52 INFO - 'talos_options': ['--e10s'], 05:15:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:52 INFO - 'tests': ['damp', 'tps']}, 05:15:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:52 INFO - 'talos_options': ['--e10s'], 05:15:52 INFO - 'tests': ['damp', 'tps']}, 05:15:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:15:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:52 INFO - 'other': {'tests': ['a11yr', 05:15:52 INFO - 'ts_paint', 05:15:52 INFO - 'tpaint', 05:15:52 INFO - 'sessionrestore', 05:15:52 INFO - 'sessionrestore_no_auto_restore']}, 05:15:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:15:52 INFO - 'tests': ['a11yr', 05:15:52 INFO - 'ts_paint', 05:15:52 INFO - 'tpaint', 05:15:52 INFO - 'sessionrestore', 05:15:52 INFO - 'sessionrestore_no_auto_restore']}, 05:15:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:15:52 INFO - 'tests': ['a11yr', 05:15:52 INFO - 'ts_paint', 05:15:52 INFO - 'tpaint', 05:15:52 INFO - 'sessionrestore', 05:15:52 INFO - 'sessionrestore_no_auto_restore']}, 05:15:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:15:52 INFO - 'tests': ['a11yr', 05:15:52 INFO - 'ts_paint', 05:15:52 INFO - 'tpaint', 05:15:52 INFO - 'sessionrestore', 05:15:52 INFO - 'sessionrestore_no_auto_restore']}, 05:15:52 INFO - 'other_l64': {'tests': ['a11yr', 05:15:52 INFO - 'ts_paint', 05:15:52 INFO - 'tpaint', 05:15:52 INFO - 'sessionrestore', 05:15:52 INFO - 'sessionrestore_no_auto_restore']}, 05:15:52 INFO - 'other_nol64': {'tests': ['a11yr', 05:15:52 INFO - 'ts_paint', 05:15:52 INFO - 'tpaint', 05:15:52 INFO - 'sessionrestore', 05:15:52 INFO - 'sessionrestore_no_auto_restore']}, 05:15:52 INFO - 'svgr': {'tests': ['tsvgx', 05:15:52 INFO - 'tsvgr_opacity', 05:15:52 INFO - 'tart', 05:15:52 INFO - 'tscrollx', 05:15:52 INFO - 'cart']}, 05:15:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:15:52 INFO - 'tests': ['tsvgx', 05:15:52 INFO - 'tsvgr_opacity', 05:15:52 INFO - 'tart', 05:15:52 INFO - 'tscrollx', 05:15:52 INFO - 'cart']}, 05:15:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:52 INFO - 'tests': ['tp5o']}, 05:15:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:52 INFO - 'talos_options': ['--e10s'], 05:15:52 INFO - 'tests': ['tp5o']}, 05:15:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:52 INFO - 'talos_options': ['--xperf_path', 05:15:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:52 INFO - 'tests': ['tp5n']}, 05:15:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:52 INFO - 'talos_options': ['--e10s', 05:15:52 INFO - '--xperf_path', 05:15:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:52 INFO - 'tests': ['tp5n']}}, 05:15:52 INFO - 'talos.zip': {'path': '', 05:15:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:52 INFO - Running post-action listener: _resource_record_post_action 05:15:52 INFO - ##### 05:15:52 INFO - ##### Running create-virtualenv step. 05:15:52 INFO - ##### 05:15:52 INFO - Running pre-action listener: _resource_record_pre_action 05:15:52 INFO - Running main action method: create_virtualenv 05:15:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:52 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 05:15:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:52 INFO - Using real prefix '/usr' 05:15:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:54 INFO - Installing pip.................done. 05:15:54 INFO - Return code: 0 05:15:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f5bd2db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2737dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca3d0>, '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 0x2735ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2736360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', '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 05:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:15:54 INFO - Using env: {'DISPLAY': ':0', 05:15:54 INFO - 'HOME': '/home/cltbld', 05:15:54 INFO - 'LANG': 'en_US.UTF-8', 05:15:54 INFO - 'LANGUAGE': 'en_US:en', 05:15:54 INFO - 'LOGNAME': 'cltbld', 05:15:54 INFO - 'MAIL': '/var/mail/cltbld', 05:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:54 INFO - 'MOZ_NO_REMOTE': '1', 05:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:54 INFO - 'NO_EM_RESTART': '1', 05:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:54 INFO - 'PWD': '/builds/slave/test', 05:15:54 INFO - 'SHELL': '/bin/bash', 05:15:54 INFO - 'SHLVL': '1', 05:15:54 INFO - 'TERM': 'linux', 05:15:54 INFO - 'TMOUT': '86400', 05:15:54 INFO - 'USER': 'cltbld', 05:15:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', 05:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:54 INFO - '_': '/tools/buildbot/bin/python'} 05:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:55 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 05:15:55 INFO - Cleaning up... 05:15:55 INFO - Return code: 0 05:15:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:15:55 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')]} 05:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:55 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')]} 05:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f5bd2db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2737dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca3d0>, '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 0x2735ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2736360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', '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 05:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:15:55 INFO - Using env: {'DISPLAY': ':0', 05:15:55 INFO - 'HOME': '/home/cltbld', 05:15:55 INFO - 'LANG': 'en_US.UTF-8', 05:15:55 INFO - 'LANGUAGE': 'en_US:en', 05:15:55 INFO - 'LOGNAME': 'cltbld', 05:15:55 INFO - 'MAIL': '/var/mail/cltbld', 05:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:55 INFO - 'MOZ_NO_REMOTE': '1', 05:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:55 INFO - 'NO_EM_RESTART': '1', 05:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:55 INFO - 'PWD': '/builds/slave/test', 05:15:55 INFO - 'SHELL': '/bin/bash', 05:15:55 INFO - 'SHLVL': '1', 05:15:55 INFO - 'TERM': 'linux', 05:15:55 INFO - 'TMOUT': '86400', 05:15:55 INFO - 'USER': 'cltbld', 05:15:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', 05:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:55 INFO - '_': '/tools/buildbot/bin/python'} 05:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:55 INFO - Downloading/unpacking psutil>=0.7.1 05:15:55 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 05:15:55 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 05:15:55 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 05:15:55 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 05:15:55 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 05:15:55 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 05:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:57 INFO - Installing collected packages: psutil 05:15:57 INFO - Running setup.py install for psutil 05:15:57 INFO - building 'psutil._psutil_linux' extension 05:15:57 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 05:15:57 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 05:15:57 INFO - building 'psutil._psutil_posix' extension 05:15:57 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 05:15:57 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 05:15:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:57 INFO - Successfully installed psutil 05:15:57 INFO - Cleaning up... 05:15:57 INFO - Return code: 0 05:15:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f5bd2db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2737dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca3d0>, '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 0x2735ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2736360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', '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 05:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:15:57 INFO - Using env: {'DISPLAY': ':0', 05:15:57 INFO - 'HOME': '/home/cltbld', 05:15:57 INFO - 'LANG': 'en_US.UTF-8', 05:15:57 INFO - 'LANGUAGE': 'en_US:en', 05:15:57 INFO - 'LOGNAME': 'cltbld', 05:15:57 INFO - 'MAIL': '/var/mail/cltbld', 05:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:57 INFO - 'MOZ_NO_REMOTE': '1', 05:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:57 INFO - 'NO_EM_RESTART': '1', 05:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:57 INFO - 'PWD': '/builds/slave/test', 05:15:57 INFO - 'SHELL': '/bin/bash', 05:15:57 INFO - 'SHLVL': '1', 05:15:57 INFO - 'TERM': 'linux', 05:15:57 INFO - 'TMOUT': '86400', 05:15:57 INFO - 'USER': 'cltbld', 05:15:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', 05:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:57 INFO - '_': '/tools/buildbot/bin/python'} 05:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:15:59 INFO - Installing collected packages: mozsystemmonitor 05:15:59 INFO - Running setup.py install for mozsystemmonitor 05:15:59 INFO - Successfully installed mozsystemmonitor 05:15:59 INFO - Cleaning up... 05:16:00 INFO - Return code: 0 05:16:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:00 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')]} 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:00 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')]} 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f5bd2db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2737dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca3d0>, '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 0x2735ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2736360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', '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 05:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:16:00 INFO - Using env: {'DISPLAY': ':0', 05:16:00 INFO - 'HOME': '/home/cltbld', 05:16:00 INFO - 'LANG': 'en_US.UTF-8', 05:16:00 INFO - 'LANGUAGE': 'en_US:en', 05:16:00 INFO - 'LOGNAME': 'cltbld', 05:16:00 INFO - 'MAIL': '/var/mail/cltbld', 05:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:00 INFO - 'MOZ_NO_REMOTE': '1', 05:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:00 INFO - 'NO_EM_RESTART': '1', 05:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:00 INFO - 'PWD': '/builds/slave/test', 05:16:00 INFO - 'SHELL': '/bin/bash', 05:16:00 INFO - 'SHLVL': '1', 05:16:00 INFO - 'TERM': 'linux', 05:16:00 INFO - 'TMOUT': '86400', 05:16:00 INFO - 'USER': 'cltbld', 05:16:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', 05:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:00 INFO - '_': '/tools/buildbot/bin/python'} 05:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - Downloading docopt-0.6.1.tar.gz 05:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:03 INFO - Running setup.py install for blobuploader 05:16:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:03 INFO - Running setup.py install for requests 05:16:03 INFO - Running setup.py install for docopt 05:16:03 INFO - Successfully installed blobuploader requests docopt 05:16:03 INFO - Cleaning up... 05:16:03 INFO - Return code: 0 05:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f5bd2db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2737dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca3d0>, '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 0x2735ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2736360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', '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 05:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 05:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 05:16:03 INFO - Using env: {'DISPLAY': ':0', 05:16:03 INFO - 'HOME': '/home/cltbld', 05:16:03 INFO - 'LANG': 'en_US.UTF-8', 05:16:03 INFO - 'LANGUAGE': 'en_US:en', 05:16:03 INFO - 'LOGNAME': 'cltbld', 05:16:03 INFO - 'MAIL': '/var/mail/cltbld', 05:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:03 INFO - 'MOZ_NO_REMOTE': '1', 05:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:03 INFO - 'NO_EM_RESTART': '1', 05:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:03 INFO - 'PWD': '/builds/slave/test', 05:16:03 INFO - 'SHELL': '/bin/bash', 05:16:03 INFO - 'SHLVL': '1', 05:16:03 INFO - 'TERM': 'linux', 05:16:03 INFO - 'TMOUT': '86400', 05:16:03 INFO - 'USER': 'cltbld', 05:16:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', 05:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:03 INFO - '_': '/tools/buildbot/bin/python'} 05:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:03 INFO - Running setup.py (path:/tmp/pip-iBVcBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:03 INFO - Running setup.py (path:/tmp/pip-1V3PbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:04 INFO - Running setup.py (path:/tmp/pip-B5zHFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:04 INFO - Running setup.py (path:/tmp/pip-gA4MsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:04 INFO - Running setup.py (path:/tmp/pip-Rv3Isp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:04 INFO - Running setup.py (path:/tmp/pip-9vFgbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:04 INFO - Running setup.py (path:/tmp/pip-4dVj4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:04 INFO - Running setup.py (path:/tmp/pip-dIuDqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:04 INFO - Running setup.py (path:/tmp/pip-Yz_9vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:04 INFO - Running setup.py (path:/tmp/pip-zesQer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:04 INFO - Running setup.py (path:/tmp/pip-Oh6x7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:04 INFO - Running setup.py (path:/tmp/pip-RelKBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:04 INFO - Running setup.py (path:/tmp/pip-nuHQS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:04 INFO - Running setup.py (path:/tmp/pip-5C6hbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:04 INFO - Running setup.py (path:/tmp/pip-JM8TQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:04 INFO - Running setup.py (path:/tmp/pip-emeA4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:05 INFO - Running setup.py (path:/tmp/pip-QU0hvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:05 INFO - Running setup.py install for manifestparser 05:16:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:05 INFO - Running setup.py install for mozcrash 05:16:05 INFO - Running setup.py install for mozdebug 05:16:05 INFO - Running setup.py install for mozdevice 05:16:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:05 INFO - Running setup.py install for mozfile 05:16:05 INFO - Running setup.py install for mozhttpd 05:16:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:05 INFO - Running setup.py install for mozinfo 05:16:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:05 INFO - Running setup.py install for mozInstall 05:16:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:05 INFO - Running setup.py install for mozleak 05:16:05 INFO - Running setup.py install for mozlog 05:16:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:06 INFO - Running setup.py install for moznetwork 05:16:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:06 INFO - Running setup.py install for mozprocess 05:16:06 INFO - Running setup.py install for mozprofile 05:16:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:06 INFO - Running setup.py install for mozrunner 05:16:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:06 INFO - Running setup.py install for mozscreenshot 05:16:06 INFO - Running setup.py install for moztest 05:16:06 INFO - Running setup.py install for mozversion 05:16:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:06 INFO - Cleaning up... 05:16:06 INFO - Return code: 0 05:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f5bd2db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2737dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca3d0>, '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 0x2735ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2736360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', '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 05:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:16:06 INFO - Using env: {'DISPLAY': ':0', 05:16:06 INFO - 'HOME': '/home/cltbld', 05:16:06 INFO - 'LANG': 'en_US.UTF-8', 05:16:06 INFO - 'LANGUAGE': 'en_US:en', 05:16:06 INFO - 'LOGNAME': 'cltbld', 05:16:06 INFO - 'MAIL': '/var/mail/cltbld', 05:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:06 INFO - 'MOZ_NO_REMOTE': '1', 05:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:06 INFO - 'NO_EM_RESTART': '1', 05:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:06 INFO - 'PWD': '/builds/slave/test', 05:16:06 INFO - 'SHELL': '/bin/bash', 05:16:06 INFO - 'SHLVL': '1', 05:16:06 INFO - 'TERM': 'linux', 05:16:06 INFO - 'TMOUT': '86400', 05:16:06 INFO - 'USER': 'cltbld', 05:16:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', 05:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:06 INFO - '_': '/tools/buildbot/bin/python'} 05:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:07 INFO - Running setup.py (path:/tmp/pip-Y5Mbf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:07 INFO - Running setup.py (path:/tmp/pip-5fljOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:07 INFO - Running setup.py (path:/tmp/pip-oyT7v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:07 INFO - Running setup.py (path:/tmp/pip-NnKEtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:07 INFO - Running setup.py (path:/tmp/pip-41Q1Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:07 INFO - Running setup.py (path:/tmp/pip-OQ_tsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:07 INFO - Running setup.py (path:/tmp/pip-kV5WKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:07 INFO - Running setup.py (path:/tmp/pip-un3CCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:07 INFO - Running setup.py (path:/tmp/pip-7RfIPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:07 INFO - Running setup.py (path:/tmp/pip-b1cvHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:07 INFO - Running setup.py (path:/tmp/pip-C7i3eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:07 INFO - Running setup.py (path:/tmp/pip-Pi891j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:07 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)) 05:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:07 INFO - Running setup.py (path:/tmp/pip-8mtxKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:08 INFO - Running setup.py (path:/tmp/pip-czbz3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:08 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)) 05:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:08 INFO - Running setup.py (path:/tmp/pip-o1uLh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:08 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)) 05:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:08 INFO - Running setup.py (path:/tmp/pip-fHg2mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:08 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)) 05:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:08 INFO - Running setup.py (path:/tmp/pip-dqTe6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:08 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)) 05:16:08 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)) 05:16:08 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)) 05:16:08 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)) 05:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:16:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:08 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 05:16:08 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 05:16:08 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 05:16:08 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 05:16:08 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 05:16:08 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 05:16:10 INFO - Downloading blessings-1.6.tar.gz 05:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:10 INFO - Installing collected packages: blessings 05:16:10 INFO - Running setup.py install for blessings 05:16:10 INFO - Successfully installed blessings 05:16:10 INFO - Cleaning up... 05:16:10 INFO - Return code: 0 05:16:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:10 INFO - Reading from file tmpfile_stdout 05:16:10 INFO - Current package versions: 05:16:10 INFO - argparse == 1.2.1 05:16:10 INFO - blessings == 1.6 05:16:10 INFO - blobuploader == 1.2.4 05:16:10 INFO - docopt == 0.6.1 05:16:10 INFO - manifestparser == 1.1 05:16:10 INFO - mozInstall == 1.12 05:16:10 INFO - mozcrash == 0.16 05:16:10 INFO - mozdebug == 0.1 05:16:10 INFO - mozdevice == 0.48 05:16:10 INFO - mozfile == 1.2 05:16:10 INFO - mozhttpd == 0.7 05:16:10 INFO - mozinfo == 0.9 05:16:10 INFO - mozleak == 0.1 05:16:10 INFO - mozlog == 3.1 05:16:10 INFO - moznetwork == 0.27 05:16:10 INFO - mozprocess == 0.22 05:16:10 INFO - mozprofile == 0.28 05:16:10 INFO - mozrunner == 6.11 05:16:10 INFO - mozscreenshot == 0.1 05:16:10 INFO - mozsystemmonitor == 0.0 05:16:10 INFO - moztest == 0.7 05:16:10 INFO - mozversion == 1.4 05:16:10 INFO - psutil == 3.1.1 05:16:10 INFO - requests == 1.2.3 05:16:10 INFO - wsgiref == 0.1.2 05:16:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f5bd2db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2737dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca3d0>, '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 0x2735ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2736360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', '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 05:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:16:10 INFO - Using env: {'DISPLAY': ':0', 05:16:10 INFO - 'HOME': '/home/cltbld', 05:16:10 INFO - 'LANG': 'en_US.UTF-8', 05:16:10 INFO - 'LANGUAGE': 'en_US:en', 05:16:10 INFO - 'LOGNAME': 'cltbld', 05:16:10 INFO - 'MAIL': '/var/mail/cltbld', 05:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:10 INFO - 'MOZ_NO_REMOTE': '1', 05:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:10 INFO - 'NO_EM_RESTART': '1', 05:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:10 INFO - 'PWD': '/builds/slave/test', 05:16:10 INFO - 'SHELL': '/bin/bash', 05:16:10 INFO - 'SHLVL': '1', 05:16:10 INFO - 'TERM': 'linux', 05:16:10 INFO - 'TMOUT': '86400', 05:16:10 INFO - 'USER': 'cltbld', 05:16:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', 05:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:10 INFO - '_': '/tools/buildbot/bin/python'} 05:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:10 INFO - Cleaning up... 05:16:10 INFO - Return code: 0 05:16:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f5bd2db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2737dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca3d0>, '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 0x2735ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2736360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', '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 05:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:16:10 INFO - Using env: {'DISPLAY': ':0', 05:16:10 INFO - 'HOME': '/home/cltbld', 05:16:10 INFO - 'LANG': 'en_US.UTF-8', 05:16:10 INFO - 'LANGUAGE': 'en_US:en', 05:16:10 INFO - 'LOGNAME': 'cltbld', 05:16:10 INFO - 'MAIL': '/var/mail/cltbld', 05:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:10 INFO - 'MOZ_NO_REMOTE': '1', 05:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:10 INFO - 'NO_EM_RESTART': '1', 05:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:10 INFO - 'PWD': '/builds/slave/test', 05:16:10 INFO - 'SHELL': '/bin/bash', 05:16:10 INFO - 'SHLVL': '1', 05:16:10 INFO - 'TERM': 'linux', 05:16:10 INFO - 'TMOUT': '86400', 05:16:10 INFO - 'USER': 'cltbld', 05:16:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', 05:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:10 INFO - '_': '/tools/buildbot/bin/python'} 05:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:10 INFO - Downloading/unpacking jsonschema 05:16:10 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 05:16:10 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 05:16:10 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 05:16:10 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 05:16:10 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 05:16:10 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 05:16:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:12 INFO - Downloading/unpacking functools32 (from jsonschema) 05:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:13 INFO - warning: no files found matching '*.txt' 05:16:13 INFO - no previously-included directories found matching 'build' 05:16:13 INFO - no previously-included directories found matching 'dist' 05:16:13 INFO - no previously-included directories found matching '.git*' 05:16:13 INFO - Installing collected packages: jsonschema, functools32 05:16:13 INFO - Running setup.py install for functools32 05:16:13 INFO - warning: no files found matching '*.txt' 05:16:13 INFO - no previously-included directories found matching 'build' 05:16:13 INFO - no previously-included directories found matching 'dist' 05:16:13 INFO - no previously-included directories found matching '.git*' 05:16:13 INFO - Successfully installed jsonschema functools32 05:16:13 INFO - Cleaning up... 05:16:13 INFO - Return code: 0 05:16:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f5bd2db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2737dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca3d0>, '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 0x2735ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2736360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', '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 05:16:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:16:13 INFO - Using env: {'DISPLAY': ':0', 05:16:13 INFO - 'HOME': '/home/cltbld', 05:16:13 INFO - 'LANG': 'en_US.UTF-8', 05:16:13 INFO - 'LANGUAGE': 'en_US:en', 05:16:13 INFO - 'LOGNAME': 'cltbld', 05:16:13 INFO - 'MAIL': '/var/mail/cltbld', 05:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:13 INFO - 'MOZ_NO_REMOTE': '1', 05:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:13 INFO - 'NO_EM_RESTART': '1', 05:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:13 INFO - 'PWD': '/builds/slave/test', 05:16:13 INFO - 'SHELL': '/bin/bash', 05:16:13 INFO - 'SHLVL': '1', 05:16:13 INFO - 'TERM': 'linux', 05:16:13 INFO - 'TMOUT': '86400', 05:16:13 INFO - 'USER': 'cltbld', 05:16:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', 05:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:13 INFO - '_': '/tools/buildbot/bin/python'} 05:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:13 INFO - Downloading/unpacking flake8 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:16:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:16:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:16:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:15 INFO - no previously-included directories found matching 'docs/_build' 05:16:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:16:15 INFO - Running setup.py install for pep8 05:16:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:16 INFO - no previously-included directories found matching 'docs/_build' 05:16:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:16:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:16:16 INFO - Cleaning up... 05:16:16 INFO - Return code: 0 05:16:16 INFO - Running post-action listener: _resource_record_post_action 05:16:16 INFO - Running post-action listener: _start_resource_monitoring 05:16:16 INFO - Starting resource monitoring. 05:16:16 INFO - ##### 05:16:16 INFO - ##### Running install step. 05:16:16 INFO - ##### 05:16:16 INFO - Running pre-action listener: _resource_record_pre_action 05:16:16 INFO - Running main action method: install 05:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:16 INFO - Reading from file tmpfile_stdout 05:16:16 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:16 INFO - Reading from file tmpfile_stdout 05:16:16 INFO - Output received: 05:16:16 INFO - Usage: mozinstall [options] installer 05:16:16 INFO - Options: 05:16:16 INFO - -h, --help show this help message and exit 05:16:16 INFO - -d DEST, --destination=DEST 05:16:16 INFO - Directory to install application into. [default: 05:16:16 INFO - "/builds/slave/test"] 05:16:16 INFO - --app=APP Application being installed. [default: firefox] 05:16:16 INFO - mkdir: /builds/slave/test/build/application 05:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:16:32 INFO - Reading from file tmpfile_stdout 05:16:32 INFO - Output received: 05:16:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:16:32 INFO - Running post-action listener: _resource_record_post_action 05:16:32 INFO - ##### 05:16:32 INFO - ##### Running run-tests step. 05:16:32 INFO - ##### 05:16:32 INFO - Running pre-action listener: _resource_record_pre_action 05:16:32 INFO - Running main action method: run_tests 05:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:32 INFO - Python 2.7.3 05:16:32 INFO - Return code: 0 05:16:32 INFO - grabbing minidump binary from tooltool 05:16:32 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')]} 05:16:32 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 0x27ca3d0>, '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 0x2735ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2736360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:32 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 05:16:32 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 05:16:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:32 INFO - Return code: 0 05:16:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:16:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:16:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:16:33 INFO - Return code: 0 05:16:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:16:33 INFO - Using env: {'DISPLAY': ':0', 05:16:33 INFO - 'HOME': '/home/cltbld', 05:16:33 INFO - 'LANG': 'en_US.UTF-8', 05:16:33 INFO - 'LANGUAGE': 'en_US:en', 05:16:33 INFO - 'LOGNAME': 'cltbld', 05:16:33 INFO - 'MAIL': '/var/mail/cltbld', 05:16:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:33 INFO - 'MOZ_NO_REMOTE': '1', 05:16:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:33 INFO - 'NO_EM_RESTART': '1', 05:16:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:33 INFO - 'PWD': '/builds/slave/test', 05:16:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:33 INFO - 'SHELL': '/bin/bash', 05:16:33 INFO - 'SHLVL': '1', 05:16:33 INFO - 'TERM': 'linux', 05:16:33 INFO - 'TMOUT': '86400', 05:16:33 INFO - 'USER': 'cltbld', 05:16:33 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135', 05:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:33 INFO - '_': '/tools/buildbot/bin/python'} 05:16:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:16:33 INFO - mozversion application_buildid: 20160203070736 05:16:33 INFO - mozversion application_changeset: 97c27a348f0963da5bce6b667612e7ba2d209078 05:16:33 INFO - mozversion application_display_name: Nightly 05:16:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:33 INFO - mozversion application_name: Firefox 05:16:33 INFO - mozversion application_remotingname: firefox 05:16:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:16:33 INFO - mozversion application_vendor: Mozilla 05:16:33 INFO - mozversion application_version: 47.0a1 05:16:33 INFO - mozversion platform_buildid: 20160203070736 05:16:33 INFO - mozversion platform_changeset: 97c27a348f0963da5bce6b667612e7ba2d209078 05:16:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:16:33 INFO - mozversion platform_version: 47.0a1 05:16:33 INFO - using testdate: 1454764593 05:16:33 INFO - actual date: 1454764593 05:16:33 INFO - starting webserver on 'localhost:54332' 05:16:33 INFO - SUITE-START | Running 2 tests 05:16:33 INFO - TEST-START | dromaeo_css 05:16:33 INFO - operating with platform_type : linux_ 05:16:33 INFO - Initialising browser for dromaeo_css test... 05:16:33 INFO - TEST-INFO | started process 4235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY81GYu/profile http://localhost:54332/getInfo.html) 05:16:33 INFO - PROCESS | 4235 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 05:16:38 INFO - PROCESS | 4235 | 05:16:38 INFO - PROCESS | 4235 | (process:4315): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:16:39 INFO - PROCESS | 4235 | __metrics Screen width/height:1600/1200 05:16:39 INFO - PROCESS | 4235 | colorDepth:24 05:16:39 INFO - PROCESS | 4235 | Browser inner width/height: 1024/697 05:16:39 INFO - PROCESS | 4235 | __metrics 05:16:39 INFO - PROCESS | 4235 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:16:39 ERROR - PROCESS | 4235 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2830: TypeError: this.tabs is undefined 05:16:39 INFO - PROCESS | 4235 | ************************* 05:16:39 INFO - PROCESS | 4235 | A coding exception was thrown in a Promise resolution callback. 05:16:39 INFO - PROCESS | 4235 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 05:16:39 INFO - PROCESS | 4235 | 05:16:39 ERROR - PROCESS | 4235 | Full message: TypeError: this.tabs is undefined 05:16:39 INFO - PROCESS | 4235 | Full stack: .get@chrome://browser/content/tabbrowser.xml:2830:17 05:16:39 INFO - PROCESS | 4235 | ssi_onClose/<@resource:///modules/sessionstore/SessionStore.jsm:1323:9 05:16:39 INFO - PROCESS | 4235 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 05:16:39 INFO - PROCESS | 4235 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 05:16:39 INFO - PROCESS | 4235 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 05:16:39 INFO - PROCESS | 4235 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 05:16:39 INFO - PROCESS | 4235 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 05:16:39 INFO - PROCESS | 4235 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:146:5 05:16:39 INFO - PROCESS | 4235 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:52:5 05:16:39 INFO - PROCESS | 4235 | receiveMessage@resource:///modules/sessionstore/SessionStore.jsm:734:11 05:16:39 INFO - PROCESS | 4235 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 05:16:39 INFO - PROCESS | 4235 | 05:16:39 INFO - PROCESS | 4235 | ************************* 05:16:40 INFO - TEST-INFO | 4235: exit 0 05:16:40 INFO - Browser initialized. 05:16:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:40 INFO - TEST-INFO | started process 4364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY81GYu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:41 INFO - PROCESS | 4364 | 05:16:41 INFO - PROCESS | 4364 | (process:4421): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:16:52 INFO - PROCESS | 4364 | RSS: Main: 152477696 05:16:52 INFO - PROCESS | 4364 | 05:17:42 INFO - PROCESS | 4364 | 1454764662047 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] 05:19:53 INFO - PROCESS | 4364 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54332/tests/dromaeo/cssquery-ext.html) 05:19:54 INFO - PROCESS | 4364 | RSS: Main: 160464896 05:19:54 INFO - PROCESS | 4364 | 05:22:56 INFO - PROCESS | 4364 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-ext.html (next: http://localhost:54332/tests/dromaeo/cssquery-jquery.html) 05:22:57 INFO - PROCESS | 4364 | RSS: Main: 156078080 05:22:57 INFO - PROCESS | 4364 | 05:25:59 INFO - PROCESS | 4364 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54332/tests/dromaeo/cssquery-mootools.html) 05:25:59 INFO - PROCESS | 4364 | RSS: Main: 156540928 05:25:59 INFO - PROCESS | 4364 | 05:29:01 INFO - PROCESS | 4364 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54332/tests/dromaeo/cssquery-prototype.html) 05:29:02 INFO - PROCESS | 4364 | RSS: Main: 154308608 05:29:02 INFO - PROCESS | 4364 | 05:32:04 INFO - PROCESS | 4364 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54332/tests/dromaeo/cssquery-yui.html) 05:32:05 INFO - PROCESS | 4364 | RSS: Main: 154611712 05:32:05 INFO - PROCESS | 4364 | 05:35:07 INFO - PROCESS | 4364 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-yui.html (next: http://localhost:54332/tests/dromaeo/cssquery-dojo.html) 05:35:08 INFO - PROCESS | 4364 | RSS: Main: 158343168 05:35:08 INFO - PROCESS | 4364 | 05:35:08 INFO - PROCESS | 4364 | __start_tp_report 05:35:08 INFO - PROCESS | 4364 | _x_x_mozilla_page_load 05:35:08 INFO - PROCESS | 4364 | _x_x_mozilla_page_load_details 05:35:08 INFO - PROCESS | 4364 | |i|pagename|runs| 05:35:08 INFO - PROCESS | 4364 | |0;dojo.html;2644.7751941085007;2666.546687063199;2702.6081218223358;2707.8781454834516;2723.9046633367825;4607.07858428314;4662.463816661085;4699.929501057487;4726.19654658708;4778.378810754602;4628.930566041512;4677.976610116944;4701.764911754407;4728.621710263179;4759.4288685357715;4279.700420970534;4286.892827679318;4400.603945644892;4410.49279332876;4427.225235583776;4175.791210439481;4306.332518459643;4317.201317756225;4336.653067754588;4385.122975404932;4244.257254980366;4250.59619336161;4311.051568654891;4323.351497275434;4345.087531618364;4279.828806847722;4287.764172970486;4297.59172878576;4309.806058727365;4313.331433627762;4165.66674666026;4255.5318914919335;4267.6375790856;4269.338252570857;4314.245007123772;4587.1513769952335;4666.510016448258;4695.1783437898575;4697.412823397075;4703.858884233478;5000.699958002531;5008.574271186953;5010.298558201855;5015.072211640858;5041.395032596075;4876.439209490918;4957.182064959314;5008.724520151391;5030.170021946411;5089.134847076006;4680.063987202573;4702.106599746037;4703.788329525214;4709.481956984729;4738.455077666113;5142.177251639794;5166.741662916839;5173.767180476888;5178.533931946143;5185.507376799198;4800.967791924753;4895.167821470359;4929.556339929351;4981.825636102719;4996.7501624918605;4975.154223781966;4979.377577802775;4985.102681517362;5028.899422011539;5064.063148317573;4966.255061740768;4967.90064198714;4980.950190498121;4981.153203955337;5018.146915024455;4832.106060378841;4919;4958.801647934114;5000.699958002531;5071.54356107952;4099.036726369301;4127.938080928789;4131.194417088639;4156.56356082613;4191.895202619898;3566.144125409883;3636.290923269937;3663.9267214655556;3671.779693218362;3695.611960744137;4295.742255464682;4296.419983302277;4364.258076127066;4365.3670217818235;4404.339349097597;5050.242463630411;5052.747362631853;5076.162433198555;5077.492250774967;5086.415062267886;4224.239636865333;4298.89252768677;4348;4356.4336636237085;4366.323219900921;4413.889652758707;4423.225935461282;4443.289073748185;4447.3773671685985;4463.665225108065;4750.429948406213;4787.593054590329;4809.110314591811;4810.13417584838;4836.12949669063;4842.5157484251295;4974.477679843564;5019.799208031784;5023.171176755941;5058.418281897481;4802.975985120052;4811.470738218723;4818.4217893851555;4832.34763306949;4855.6601037927;4975.402951645826;4990.775415106402;4994.80020799164;5006.499350064964;5060.949390506048;4923.753812309298;5003.674761140514;5036.420811606566;5091.032703786269;5111.744412779421;4844.515548445127;4845;4859.854204373874;4860.975695121643;4908.4355299139625;4848.200046992207;4856.320115183807;4862.440819305683;4865.489123641966;4901.117798796108;4677.368555244999;4752.382190315237;4764.976175119103;4809.254565542346;4828.7102773833685;4914.827981020647;4932.4081110267;4944.802207911644;4960.553550180501;5009.9248511271635;4707.19977603815;4831.4202295724735;4850;4858.028394321079;4895.559399654048 05:35:08 INFO - PROCESS | 4364 | |1;ext.html;478.08446824331406;479.9232122860342;487.9999999999998;506.89101843103737;521.0594876248371;31884.68115318846;32966;33032.834835825844;33180.66819331809;33200.83399583005;37550.8122459388;37699.434508482394;37983.81008094956;38241;38257.23485530288;7758.573278469696;7879.881801772978;7881.645325960317;7893.684252629888;7952.483088599222;7809.843803123934;7908.525488470681;7939.285464308211;7970.840583188333;7990.680372785082;8097.392695547828;8215.055268644093;8253.628586713583;8268.586570671472;8289.709860154895;8114.6754129835035;8134.796630084236;8167.632456539411;8205.83588328233;8234.505929644181;7899.842003159904;8085.07021692507;8086.312663423616;8090.312323452514;8119.918800811975;37504.24991500155;37784.24431511382;37857.81071094654;37865.24269514594;37933;2498.575242208829;3060.877564897424;3067.662557118715;3235.563198968133;3277.2298509850166;25199.244022679348;25210.873945630337;25319.62020569693;25433.618495722578;25973.610395844076;3425.4348032574594;3451.447768357051;3476.2526056897887;3488.389531831919;3570.143165640228;175283;177698;177748;178851.9999999987;228070.99999999834;37710.24579508449;55697.443025570035;57445.71277143671;57510.424895750504;57521.71239143777;51698.6735596899;51829;51965.7401712989;52296;52450;12428.316442595744;12546.372681365896;12557.246565206116;12590.81113783294;12604;9250.768730781785;9294.535273236312;9353.39202951806;9369.765755856022;9436.622535098519;18480.260789568536;19071.427857164308;19144.904275478533;19237;19274.71087933682;7578.4316176287;7846.607669616496;7859.253370929752;7878.960605196938;7935.484193527518;812.5815205169342;831.1812864328631;852.2798235491;865.8311629232239;976.9023097690316;26329.21012369632;26677.86661066721;26921.596176057374;26930.596041059398;27050;928.4150984879483;940.9012053734397;974.2060220919927;988.9258305627106;1033.8707661542308;15184;15346.616334591501;15407.229638518029;15471.303791329417;15599.922000389925;325261;329968;331318;334137;334693;49467;49968.25047624289;50180.498195018314;50260.24609630858;50398.49601503938;1131.7114135895295;1134.03606934107;1196.1925700152362;1212.2362911365783;1230.2987297240486;28246.71753282441;28483;29042.854785725936;29116.7088329114;29212.26969325784;42423.787881060394;43222.567774321855;43650;43656.126877462906;43748.78125609351;194933;197830;198463;198799;199378;39135.6086439132;39269.21461570695;39279.41080883846;39463.408048878715;40180.79909600433;37062;38683.41974870323;39244;39563.80218098891;39582.208355833296;33099.338013240085;33844.83077584596;34047.14882127967;34199.487007694406;34512;33516.329673405904;33661.83169084139;33911.15222119368;33985.490217646264;34014.48978265378;33565.16087097842;33872.49191262182;34075.65924340725;34248.65751342455;34341.141471463416;29050;31054.844725776227;31316.53025204578;31469.74121035133;31497.21256968594;23987;24043.278701638978;24102.758972410753;24148.275551733477;24375.390615234763 05:35:08 INFO - PROCESS | 4364 | |2;jquery.html;343.52593421078905;347.813919553039;348.3833614502331;350.21551724137936;352.2286193236813;14530.564083077512;14857.40570377185;15252.313645885934;15954.76067858983;16409.09749963753;9879.456629885353;9998.150157236625;12727.872721272784;14996.625084372896;15005.549833505012;4551.88620284493;4652.464966528842;4680.204365257898;4785.784639691205;4797.352357431754;4650.395448591678;4733;4735.526447355272;4754.572088512034;4754.762261886909;4646.395968524104;4763;4885.828995985141;5117.641765076446;5141.228815677641;4971.950280497185;5033.295338652591;5062.936783275517;5081.339425874631;5337.839864804023;5061.468545802674;5096.235564665293;5133.640645154841;5143.099957507421;5154.742262886841;17925.73111403317;18027.909860450745;18134.546636334064;18490.815091849043;18598.535036624056;1680.5546530169515;1686.3001854230479;1710.1107424139502;1923.2595450751562;2009.3770931011434;8111.918880811176;8415.495070295801;8420.621072051772;8583.871241931376;8635.913640863573;1664.176232764777;1716.356366362614;1761.674090293287;1785.9285628574842;1804.9097545122822;50436.23473178458;52942.20586691241;54140.72929635366;54842.35472935818;54999.72500137474;9627.951860240653;9755.560999755027;9801.068898454636;9842.261830362751;9884.11043006133;12287.754244915051;12365.319907404999;12430.192037517532;12445.75108497825;12476.750464990831;6443.935560644427;6490.091387205795;6587.341265873374;6798.388145066869;6822;6324.525660575475;6346.58747181441;6359.459445947054;6368.872622547523;6378.681065946684;4159.667226621924;4180.205760905418;4207.747535147901;4230.7884605770205;4241.448611680524;1611.717949358881;1730.2732852202105;1758.156085079169;1773.6098058427126;1804.8556115510728;385.4680540853604;392.70939504766267;427.79038271246867;436.25836078666396;796.482286513759;9057.36598438103;9319.254459643213;9327.953360233156;9560.952195239119;9694.079062489052;384.27947598253274;384.63843986652455;389.9668528175137;422.51410877491134;427.73694178080257;3956.8219430125714;5127.564157046618;5331.253624492574;5360.597955153379;5362.115250983622;466889;470296;504228;509754;521841;64207;68525;68608.3139168612;69059.65470172618;70141.29858701449;443.09166209270865;445.97770111494947;447.55915423308664;450.07734145002615;450.5584527163464;9030.864537031819;9110.90889091127;9198.632054717737;9239.907600923905;9390.920044195005;27507.449851003268;28219;28812.855935721025;29139.562906555995;29883;45304;46190.53809461863;46209.53790462052;46219.76890115528;46455.76772116118;6711.697973591297;6935.237123916466;6944.131983502062;7003.4747393944635;7015.36861682451;9216.216621586971;10185.337953033326;10263;10285.382877027403;10475.266731329039;8159.939207902935;8366.539840308842;8546.316294696286;8838.602262898057;8997.505137217517;2441.877906104652;7429.774087275539;8557.743267701979;8641.870371944551;9177.816443671223;9176.128267814547;9236.584353704235;9295.11696388842;9357.906420935704;9398.53007349616;6553.803385898431;6794.150731158606;6862.862742745217;6873.931260687529;6995.265497122728;8882.511461869659;8954.641814327353;8969.14793094655;9346.719598412059;9353.298502612468 05:35:08 INFO - PROCESS | 4364 | |3;mootools.html;1398.8041674165615;1417.0930604413177;1568.5843251538345;1767.1164417791103;1767.1605987156095;6294.905576416358;6358.237011558608;7251.709931602736;7495.287947644979;7522.511036782612;6989.860202795941;7075.858482830353;7178.2103968563415;7185.245549217335;7206.171290301617;2166.7833216678323;2189.4526368407896;2204.9559008819815;2207.39296693409;2209.491816882118;2080.43828166395;2138.4760733620283;2155.6119898418356;2156.212982261471;2160.114353115223;2106.1575369852103;2115.6932244824493;2118.4809721618226;2131.8081372676456;2196;2184.770599087097;2187.2563328468236;2188.562287542482;2198.4503874031493;2204.371754050096;2177.5862586108747;2208.017432242653;2210.126999835072;2210.8784016879067;2212.7344718633867;7569.7350592729545;7599.278068583476;7610.7336243231775;7613.390928725744;7621.771346859603;4312.568743125694;4374.8906277343;4441.511433742286;4450.621697155713;4459.375687403766;2823.6752773431112;2868.3116052147543;2948.5429758387486;2953.040261914865;2967.2730181105767;858.6050416808275;864.0927026622085;883.7967267528504;888.4536010353651;928.1043792739971;10363.896361036444;10426.79146417075;10427.582896684124;10523.78952420955;10543;4041.1109555897656;4051.39229115635;4102.118044620421;4114.259433302034;4115.753054816721;8774.868376974351;8838.381313308008;8873.157050080232;8888.822223555493;8921.464712117164;4386;4406.361077643788;4418.138462999748;4421.182081314967;4425.977870110693;3271.3947919634466;3349.447341188725;3906.453096566483;3970.285348637215;4021.8391264349684;3503.474478828196;3512.631173726773;3525.153963048901;3559.555055618048;3578.4453409721536;1129.2885482146196;1133.4276190523897;1148.5405837664835;1152.2970987697497;1157;1206.5053328135423;1207.4445754952644;1216.0636310041218;1230.4831970572382;1233.0012689721354;6826.078479405217;6838.829029274308;6885.414739747077;6900.551464154814;7115.5730656160795;1047.1308813684623;1064.499685147979;1081.259337353915;1091.143452389886;1102.9669109926715;5429.538489228381;5475.589330800206;5497.340319161726;5503.752331145028;5505.311836020497;8675.522846243392;8753.518556479456;9084.772880677903;9088.136627020422;9103.863442048374;9171.541422928827;9187;9219.078092190728;9230.53847307632;9264.675736349196;7036.437085033287;7130.288730704594;7166.211716711157;7167.641617919083;7189.5326803758635;6839.487038472234;6861.897071543831;6873.518853680194;6878.518503704692;6903.413209877217;7939.801504962422;8321.209485098905;8384.455010424303;8391.538465384463;8400.075991641037;8325;8456.365772567206;8467.57662116904;8479.406441549032;8485.87271190945;5575.944240557543;5771.480566749013;6285.779997700059;6490.740370385131;6509.121268628674;6898.068760717239;6935.237123916466;6966.059581956371;6989.33601307875;7018.929810701828;6452.35476452351;6519.902201466887;6548.443382312556;6629.07192992991;6759.121314229119;6442.742290308335;6469.547131700736;6502.414782669583;6517.217933847968;6519.08732777421;6520.543561950808;6522.608643481406;6552.27924928267;6563.146790917151;6572.507061970276;6006.759729610767;6123.112148738319;6161.815145545641;6170.691465426621;6203.906941395973;6212.689365531615;6220.844478888064;6259.843503912439;6262.655553944577;6269.028300613412 05:35:08 INFO - PROCESS | 4364 | |4;prototype.html;298.62969917302553;302.9136696041628;310.6412094031393;313.16697584425435;317.19590837227634;5513.50378465938;5656.745446454909;5659.547236221103;5696.259486266779;5700.572457065727;5572;5584.4136365681525;5617.325920889489;5639.295088113986;5650.982823091842;4047.6357127858487;4133.689973252003;4292.334688123346;4331;4333.349997500369;4122.299209134454;4177.4778152730905;4199.916001679964;4203;4208.747475151486;4119.8876303398065;4196.727212731163;4207.242696314662;4220.620144187023;4224.408582798411;4182.519010313822;4201.621854033121;4213.410122582825;4215.641670458015;4221;3647.908802279938;3669.6880765134997;3674.393725035393;3678.9080272993388;3679.889603311905;5276.261323414725;5370.570354371641;5377.059014672417;5378.946210537883;5383.542398896098;4876.487968763265;4882.072406242803;4891.1195984722735;4895.290182923456;4910.21436570147;5835.941640583582;5852.034414321632;5853.239078919756;5861.062230043172;5862.97068514659;4005.559388467266;4008.1382502761753;4011.919761604781;4015.759054456742;4026.979865100685;5900.232969713953;6109.541784366191;6208.006718924996;6210.472109870667;6214.130021796952;4171.833126674899;4202.096549241927;4205.978970105191;4213.346931225665;4225.598568136023;4283.593058659422;4287.614114729689;4290.89272768177;4295.162443323585;4337.15425492026;4961.42943561495;4962.975185124052;4971.254311853251;4972.5276098770555;4985.252212168204;5720.856978575569;5919.704014799243;5920.763169473259;5922.170896074553;5943.435373639497;1520.376645575331;1536.4391996921267;1541.6608346163825;1541.714782765192;1543.2283858070964;1025.3027941000191;1026.6047571684805;1038.055369613648;1042.8279333909973;1049.8477720730452;5065.341505604321;5084.13569693153;5084.262781896604;5095.87260318495;5099.719515426613;5856.385079566584;6003.549733769897;6023.247094113236;6055.636661800306;6153.784617538454;5086.720230387365;5092.10888094582;5101.387833460009;5121.743912804345;5123.590112790967;3255.1536600484046;3285.0309158797736;3302.702756751904;3303.2897926945343;3304.471284594453;5707.258056452634;5808.361080281165;5824.330202026821;5865.442782935615;5894.587378883522;6294.433500984934;6297.748090076438;6308.3060863305;6322;6331.050342448578;5743.62666426681;5743.655380677173;5791.594588378773;5812.941870581325;5831.912521312099;5996.67018313997;6035.849103772441;6068.393160683896;6087.482563982111;6114.755409783559;5964.31410387811;5998.70006499682;6000;6000.69996500182;6002.849928751816;5817;5823.155642431739;5823.35943046273;5831.271091113611;5836.883262334814;4292.441982542249;4293.849715259951;4300.333448315516;4303.720258183208;4307;5901;6104.6642434664745;6111.938880611137;6121.32665406796;6131.417515336036;5898.587098903207;5900.468957793819;5903.173555702291;5916.230889984275;5952.434518720715;5849.766009359578;5867.706614669335;5891.852703682271;5892.469677729025;5903.498202652822;5547.472990065938;5660.773569057356;5684.289463817023;5720.227769251098;5733.140028995684;5877.853053673693;5908.970455147697;5914.881702366015;5923.4076592340425;5932.851678708067;5557.083081291542;5772.855678608068;5775.451332123442;5781.277340332458;5786.739596718242 05:35:08 INFO - PROCESS | 4364 | |5;yui.html;676.6244734172534;751.8722412339433;768.19339693322;770.718687678997;773.9380849532038;11282.210245282833;11391.829122563158;11392.373419461937;11485.483153258103;11556.30662160269;13157.342132893342;13531.188128712283;13531.797023044663;13533.796993045087;13538.187708737483;608.1941427608415;624.4348864277836;778.1207235823525;789.5302295134386;794.2057942057942;791.1771757372354;801.1747899663357;802.7350974178536;807.3541167066353;809.1180613131685;830.3066939105854;830.7009476588423;832.7959649885787;833.4540875726378;833.9624716887755;811.8579248631495;814.2102160903913;820.9548474833912;823.1398188892622;826.2852632472927;612.1582823617526;616.9043798211285;617.8640699046202;618.3291129124905;619.6653806944245;12319.815202771966;12335.75328493434;12350.62948111558;12382.071344649097;12410.56563020299;11795.115366347472;11880.287182769061;12020.45907934145;12045.939770301093;12053.385648891242;9646.565904534313;9700.175485083777;9795.265355098325;9823.656172033945;9826;3237.8057316560844;3249.1877030742316;3288.8355582220793;3345;3353.5305057292;40356.798216009025;41862.37206441906;41864.16271674549;42297.36553951662;42371.36442953358;9548.42709437436;9572.9042709572;9666.95166524177;9706.272029597809;9724.70825875225;16124.67750645004;16199.190040497928;16203.432879849148;16209.270582823801;16270.186490675418;6478.125453063871;6483.286838447767;6518.315576864456;6590.934090659128;6719.42884854783;3718.721095917817;3720.720945929066;3750.887473375803;3764.792936388525;3817.675497582681;2687.8118531702594;2717.6331195288776;2727.277271523048;2729.126679462553;2748.1343376836235;505.98988020240125;552.0587398485573;561.6433564686454;564.25800072904;571.2145799525653;486.2050547355029;568.692905830855;569.532982953982;619.3001907844107;632.3929028132952;7995;8075.798105047304;8106.878396824052;8110.188981101961;8239;484.6583158872986;512.7743792731186;566.7109774015199;651.46905272203;656.7963931181349;3811.9809400953372;3827.961720382816;3848.365019771706;3886.4753258310334;3935.7244992850797;45614.31578526325;46078.769606151756;46753.53246467492;46790;46864;41132.38301425481;41288.38067428991;41334.58665413367;41338.1732365351;47064.7646761764;39813.80093099574;39948.20103597912;40055;40088.799556002035;40146.79926600348;8202;8271.751847444586;8445.282151017233;8445.619947102272;8572.614232359683;27525.72474275312;27739.44521109607;27741.167764967082;28849.134525964255;29127.417451651272;31693.683063169072;35580;37464.438033430066;37675.43486847754;37854.053648659006;9738.707838764849;10108.89891101109;10246.282760206714;10273.332233404804;10524;11292.153088518558;11482.94258528702;11487.942560287145;11587.826182607436;11801.468933898166;10851;11030.06244469197;11081.445927703744;11185.496652650487;11205.103591712807;10747.516361763895;10750.301230420311;10780.622678206226;10922.453877306261;11369;10027.849582256125;10227.28409011362;10838.620648277272;10932.125429965425;11275.548978041115;8191.631376587949;8336.291415229773;8354.289885359813;8546.572671366283;8695.087015863497;8141.79645508867;8798.164174403422;8877.866831997655;8881.644734210558;8940.329475289509 05:35:08 INFO - PROCESS | 4364 | __end_tp_report 05:35:08 INFO - PROCESS | 4364 | __start_cc_report 05:35:08 INFO - PROCESS | 4364 | _x_x_mozilla_cycle_collect,336 05:35:08 INFO - PROCESS | 4364 | __end_cc_report 05:35:08 INFO - PROCESS | 4364 | __startTimestamp1454765708146__endTimestamp 05:35:08 INFO - PROCESS | 4364 | 05:35:08 INFO - PROCESS | 4364 | ------- Summary: start ------- 05:35:08 INFO - PROCESS | 4364 | Number of tests: 6 05:35:08 INFO - PROCESS | 4364 | 05:35:08 INFO - PROCESS | 4364 | [#0] dojo.html Cycles:165 Average:4633.28 Median:4802.98 stddev:487.74 (10.2%) stddev-sans-first:463.62 05:35:08 INFO - PROCESS | 4364 | Values: 2644.8 2666.5 2702.6 2707.9 2723.9 4607.1 4662.5 4699.9 4726.2 4778.4 4628.9 4678.0 4701.8 4728.6 4759.4 4279.7 4286.9 4400.6 4410.5 4427.2 4175.8 4306.3 4317.2 4336.7 4385.1 4244.3 4250.6 4311.1 4323.4 4345.1 4279.8 4287.8 4297.6 4309.8 4313.3 4165.7 4255.5 4267.6 4269.3 4314.2 4587.2 4666.5 4695.2 4697.4 4703.9 5000.7 5008.6 5010.3 5015.1 5041.4 4876.4 4957.2 5008.7 5030.2 5089.1 4680.1 4702.1 4703.8 4709.5 4738.5 5142.2 5166.7 5173.8 5178.5 5185.5 4801.0 4895.2 4929.6 4981.8 4996.8 4975.2 4979.4 4985.1 5028.9 5064.1 4966.3 4967.9 4981.0 4981.2 5018.1 4832.1 4919.0 4958.8 5000.7 5071.5 4099.0 4127.9 4131.2 4156.6 4191.9 3566.1 3636.3 3663.9 3671.8 3695.6 4295.7 4296.4 4364.3 4365.4 4404.3 5050.2 5052.7 5076.2 5077.5 5086.4 4224.2 4298.9 4348.0 4356.4 4366.3 4413.9 4423.2 4443.3 4447.4 4463.7 4750.4 4787.6 4809.1 4810.1 4836.1 4842.5 4974.5 5019.8 5023.2 5058.4 4803.0 4811.5 4818.4 4832.3 4855.7 4975.4 4990.8 4994.8 5006.5 5060.9 4923.8 5003.7 5036.4 5091.0 5111.7 4844.5 4845.0 4859.9 4861.0 4908.4 4848.2 4856.3 4862.4 4865.5 4901.1 4677.4 4752.4 4765.0 4809.3 4828.7 4914.8 4932.4 4944.8 4960.6 5009.9 4707.2 4831.4 4850.0 4858.0 4895.6 05:35:08 INFO - PROCESS | 4364 | 05:35:08 INFO - PROCESS | 4364 | [#1] ext.html Cycles:180 Average:40395.32 Median:20316.07 stddev:64956.30 (319.7%) stddev-sans-first:65069.37 05:35:08 INFO - PROCESS | 4364 | Values: 478.1 479.9 488.0 506.9 521.1 31884.7 32966.0 33032.8 33180.7 33200.8 37550.8 37699.4 37983.8 38241.0 38257.2 7758.6 7879.9 7881.6 7893.7 7952.5 7809.8 7908.5 7939.3 7970.8 7990.7 8097.4 8215.1 8253.6 8268.6 8289.7 8114.7 8134.8 8167.6 8205.8 8234.5 7899.8 8085.1 8086.3 8090.3 8119.9 37504.2 37784.2 37857.8 37865.2 37933.0 2498.6 3060.9 3067.7 3235.6 3277.2 25199.2 25210.9 25319.6 25433.6 25973.6 3425.4 3451.4 3476.3 3488.4 3570.1 175283.0 177698.0 177748.0 178852.0 228071.0 37710.2 55697.4 57445.7 57510.4 57521.7 51698.7 51829.0 51965.7 52296.0 52450.0 12428.3 12546.4 12557.2 12590.8 12604.0 9250.8 9294.5 9353.4 9369.8 9436.6 18480.3 19071.4 19144.9 19237.0 19274.7 7578.4 7846.6 7859.3 7879.0 7935.5 812.6 831.2 852.3 865.8 976.9 26329.2 26677.9 26921.6 26930.6 27050.0 928.4 940.9 974.2 988.9 1033.9 15184.0 15346.6 15407.2 15471.3 15599.9 325261.0 329968.0 331318.0 334137.0 334693.0 49467.0 49968.3 50180.5 50260.2 50398.5 1131.7 1134.0 1196.2 1212.2 1230.3 28246.7 28483.0 29042.9 29116.7 29212.3 42423.8 43222.6 43650.0 43656.1 43748.8 194933.0 197830.0 198463.0 198799.0 199378.0 39135.6 39269.2 39279.4 39463.4 40180.8 37062.0 38683.4 39244.0 39563.8 39582.2 33099.3 33844.8 34047.1 34199.5 34512.0 33516.3 33661.8 33911.2 33985.5 34014.5 33565.2 33872.5 34075.7 34248.7 34341.1 29050.0 31054.8 31316.5 31469.7 31497.2 23987.0 24043.3 24102.8 24148.3 24375.4 05:35:08 INFO - PROCESS | 4364 | 05:35:08 INFO - PROCESS | 4364 | [#2] jquery.html Cycles:180 Average:24947.52 Median:277332.12 stddev:81045.01 (29.2%) stddev-sans-first:81251.30 05:35:08 INFO - PROCESS | 4364 | Values: 343.5 347.8 348.4 350.2 352.2 14530.6 14857.4 15252.3 15954.8 16409.1 9879.5 9998.2 12727.9 14996.6 15005.5 4551.9 4652.5 4680.2 4785.8 4797.4 4650.4 4733.0 4735.5 4754.6 4754.8 4646.4 4763.0 4885.8 5117.6 5141.2 4972.0 5033.3 5062.9 5081.3 5337.8 5061.5 5096.2 5133.6 5143.1 5154.7 17925.7 18027.9 18134.5 18490.8 18598.5 1680.6 1686.3 1710.1 1923.3 2009.4 8111.9 8415.5 8420.6 8583.9 8635.9 1664.2 1716.4 1761.7 1785.9 1804.9 50436.2 52942.2 54140.7 54842.4 54999.7 9628.0 9755.6 9801.1 9842.3 9884.1 12287.8 12365.3 12430.2 12445.8 12476.8 6443.9 6490.1 6587.3 6798.4 6822.0 6324.5 6346.6 6359.5 6368.9 6378.7 4159.7 4180.2 4207.7 4230.8 4241.4 1611.7 1730.3 1758.2 1773.6 1804.9 385.5 392.7 427.8 436.3 796.5 9057.4 9319.3 9328.0 9561.0 9694.1 384.3 384.6 390.0 422.5 427.7 3956.8 5127.6 5331.3 5360.6 5362.1 466889.0 470296.0 504228.0 509754.0 521841.0 64207.0 68525.0 68608.3 69059.7 70141.3 443.1 446.0 447.6 450.1 450.6 9030.9 9110.9 9198.6 9239.9 9390.9 27507.4 28219.0 28812.9 29139.6 29883.0 45304.0 46190.5 46209.5 46219.8 46455.8 6711.7 6935.2 6944.1 7003.5 7015.4 9216.2 10185.3 10263.0 10285.4 10475.3 8159.9 8366.5 8546.3 8838.6 8997.5 2441.9 7429.8 8557.7 8641.9 9177.8 9176.1 9236.6 9295.1 9357.9 9398.5 6553.8 6794.2 6862.9 6873.9 6995.3 8882.5 8954.6 8969.1 9346.7 9353.3 05:35:08 INFO - PROCESS | 4364 | 05:35:08 INFO - PROCESS | 4364 | [#3] mootools.html Cycles:180 Average:5200.98 Median:6187.30 stddev:2720.70 (44.0%) stddev-sans-first:2713.32 05:35:08 INFO - PROCESS | 4364 | Values: 1398.8 1417.1 1568.6 1767.1 1767.2 6294.9 6358.2 7251.7 7495.3 7522.5 6989.9 7075.9 7178.2 7185.2 7206.2 2166.8 2189.5 2205.0 2207.4 2209.5 2080.4 2138.5 2155.6 2156.2 2160.1 2106.2 2115.7 2118.5 2131.8 2196.0 2184.8 2187.3 2188.6 2198.5 2204.4 2177.6 2208.0 2210.1 2210.9 2212.7 7569.7 7599.3 7610.7 7613.4 7621.8 4312.6 4374.9 4441.5 4450.6 4459.4 2823.7 2868.3 2948.5 2953.0 2967.3 858.6 864.1 883.8 888.5 928.1 10363.9 10426.8 10427.6 10523.8 10543.0 4041.1 4051.4 4102.1 4114.3 4115.8 8774.9 8838.4 8873.2 8888.8 8921.5 4386.0 4406.4 4418.1 4421.2 4426.0 3271.4 3349.4 3906.5 3970.3 4021.8 3503.5 3512.6 3525.2 3559.6 3578.4 1129.3 1133.4 1148.5 1152.3 1157.0 1206.5 1207.4 1216.1 1230.5 1233.0 6826.1 6838.8 6885.4 6900.6 7115.6 1047.1 1064.5 1081.3 1091.1 1103.0 5429.5 5475.6 5497.3 5503.8 5505.3 8675.5 8753.5 9084.8 9088.1 9103.9 9171.5 9187.0 9219.1 9230.5 9264.7 7036.4 7130.3 7166.2 7167.6 7189.5 6839.5 6861.9 6873.5 6878.5 6903.4 7939.8 8321.2 8384.5 8391.5 8400.1 8325.0 8456.4 8467.6 8479.4 8485.9 5575.9 5771.5 6285.8 6490.7 6509.1 6898.1 6935.2 6966.1 6989.3 7018.9 6452.4 6519.9 6548.4 6629.1 6759.1 6442.7 6469.5 6502.4 6517.2 6519.1 6520.5 6522.6 6552.3 6563.1 6572.5 6006.8 6123.1 6161.8 6170.7 6203.9 6212.7 6220.8 6259.8 6262.7 6269.0 05:35:08 INFO - PROCESS | 4364 | 05:35:08 INFO - PROCESS | 4364 | [#4] prototype.html Cycles:180 Average:4861.18 Median:5530.49 stddev:1438.58 (26.0%) stddev-sans-first:1401.26 05:35:08 INFO - PROCESS | 4364 | Values: 298.6 302.9 310.6 313.2 317.2 5513.5 5656.7 5659.5 5696.3 5700.6 5572.0 5584.4 5617.3 5639.3 5651.0 4047.6 4133.7 4292.3 4331.0 4333.3 4122.3 4177.5 4199.9 4203.0 4208.7 4119.9 4196.7 4207.2 4220.6 4224.4 4182.5 4201.6 4213.4 4215.6 4221.0 3647.9 3669.7 3674.4 3678.9 3679.9 5276.3 5370.6 5377.1 5378.9 5383.5 4876.5 4882.1 4891.1 4895.3 4910.2 5835.9 5852.0 5853.2 5861.1 5863.0 4005.6 4008.1 4011.9 4015.8 4027.0 5900.2 6109.5 6208.0 6210.5 6214.1 4171.8 4202.1 4206.0 4213.3 4225.6 4283.6 4287.6 4290.9 4295.2 4337.2 4961.4 4963.0 4971.3 4972.5 4985.3 5720.9 5919.7 5920.8 5922.2 5943.4 1520.4 1536.4 1541.7 1541.7 1543.2 1025.3 1026.6 1038.1 1042.8 1049.8 5065.3 5084.1 5084.3 5095.9 5099.7 5856.4 6003.5 6023.2 6055.6 6153.8 5086.7 5092.1 5101.4 5121.7 5123.6 3255.2 3285.0 3302.7 3303.3 3304.5 5707.3 5808.4 5824.3 5865.4 5894.6 6294.4 6297.7 6308.3 6322.0 6331.1 5743.6 5743.7 5791.6 5812.9 5831.9 5996.7 6035.8 6068.4 6087.5 6114.8 5964.3 5998.7 6000.0 6000.7 6002.8 5817.0 5823.2 5823.4 5831.3 5836.9 4292.4 4293.8 4300.3 4303.7 4307.0 5901.0 6104.7 6111.9 6121.3 6131.4 5898.6 5900.5 5903.2 5916.2 5952.4 5849.8 5867.7 5891.9 5892.5 5903.5 5547.5 5660.8 5684.3 5720.2 5733.1 5877.9 5909.0 5914.9 5923.4 5932.9 5557.1 5772.9 5775.5 5781.3 5786.7 05:35:08 INFO - PROCESS | 4364 | 05:35:08 INFO - PROCESS | 4364 | [#5] yui.html Cycles:180 Average:12058.19 Median:42080.76 stddev:13160.16 (31.3%) stddev-sans-first:13169.32 05:35:08 INFO - PROCESS | 4364 | Values: 676.6 751.9 768.2 770.7 773.9 11282.2 11391.8 11392.4 11485.5 11556.3 13157.3 13531.2 13531.8 13533.8 13538.2 608.2 624.4 778.1 789.5 794.2 791.2 801.2 802.7 807.4 809.1 830.3 830.7 832.8 833.5 834.0 811.9 814.2 821.0 823.1 826.3 612.2 616.9 617.9 618.3 619.7 12319.8 12335.8 12350.6 12382.1 12410.6 11795.1 11880.3 12020.5 12045.9 12053.4 9646.6 9700.2 9795.3 9823.7 9826.0 3237.8 3249.2 3288.8 3345.0 3353.5 40356.8 41862.4 41864.2 42297.4 42371.4 9548.4 9572.9 9667.0 9706.3 9724.7 16124.7 16199.2 16203.4 16209.3 16270.2 6478.1 6483.3 6518.3 6590.9 6719.4 3718.7 3720.7 3750.9 3764.8 3817.7 2687.8 2717.6 2727.3 2729.1 2748.1 506.0 552.1 561.6 564.3 571.2 486.2 568.7 569.5 619.3 632.4 7995.0 8075.8 8106.9 8110.2 8239.0 484.7 512.8 566.7 651.5 656.8 3812.0 3828.0 3848.4 3886.5 3935.7 45614.3 46078.8 46753.5 46790.0 46864.0 41132.4 41288.4 41334.6 41338.2 47064.8 39813.8 39948.2 40055.0 40088.8 40146.8 8202.0 8271.8 8445.3 8445.6 8572.6 27525.7 27739.4 27741.2 28849.1 29127.4 31693.7 35580.0 37464.4 37675.4 37854.1 9738.7 10108.9 10246.3 10273.3 10524.0 11292.2 11482.9 11487.9 11587.8 11801.5 10851.0 11030.1 11081.4 11185.5 11205.1 10747.5 10750.3 10780.6 10922.5 11369.0 10027.8 10227.3 10838.6 10932.1 11275.5 8191.6 8336.3 8354.3 8546.6 8695.1 8141.8 8798.2 8877.9 8881.6 8940.3 05:35:08 INFO - PROCESS | 4364 | -------- Summary: end -------- 05:35:08 INFO - PROCESS | 4364 | 05:35:08 INFO - TEST-INFO | 4364: exit 0 05:35:08 INFO - TEST-OK | dromaeo_css | took 1115401ms 05:35:08 INFO - TEST-START | kraken 05:35:08 INFO - operating with platform_type : linux_ 05:35:08 INFO - Initialising browser for kraken test... 05:35:08 INFO - TEST-INFO | started process 4606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYP3oxf/profile http://localhost:54332/getInfo.html) 05:35:09 INFO - PROCESS | 4606 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 05:35:13 INFO - PROCESS | 4606 | 05:35:13 INFO - PROCESS | 4606 | (process:4673): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:35:14 INFO - PROCESS | 4606 | __metrics Screen width/height:1600/1200 05:35:14 INFO - PROCESS | 4606 | colorDepth:24 05:35:14 INFO - PROCESS | 4606 | Browser inner width/height: 1024/697 05:35:14 INFO - PROCESS | 4606 | __metrics 05:35:14 INFO - PROCESS | 4606 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:35:14 ERROR - PROCESS | 4606 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2830: TypeError: this.tabs is undefined 05:35:14 INFO - PROCESS | 4606 | ************************* 05:35:14 INFO - PROCESS | 4606 | A coding exception was thrown in a Promise resolution callback. 05:35:14 INFO - PROCESS | 4606 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 05:35:14 INFO - PROCESS | 4606 | 05:35:14 ERROR - PROCESS | 4606 | Full message: TypeError: this.tabs is undefined 05:35:14 INFO - PROCESS | 4606 | Full stack: .get@chrome://browser/content/tabbrowser.xml:2830:17 05:35:14 INFO - PROCESS | 4606 | ssi_onClose/<@resource:///modules/sessionstore/SessionStore.jsm:1323:9 05:35:14 INFO - PROCESS | 4606 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 05:35:14 INFO - PROCESS | 4606 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 05:35:14 INFO - PROCESS | 4606 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 05:35:14 INFO - PROCESS | 4606 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 05:35:14 INFO - PROCESS | 4606 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 05:35:14 INFO - PROCESS | 4606 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:146:5 05:35:14 INFO - PROCESS | 4606 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:52:5 05:35:14 INFO - PROCESS | 4606 | receiveMessage@resource:///modules/sessionstore/SessionStore.jsm:734:11 05:35:14 INFO - PROCESS | 4606 | 05:35:14 INFO - PROCESS | 4606 | ************************* 05:35:15 INFO - TEST-INFO | 4606: exit 0 05:35:15 INFO - Browser initialized. 05:35:15 INFO - Running cycle 1/1 for kraken test... 05:35:15 INFO - TEST-INFO | started process 4722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYP3oxf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:17 INFO - PROCESS | 4722 | 05:35:17 INFO - PROCESS | 4722 | (process:4782): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:35:27 INFO - PROCESS | 4722 | RSS: Main: 152485888 05:35:27 INFO - PROCESS | 4722 | 05:35:30 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:31 INFO - PROCESS | 4722 | RSS: Main: 156119040 05:35:31 INFO - PROCESS | 4722 | 05:35:33 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-dft) 05:35:34 INFO - PROCESS | 4722 | RSS: Main: 158629888 05:35:34 INFO - PROCESS | 4722 | 05:35:37 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-fft) 05:35:37 INFO - PROCESS | 4722 | RSS: Main: 149925888 05:35:37 INFO - PROCESS | 4722 | 05:35:40 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-oscillator) 05:35:40 INFO - PROCESS | 4722 | RSS: Main: 151056384 05:35:40 INFO - PROCESS | 4722 | 05:35:42 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54332/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:43 INFO - PROCESS | 4722 | RSS: Main: 152739840 05:35:43 INFO - PROCESS | 4722 | 05:35:46 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54332/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:47 INFO - PROCESS | 4722 | RSS: Main: 152535040 05:35:47 INFO - PROCESS | 4722 | 05:35:50 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54332/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:51 INFO - PROCESS | 4722 | RSS: Main: 153169920 05:35:51 INFO - PROCESS | 4722 | 05:35:54 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54332/tests/kraken/driver.html?testName=json-parse-financial) 05:35:54 INFO - PROCESS | 4722 | RSS: Main: 152571904 05:35:54 INFO - PROCESS | 4722 | 05:35:56 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54332/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:57 INFO - PROCESS | 4722 | RSS: Main: 153489408 05:35:57 INFO - PROCESS | 4722 | 05:35:59 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:59 INFO - PROCESS | 4722 | RSS: Main: 153632768 05:35:59 INFO - PROCESS | 4722 | 05:36:01 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:02 INFO - PROCESS | 4722 | RSS: Main: 154116096 05:36:02 INFO - PROCESS | 4722 | 05:36:05 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:05 INFO - PROCESS | 4722 | RSS: Main: 154816512 05:36:05 INFO - PROCESS | 4722 | 05:36:08 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:08 INFO - PROCESS | 4722 | RSS: Main: 153853952 05:36:08 INFO - PROCESS | 4722 | 05:36:10 INFO - PROCESS | 4722 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54332/tests/kraken/driver.html?testName=ai-astar) 05:36:11 INFO - PROCESS | 4722 | RSS: Main: 155746304 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | __start_tp_report 05:36:11 INFO - PROCESS | 4722 | _x_x_mozilla_page_load 05:36:11 INFO - PROCESS | 4722 | _x_x_mozilla_page_load_details 05:36:11 INFO - PROCESS | 4722 | |i|pagename|runs| 05:36:11 INFO - PROCESS | 4722 | |0;ai-astar;115;110;114;115;113;126;113;114;113;112 05:36:11 INFO - PROCESS | 4722 | |1;audio-beat-detection;153;132;160;172;135;161;167;135;171;138 05:36:11 INFO - PROCESS | 4722 | |2;audio-dft;162;163;163;162;165;166;166;164;164;163 05:36:11 INFO - PROCESS | 4722 | |3;audio-fft;75;75;75;73;139;77;74;74;77;96 05:36:11 INFO - PROCESS | 4722 | |4;audio-oscillator;99;99;146;99;99;98;134;97;100;134 05:36:11 INFO - PROCESS | 4722 | |5;imaging-gaussian-blur;120;117;115;116;115;116;115;116;115;116 05:36:11 INFO - PROCESS | 4722 | |6;imaging-darkroom;148;148;148;150;148;148;148;148;148;152 05:36:11 INFO - PROCESS | 4722 | |7;imaging-desaturate;96;97;97;97;96;96;101;98;97;96 05:36:11 INFO - PROCESS | 4722 | |8;json-parse-financial;70;70;67;70;68;70;68;70;69;66 05:36:11 INFO - PROCESS | 4722 | |9;json-stringify-tinderbox;69;70;70;69;70;70;71;70;70;69 05:36:11 INFO - PROCESS | 4722 | |10;stanford-crypto-aes;92;86;88;86;87;94;87;88;87;88 05:36:11 INFO - PROCESS | 4722 | |11;stanford-crypto-ccm;126;129;123;131;126;132;124;123;125;121 05:36:11 INFO - PROCESS | 4722 | |12;stanford-crypto-pbkdf2;147;158;157;152;155;147;154;152;150;147 05:36:11 INFO - PROCESS | 4722 | |13;stanford-crypto-sha256-iterative;75;75;73;72;71;73;72;72;71;71 05:36:11 INFO - PROCESS | 4722 | __end_tp_report 05:36:11 INFO - PROCESS | 4722 | __start_cc_report 05:36:11 INFO - PROCESS | 4722 | _x_x_mozilla_cycle_collect,816 05:36:11 INFO - PROCESS | 4722 | __end_cc_report 05:36:11 INFO - PROCESS | 4722 | __startTimestamp1454765771018__endTimestamp 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | ------- Summary: start ------- 05:36:11 INFO - PROCESS | 4722 | Number of tests: 14 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.00 stddev:4.30 (3.8%) stddev-sans-first:4.56 05:36:11 INFO - PROCESS | 4722 | Values: 115.0 110.0 114.0 115.0 113.0 126.0 113.0 114.0 113.0 112.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:160.50 stddev:16.00 (10.0%) stddev-sans-first:16.97 05:36:11 INFO - PROCESS | 4722 | Values: 153.0 132.0 160.0 172.0 135.0 161.0 167.0 135.0 171.0 138.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.48 (0.9%) stddev-sans-first:1.41 05:36:11 INFO - PROCESS | 4722 | Values: 162.0 163.0 163.0 162.0 165.0 166.0 166.0 164.0 164.0 163.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.00 stddev:20.62 (27.5%) stddev-sans-first:21.65 05:36:11 INFO - PROCESS | 4722 | Values: 75.0 75.0 75.0 73.0 139.0 77.0 74.0 74.0 77.0 96.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:98.50 stddev:19.27 (19.6%) stddev-sans-first:19.99 05:36:11 INFO - PROCESS | 4722 | Values: 99.0 99.0 146.0 99.0 99.0 98.0 134.0 97.0 100.0 134.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:116.00 stddev:1.52 (1.3%) stddev-sans-first:0.71 05:36:11 INFO - PROCESS | 4722 | Values: 120.0 117.0 115.0 116.0 115.0 116.0 115.0 116.0 115.0 116.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.00 stddev:1.35 (0.9%) stddev-sans-first:1.41 05:36:11 INFO - PROCESS | 4722 | Values: 148.0 148.0 148.0 150.0 148.0 148.0 148.0 148.0 148.0 152.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:1.52 (1.6%) stddev-sans-first:1.56 05:36:11 INFO - PROCESS | 4722 | Values: 96.0 97.0 97.0 97.0 96.0 96.0 101.0 98.0 97.0 96.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:70.00 stddev:1.48 (2.1%) stddev-sans-first:1.50 05:36:11 INFO - PROCESS | 4722 | Values: 70.0 70.0 67.0 70.0 68.0 70.0 68.0 70.0 69.0 66.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 05:36:11 INFO - PROCESS | 4722 | Values: 69.0 70.0 70.0 69.0 70.0 70.0 71.0 70.0 70.0 69.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:88.00 stddev:2.63 (3.0%) stddev-sans-first:2.42 05:36:11 INFO - PROCESS | 4722 | Values: 92.0 86.0 88.0 86.0 87.0 94.0 87.0 88.0 87.0 88.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.00 stddev:3.62 (2.9%) stddev-sans-first:3.84 05:36:11 INFO - PROCESS | 4722 | Values: 126.0 129.0 123.0 131.0 126.0 132.0 124.0 123.0 125.0 121.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:153.00 stddev:4.12 (2.7%) stddev-sans-first:3.97 05:36:11 INFO - PROCESS | 4722 | Values: 147.0 158.0 157.0 152.0 155.0 147.0 154.0 152.0 150.0 147.0 05:36:11 INFO - PROCESS | 4722 | 05:36:11 INFO - PROCESS | 4722 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:1.51 (2.1%) stddev-sans-first:1.30 05:36:11 INFO - PROCESS | 4722 | Values: 75.0 75.0 73.0 72.0 71.0 73.0 72.0 72.0 71.0 71.0 05:36:11 INFO - PROCESS | 4722 | -------- Summary: end -------- 05:36:11 INFO - PROCESS | 4722 | 05:36:12 INFO - TEST-INFO | 4722: exit 0 05:36:12 INFO - TEST-OK | kraken | took 63210ms 05:36:12 INFO - SUITE-END | took 1178s 05:36:12 INFO - Completed test suite (00:19:38) 05:36:12 INFO - Working with test: dromaeo_css 05:36:12 INFO - Generating results file: dromaeo_css 05:36:12 INFO - Working with test: kraken 05:36:12 INFO - Generating results file: kraken 05:36:12 INFO - javascript benchmark 05:36:12 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:36:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 05:36:12 INFO - process_Request line: dromaeo_css 6203.33 graph.html#tests=[[72,132,43]] 05:36:12 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:36:12 INFO - process_Request line: kraken 1563.80 graph.html#tests=[[232,132,43]] 05:36:12 INFO - RETURN: dromaeo_css: 6203.33 05:36:12 INFO - RETURN: kraken: 1563.80 05:36:12 INFO - javascript benchmark 05:36:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2644.7751941085007, 2666.546687063199, 2702.6081218223358, 2707.8781454834516, 2723.9046633367825, 4607.07858428314, 4662.463816661085, 4699.929501057487, 4726.19654658708, 4778.378810754602, 4628.930566041512, 4677.976610116944, 4701.764911754407, 4728.621710263179, 4759.4288685357715, 4279.700420970534, 4286.892827679318, 4400.603945644892, 4410.49279332876, 4427.225235583776, 4175.791210439481, 4306.332518459643, 4317.201317756225, 4336.653067754588, 4385.122975404932, 4244.257254980366, 4250.59619336161, 4311.051568654891, 4323.351497275434, 4345.087531618364, 4279.828806847722, 4287.764172970486, 4297.59172878576, 4309.806058727365, 4313.331433627762, 4165.66674666026, 4255.5318914919335, 4267.6375790856, 4269.338252570857, 4314.245007123772, 4587.1513769952335, 4666.510016448258, 4695.1783437898575, 4697.412823397075, 4703.858884233478, 5000.699958002531, 5008.574271186953, 5010.298558201855, 5015.072211640858, 5041.395032596075, 4876.439209490918, 4957.182064959314, 5008.724520151391, 5030.170021946411, 5089.134847076006, 4680.063987202573, 4702.106599746037, 4703.788329525214, 4709.481956984729, 4738.455077666113, 5142.177251639794, 5166.741662916839, 5173.767180476888, 5178.533931946143, 5185.507376799198, 4800.967791924753, 4895.167821470359, 4929.556339929351, 4981.825636102719, 4996.7501624918605, 4975.154223781966, 4979.377577802775, 4985.102681517362, 5028.899422011539, 5064.063148317573, 4966.255061740768, 4967.90064198714, 4980.950190498121, 4981.153203955337, 5018.146915024455, 4832.106060378841, 4919.0, 4958.801647934114, 5000.699958002531, 5071.54356107952, 4099.036726369301, 4127.938080928789, 4131.194417088639, 4156.56356082613, 4191.895202619898, 3566.144125409883, 3636.290923269937, 3663.9267214655556, 3671.779693218362, 3695.611960744137, 4295.742255464682, 4296.419983302277, 4364.258076127066, 4365.3670217818235, 4404.339349097597, 5050.242463630411, 5052.747362631853, 5076.162433198555, 5077.492250774967, 5086.415062267886, 4224.239636865333, 4298.89252768677, 4348.0, 4356.4336636237085, 4366.323219900921, 4413.889652758707, 4423.225935461282, 4443.289073748185, 4447.3773671685985, 4463.665225108065, 4750.429948406213, 4787.593054590329, 4809.110314591811, 4810.13417584838, 4836.12949669063, 4842.5157484251295, 4974.477679843564, 5019.799208031784, 5023.171176755941, 5058.418281897481, 4802.975985120052, 4811.470738218723, 4818.4217893851555, 4832.34763306949, 4855.6601037927, 4975.402951645826, 4990.775415106402, 4994.80020799164, 5006.499350064964, 5060.949390506048, 4923.753812309298, 5003.674761140514, 5036.420811606566, 5091.032703786269, 5111.744412779421, 4844.515548445127, 4845.0, 4859.854204373874, 4860.975695121643, 4908.4355299139625, 4848.200046992207, 4856.320115183807, 4862.440819305683, 4865.489123641966, 4901.117798796108, 4677.368555244999, 4752.382190315237, 4764.976175119103, 4809.254565542346, 4828.7102773833685, 4914.827981020647, 4932.4081110267, 4944.802207911644, 4960.553550180501, 5009.9248511271635, 4707.19977603815, 4831.4202295724735, 4850.0, 4858.028394321079, 4895.559399654048], "unit": "score", "name": "dojo.html", "value": 4602.590971945009}, {"lowerIsBetter": false, "replicates": [478.08446824331406, 479.9232122860342, 487.9999999999998, 506.89101843103737, 521.0594876248371, 31884.68115318846, 32966.0, 33032.834835825844, 33180.66819331809, 33200.83399583005, 37550.8122459388, 37699.434508482394, 37983.81008094956, 38241.0, 38257.23485530288, 7758.573278469696, 7879.881801772978, 7881.645325960317, 7893.684252629888, 7952.483088599222, 7809.843803123934, 7908.525488470681, 7939.285464308211, 7970.840583188333, 7990.680372785082, 8097.392695547828, 8215.055268644093, 8253.628586713583, 8268.586570671472, 8289.709860154895, 8114.6754129835035, 8134.796630084236, 8167.632456539411, 8205.83588328233, 8234.505929644181, 7899.842003159904, 8085.07021692507, 8086.312663423616, 8090.312323452514, 8119.918800811975, 37504.24991500155, 37784.24431511382, 37857.81071094654, 37865.24269514594, 37933.0, 2498.575242208829, 3060.877564897424, 3067.662557118715, 3235.563198968133, 3277.2298509850166, 25199.244022679348, 25210.873945630337, 25319.62020569693, 25433.618495722578, 25973.610395844076, 3425.4348032574594, 3451.447768357051, 3476.2526056897887, 3488.389531831919, 3570.143165640228, 175283.0, 177698.0, 177748.0, 178851.9999999987, 228070.99999999834, 37710.24579508449, 55697.443025570035, 57445.71277143671, 57510.424895750504, 57521.71239143777, 51698.6735596899, 51829.0, 51965.7401712989, 52296.0, 52450.0, 12428.316442595744, 12546.372681365896, 12557.246565206116, 12590.81113783294, 12604.0, 9250.768730781785, 9294.535273236312, 9353.39202951806, 9369.765755856022, 9436.622535098519, 18480.260789568536, 19071.427857164308, 19144.904275478533, 19237.0, 19274.71087933682, 7578.4316176287, 7846.607669616496, 7859.253370929752, 7878.960605196938, 7935.484193527518, 812.5815205169342, 831.1812864328631, 852.2798235491, 865.8311629232239, 976.9023097690316, 26329.21012369632, 26677.86661066721, 26921.596176057374, 26930.596041059398, 27050.0, 928.4150984879483, 940.9012053734397, 974.2060220919927, 988.9258305627106, 1033.8707661542308, 15184.0, 15346.616334591501, 15407.229638518029, 15471.303791329417, 15599.922000389925, 325261.0, 329968.0, 331318.0, 334137.0, 334693.0, 49467.0, 49968.25047624289, 50180.498195018314, 50260.24609630858, 50398.49601503938, 1131.7114135895295, 1134.03606934107, 1196.1925700152362, 1212.2362911365783, 1230.2987297240486, 28246.71753282441, 28483.0, 29042.854785725936, 29116.7088329114, 29212.26969325784, 42423.787881060394, 43222.567774321855, 43650.0, 43656.126877462906, 43748.78125609351, 194933.0, 197830.0, 198463.0, 198799.0, 199378.0, 39135.6086439132, 39269.21461570695, 39279.41080883846, 39463.408048878715, 40180.79909600433, 37062.0, 38683.41974870323, 39244.0, 39563.80218098891, 39582.208355833296, 33099.338013240085, 33844.83077584596, 34047.14882127967, 34199.487007694406, 34512.0, 33516.329673405904, 33661.83169084139, 33911.15222119368, 33985.490217646264, 34014.48978265378, 33565.16087097842, 33872.49191262182, 34075.65924340725, 34248.65751342455, 34341.141471463416, 29050.0, 31054.844725776227, 31316.53025204578, 31469.74121035133, 31497.21256968594, 23987.0, 24043.278701638978, 24102.758972410753, 24148.275551733477, 24375.390615234763], "unit": "score", "name": "ext.html", "value": 16852.052154766865}, {"lowerIsBetter": false, "replicates": [343.52593421078905, 347.813919553039, 348.3833614502331, 350.21551724137936, 352.2286193236813, 14530.564083077512, 14857.40570377185, 15252.313645885934, 15954.76067858983, 16409.09749963753, 9879.456629885353, 9998.150157236625, 12727.872721272784, 14996.625084372896, 15005.549833505012, 4551.88620284493, 4652.464966528842, 4680.204365257898, 4785.784639691205, 4797.352357431754, 4650.395448591678, 4733.0, 4735.526447355272, 4754.572088512034, 4754.762261886909, 4646.395968524104, 4763.0, 4885.828995985141, 5117.641765076446, 5141.228815677641, 4971.950280497185, 5033.295338652591, 5062.936783275517, 5081.339425874631, 5337.839864804023, 5061.468545802674, 5096.235564665293, 5133.640645154841, 5143.099957507421, 5154.742262886841, 17925.73111403317, 18027.909860450745, 18134.546636334064, 18490.815091849043, 18598.535036624056, 1680.5546530169515, 1686.3001854230479, 1710.1107424139502, 1923.2595450751562, 2009.3770931011434, 8111.918880811176, 8415.495070295801, 8420.621072051772, 8583.871241931376, 8635.913640863573, 1664.176232764777, 1716.356366362614, 1761.674090293287, 1785.9285628574842, 1804.9097545122822, 50436.23473178458, 52942.20586691241, 54140.72929635366, 54842.35472935818, 54999.72500137474, 9627.951860240653, 9755.560999755027, 9801.068898454636, 9842.261830362751, 9884.11043006133, 12287.754244915051, 12365.319907404999, 12430.192037517532, 12445.75108497825, 12476.750464990831, 6443.935560644427, 6490.091387205795, 6587.341265873374, 6798.388145066869, 6822.0, 6324.525660575475, 6346.58747181441, 6359.459445947054, 6368.872622547523, 6378.681065946684, 4159.667226621924, 4180.205760905418, 4207.747535147901, 4230.7884605770205, 4241.448611680524, 1611.717949358881, 1730.2732852202105, 1758.156085079169, 1773.6098058427126, 1804.8556115510728, 385.4680540853604, 392.70939504766267, 427.79038271246867, 436.25836078666396, 796.482286513759, 9057.36598438103, 9319.254459643213, 9327.953360233156, 9560.952195239119, 9694.079062489052, 384.27947598253274, 384.63843986652455, 389.9668528175137, 422.51410877491134, 427.73694178080257, 3956.8219430125714, 5127.564157046618, 5331.253624492574, 5360.597955153379, 5362.115250983622, 466889.0, 470296.0, 504228.0, 509754.0, 521841.0, 64207.0, 68525.0, 68608.3139168612, 69059.65470172618, 70141.29858701449, 443.09166209270865, 445.97770111494947, 447.55915423308664, 450.07734145002615, 450.5584527163464, 9030.864537031819, 9110.90889091127, 9198.632054717737, 9239.907600923905, 9390.920044195005, 27507.449851003268, 28219.0, 28812.855935721025, 29139.562906555995, 29883.0, 45304.0, 46190.53809461863, 46209.53790462052, 46219.76890115528, 46455.76772116118, 6711.697973591297, 6935.237123916466, 6944.131983502062, 7003.4747393944635, 7015.36861682451, 9216.216621586971, 10185.337953033326, 10263.0, 10285.382877027403, 10475.266731329039, 8159.939207902935, 8366.539840308842, 8546.316294696286, 8838.602262898057, 8997.505137217517, 2441.877906104652, 7429.774087275539, 8557.743267701979, 8641.870371944551, 9177.816443671223, 9176.128267814547, 9236.584353704235, 9295.11696388842, 9357.906420935704, 9398.53007349616, 6553.803385898431, 6794.150731158606, 6862.862742745217, 6873.931260687529, 6995.265497122728, 8882.511461869659, 8954.641814327353, 8969.14793094655, 9346.719598412059, 9353.298502612468], "unit": "score", "name": "jquery.html", "value": 6768.522606593365}, {"lowerIsBetter": false, "replicates": [1398.8041674165615, 1417.0930604413177, 1568.5843251538345, 1767.1164417791103, 1767.1605987156095, 6294.905576416358, 6358.237011558608, 7251.709931602736, 7495.287947644979, 7522.511036782612, 6989.860202795941, 7075.858482830353, 7178.2103968563415, 7185.245549217335, 7206.171290301617, 2166.7833216678323, 2189.4526368407896, 2204.9559008819815, 2207.39296693409, 2209.491816882118, 2080.43828166395, 2138.4760733620283, 2155.6119898418356, 2156.212982261471, 2160.114353115223, 2106.1575369852103, 2115.6932244824493, 2118.4809721618226, 2131.8081372676456, 2196.0, 2184.770599087097, 2187.2563328468236, 2188.562287542482, 2198.4503874031493, 2204.371754050096, 2177.5862586108747, 2208.017432242653, 2210.126999835072, 2210.8784016879067, 2212.7344718633867, 7569.7350592729545, 7599.278068583476, 7610.7336243231775, 7613.390928725744, 7621.771346859603, 4312.568743125694, 4374.8906277343, 4441.511433742286, 4450.621697155713, 4459.375687403766, 2823.6752773431112, 2868.3116052147543, 2948.5429758387486, 2953.040261914865, 2967.2730181105767, 858.6050416808275, 864.0927026622085, 883.7967267528504, 888.4536010353651, 928.1043792739971, 10363.896361036444, 10426.79146417075, 10427.582896684124, 10523.78952420955, 10543.0, 4041.1109555897656, 4051.39229115635, 4102.118044620421, 4114.259433302034, 4115.753054816721, 8774.868376974351, 8838.381313308008, 8873.157050080232, 8888.822223555493, 8921.464712117164, 4386.0, 4406.361077643788, 4418.138462999748, 4421.182081314967, 4425.977870110693, 3271.3947919634466, 3349.447341188725, 3906.453096566483, 3970.285348637215, 4021.8391264349684, 3503.474478828196, 3512.631173726773, 3525.153963048901, 3559.555055618048, 3578.4453409721536, 1129.2885482146196, 1133.4276190523897, 1148.5405837664835, 1152.2970987697497, 1157.0, 1206.5053328135423, 1207.4445754952644, 1216.0636310041218, 1230.4831970572382, 1233.0012689721354, 6826.078479405217, 6838.829029274308, 6885.414739747077, 6900.551464154814, 7115.5730656160795, 1047.1308813684623, 1064.499685147979, 1081.259337353915, 1091.143452389886, 1102.9669109926715, 5429.538489228381, 5475.589330800206, 5497.340319161726, 5503.752331145028, 5505.311836020497, 8675.522846243392, 8753.518556479456, 9084.772880677903, 9088.136627020422, 9103.863442048374, 9171.541422928827, 9187.0, 9219.078092190728, 9230.53847307632, 9264.675736349196, 7036.437085033287, 7130.288730704594, 7166.211716711157, 7167.641617919083, 7189.5326803758635, 6839.487038472234, 6861.897071543831, 6873.518853680194, 6878.518503704692, 6903.413209877217, 7939.801504962422, 8321.209485098905, 8384.455010424303, 8391.538465384463, 8400.075991641037, 8325.0, 8456.365772567206, 8467.57662116904, 8479.406441549032, 8485.87271190945, 5575.944240557543, 5771.480566749013, 6285.779997700059, 6490.740370385131, 6509.121268628674, 6898.068760717239, 6935.237123916466, 6966.059581956371, 6989.33601307875, 7018.929810701828, 6452.35476452351, 6519.902201466887, 6548.443382312556, 6629.07192992991, 6759.121314229119, 6442.742290308335, 6469.547131700736, 6502.414782669583, 6517.217933847968, 6519.08732777421, 6520.543561950808, 6522.608643481406, 6552.27924928267, 6563.146790917151, 6572.507061970276, 6006.759729610767, 6123.112148738319, 6161.815145545641, 6170.691465426621, 6203.906941395973, 6212.689365531615, 6220.844478888064, 6259.843503912439, 6262.655553944577, 6269.028300613412], "unit": "score", "name": "mootools.html", "value": 4278.1458410194555}, {"lowerIsBetter": false, "replicates": [298.62969917302553, 302.9136696041628, 310.6412094031393, 313.16697584425435, 317.19590837227634, 5513.50378465938, 5656.745446454909, 5659.547236221103, 5696.259486266779, 5700.572457065727, 5572.0, 5584.4136365681525, 5617.325920889489, 5639.295088113986, 5650.982823091842, 4047.6357127858487, 4133.689973252003, 4292.334688123346, 4331.0, 4333.349997500369, 4122.299209134454, 4177.4778152730905, 4199.916001679964, 4203.0, 4208.747475151486, 4119.8876303398065, 4196.727212731163, 4207.242696314662, 4220.620144187023, 4224.408582798411, 4182.519010313822, 4201.621854033121, 4213.410122582825, 4215.641670458015, 4221.0, 3647.908802279938, 3669.6880765134997, 3674.393725035393, 3678.9080272993388, 3679.889603311905, 5276.261323414725, 5370.570354371641, 5377.059014672417, 5378.946210537883, 5383.542398896098, 4876.487968763265, 4882.072406242803, 4891.1195984722735, 4895.290182923456, 4910.21436570147, 5835.941640583582, 5852.034414321632, 5853.239078919756, 5861.062230043172, 5862.97068514659, 4005.559388467266, 4008.1382502761753, 4011.919761604781, 4015.759054456742, 4026.979865100685, 5900.232969713953, 6109.541784366191, 6208.006718924996, 6210.472109870667, 6214.130021796952, 4171.833126674899, 4202.096549241927, 4205.978970105191, 4213.346931225665, 4225.598568136023, 4283.593058659422, 4287.614114729689, 4290.89272768177, 4295.162443323585, 4337.15425492026, 4961.42943561495, 4962.975185124052, 4971.254311853251, 4972.5276098770555, 4985.252212168204, 5720.856978575569, 5919.704014799243, 5920.763169473259, 5922.170896074553, 5943.435373639497, 1520.376645575331, 1536.4391996921267, 1541.6608346163825, 1541.714782765192, 1543.2283858070964, 1025.3027941000191, 1026.6047571684805, 1038.055369613648, 1042.8279333909973, 1049.8477720730452, 5065.341505604321, 5084.13569693153, 5084.262781896604, 5095.87260318495, 5099.719515426613, 5856.385079566584, 6003.549733769897, 6023.247094113236, 6055.636661800306, 6153.784617538454, 5086.720230387365, 5092.10888094582, 5101.387833460009, 5121.743912804345, 5123.590112790967, 3255.1536600484046, 3285.0309158797736, 3302.702756751904, 3303.2897926945343, 3304.471284594453, 5707.258056452634, 5808.361080281165, 5824.330202026821, 5865.442782935615, 5894.587378883522, 6294.433500984934, 6297.748090076438, 6308.3060863305, 6322.0, 6331.050342448578, 5743.62666426681, 5743.655380677173, 5791.594588378773, 5812.941870581325, 5831.912521312099, 5996.67018313997, 6035.849103772441, 6068.393160683896, 6087.482563982111, 6114.755409783559, 5964.31410387811, 5998.70006499682, 6000.0, 6000.69996500182, 6002.849928751816, 5817.0, 5823.155642431739, 5823.35943046273, 5831.271091113611, 5836.883262334814, 4292.441982542249, 4293.849715259951, 4300.333448315516, 4303.720258183208, 4307.0, 5901.0, 6104.6642434664745, 6111.938880611137, 6121.32665406796, 6131.417515336036, 5898.587098903207, 5900.468957793819, 5903.173555702291, 5916.230889984275, 5952.434518720715, 5849.766009359578, 5867.706614669335, 5891.852703682271, 5892.469677729025, 5903.498202652822, 5547.472990065938, 5660.773569057356, 5684.289463817023, 5720.227769251098, 5733.140028995684, 5877.853053673693, 5908.970455147697, 5914.881702366015, 5923.4076592340425, 5932.851678708067, 5557.083081291542, 5772.855678608068, 5775.451332123442, 5781.277340332458, 5786.739596718242], "unit": "score", "name": "prototype.html", "value": 4398.274889342033}, {"lowerIsBetter": false, "replicates": [676.6244734172534, 751.8722412339433, 768.19339693322, 770.718687678997, 773.9380849532038, 11282.210245282833, 11391.829122563158, 11392.373419461937, 11485.483153258103, 11556.30662160269, 13157.342132893342, 13531.188128712283, 13531.797023044663, 13533.796993045087, 13538.187708737483, 608.1941427608415, 624.4348864277836, 778.1207235823525, 789.5302295134386, 794.2057942057942, 791.1771757372354, 801.1747899663357, 802.7350974178536, 807.3541167066353, 809.1180613131685, 830.3066939105854, 830.7009476588423, 832.7959649885787, 833.4540875726378, 833.9624716887755, 811.8579248631495, 814.2102160903913, 820.9548474833912, 823.1398188892622, 826.2852632472927, 612.1582823617526, 616.9043798211285, 617.8640699046202, 618.3291129124905, 619.6653806944245, 12319.815202771966, 12335.75328493434, 12350.62948111558, 12382.071344649097, 12410.56563020299, 11795.115366347472, 11880.287182769061, 12020.45907934145, 12045.939770301093, 12053.385648891242, 9646.565904534313, 9700.175485083777, 9795.265355098325, 9823.656172033945, 9826.0, 3237.8057316560844, 3249.1877030742316, 3288.8355582220793, 3345.0, 3353.5305057292, 40356.798216009025, 41862.37206441906, 41864.16271674549, 42297.36553951662, 42371.36442953358, 9548.42709437436, 9572.9042709572, 9666.95166524177, 9706.272029597809, 9724.70825875225, 16124.67750645004, 16199.190040497928, 16203.432879849148, 16209.270582823801, 16270.186490675418, 6478.125453063871, 6483.286838447767, 6518.315576864456, 6590.934090659128, 6719.42884854783, 3718.721095917817, 3720.720945929066, 3750.887473375803, 3764.792936388525, 3817.675497582681, 2687.8118531702594, 2717.6331195288776, 2727.277271523048, 2729.126679462553, 2748.1343376836235, 505.98988020240125, 552.0587398485573, 561.6433564686454, 564.25800072904, 571.2145799525653, 486.2050547355029, 568.692905830855, 569.532982953982, 619.3001907844107, 632.3929028132952, 7995.0, 8075.798105047304, 8106.878396824052, 8110.188981101961, 8239.0, 484.6583158872986, 512.7743792731186, 566.7109774015199, 651.46905272203, 656.7963931181349, 3811.9809400953372, 3827.961720382816, 3848.365019771706, 3886.4753258310334, 3935.7244992850797, 45614.31578526325, 46078.769606151756, 46753.53246467492, 46790.0, 46864.0, 41132.38301425481, 41288.38067428991, 41334.58665413367, 41338.1732365351, 47064.7646761764, 39813.80093099574, 39948.20103597912, 40055.0, 40088.799556002035, 40146.79926600348, 8202.0, 8271.751847444586, 8445.282151017233, 8445.619947102272, 8572.614232359683, 27525.72474275312, 27739.44521109607, 27741.167764967082, 28849.134525964255, 29127.417451651272, 31693.683063169072, 35580.0, 37464.438033430066, 37675.43486847754, 37854.053648659006, 9738.707838764849, 10108.89891101109, 10246.282760206714, 10273.332233404804, 10524.0, 11292.153088518558, 11482.94258528702, 11487.942560287145, 11587.826182607436, 11801.468933898166, 10851.0, 11030.06244469197, 11081.445927703744, 11185.496652650487, 11205.103591712807, 10747.516361763895, 10750.301230420311, 10780.622678206226, 10922.453877306261, 11369.0, 10027.849582256125, 10227.28409011362, 10838.620648277272, 10932.125429965425, 11275.548978041115, 8191.631376587949, 8336.291415229773, 8354.289885359813, 8546.572671366283, 8695.087015863497, 8141.79645508867, 8798.164174403422, 8877.866831997655, 8881.644734210558, 8940.329475289509], "unit": "score", "name": "yui.html", "value": 5767.992571703337}], "name": "dromaeo_css", "value": 6203.335165345891}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 114.0, 115.0, 113.0, 126.0, 113.0, 114.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 114.5}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 160.0, 172.0, 135.0, 161.0, 167.0, 135.0, 171.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 152.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 162.0, 165.0, 166.0, 166.0, 164.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 75.0, 73.0, 139.0, 77.0, 74.0, 74.0, 77.0, 96.0], "unit": "score", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [99.0, 99.0, 146.0, 99.0, 99.0, 98.0, 134.0, 97.0, 100.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 115.0, 116.0, 115.0, 116.0, 115.0, 116.0, 115.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.1}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 150.0, 148.0, 148.0, 148.0, 148.0, 148.0, 152.0], "unit": "score", "name": "imaging-darkroom", "value": 148.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 101.0, 98.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 67.0, 70.0, 68.0, 70.0, 68.0, 70.0, 69.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 69.0, 70.0, 70.0, 71.0, 70.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 88.0, 86.0, 87.0, 94.0, 87.0, 88.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [126.0, 129.0, 123.0, 131.0, 126.0, 132.0, 124.0, 123.0, 125.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [147.0, 158.0, 157.0, 152.0, 155.0, 147.0, 154.0, 152.0, 150.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.9}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 73.0, 72.0, 71.0, 73.0, 72.0, 72.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.5}], "name": "kraken", "value": 1563.8000000000002}]} 05:36:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1563.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6203.33"}}} 05:36:12 INFO - Return code: 0 05:36:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:36:12 ERROR - # TBPL SUCCESS # 05:36:12 INFO - Running post-action listener: _resource_record_post_action 05:36:12 INFO - Running post-run listener: _resource_record_post_run 05:36:13 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 172032; Write bytes: 301723648; Read time: 852; Write time: 340804 05:36:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14053376; Read time: 0; Write time: 2716 05:36:13 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 172032; Write bytes: 287670272; Read time: 852; Write time: 338088 05:36:13 INFO - Running post-run listener: _upload_blobber_files 05:36:13 INFO - Blob upload gear active. 05:36:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:36:13 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:14 INFO - (blobuploader) - INFO - Done attempting. 05:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:15 INFO - (blobuploader) - INFO - Done attempting. 05:36:15 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:15 INFO - Return code: 0 05:36:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a33b938fb61796a642177d6eaf98b001ddfe1d53d8a4ddf2a12f7616daedf0e236ed12e004a15043ea6ddee0fbad8bbdb2780e592e7c3522a7d8cda57a3e5922", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a1b57f918dc891baa669858c311b3937a318fbb851960a86d402ad5493ef0460d94cfbc09c090ab5aab421187462b0405bdc2d8194a56a278aeca86520769b9"} 05:36:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:15 INFO - Contents: 05:36:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a33b938fb61796a642177d6eaf98b001ddfe1d53d8a4ddf2a12f7616daedf0e236ed12e004a15043ea6ddee0fbad8bbdb2780e592e7c3522a7d8cda57a3e5922", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a1b57f918dc891baa669858c311b3937a318fbb851960a86d402ad5493ef0460d94cfbc09c090ab5aab421187462b0405bdc2d8194a56a278aeca86520769b9"} 05:36:15 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:15 INFO - Copying logs to upload dir... 05:36:15 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.700811 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-06 05:36:15.458344) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 05:36:15.462139) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a33b938fb61796a642177d6eaf98b001ddfe1d53d8a4ddf2a12f7616daedf0e236ed12e004a15043ea6ddee0fbad8bbdb2780e592e7c3522a7d8cda57a3e5922", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a1b57f918dc891baa669858c311b3937a318fbb851960a86d402ad5493ef0460d94cfbc09c090ab5aab421187462b0405bdc2d8194a56a278aeca86520769b9"} build_url:https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a33b938fb61796a642177d6eaf98b001ddfe1d53d8a4ddf2a12f7616daedf0e236ed12e004a15043ea6ddee0fbad8bbdb2780e592e7c3522a7d8cda57a3e5922", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a1b57f918dc891baa669858c311b3937a318fbb851960a86d402ad5493ef0460d94cfbc09c090ab5aab421187462b0405bdc2d8194a56a278aeca86520769b9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 05:36:15.486131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:36:15.486449) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1454764535.255398-1784565135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:36:15.570686) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 05:36:15.571003) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 05:36:15.571302) ========= ========= Total master_lag: 0.38 =========