builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1454764592.96 results: success (0) buildid: 20160203070736 builduid: 019b7fca185e4b33adf5c590d5ec532e revision: 97c27a348f0963da5bce6b667612e7ba2d209078 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:32.960332) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:32.960806) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:32.961097) ========= 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=14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006213 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:32.984724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:32.985224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:32.998720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:32.999468) ========= 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=14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:33.050239) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:33.050897) ========= 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:16:33.051303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:33.051728) ========= 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=14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-06 05:16:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.2M=0s 2016-02-06 05:16:33 (30.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:33.162847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:33.163353) ========= 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=14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022358 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:33.213712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 05:16:33.214064) ========= 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=14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-06 05:16:33,554 truncating revision to first 12 chars 2016-02-06 05:16:33,555 Setting DEBUG logging. 2016-02-06 05:16:33,555 attempt 1/10 2016-02-06 05:16:33,555 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:16:34,621 unpacking tar archive at: fx-team-97c27a348f09/testing/mozharness/ program finished with exit code 0 elapsedTime=1.393250 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 05:16:34.618584) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:34.618984) ========= 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=14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 97c27a348f0963da5bce6b667612e7ba2d209078 program finished with exit code 0 elapsedTime=0.004754 script_repo_revision: '97c27a348f0963da5bce6b667612e7ba2d209078' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:34.668644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:34.668973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 05:16:34.678638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-02-06 05:16:34.678994) ========= /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=14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:16:35 INFO - MultiFileLogger online at 20160206 05:16:35 in /builds/slave/test 05:16:35 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:16:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:35 INFO - {'append_to_log': False, 05:16:35 INFO - 'base_work_dir': '/builds/slave/test', 05:16:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:16:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:35 INFO - 'branch': 'Fx-Team-Non-PGO', 05:16:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:35 INFO - 'config_files': ('talos/linux_config.py',), 05:16:35 INFO - 'default_actions': ('clobber', 05:16:35 INFO - 'read-buildbot-config', 05:16:35 INFO - 'download-and-extract', 05:16:35 INFO - 'populate-webroot', 05:16:35 INFO - 'create-virtualenv', 05:16:35 INFO - 'install', 05:16:35 INFO - 'run-tests'), 05:16:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:35 INFO - 'download_minidump_stackwalk': True, 05:16:35 INFO - 'download_symbols': 'ondemand', 05:16:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:35 INFO - 'installer_path': 'installer.exe', 05:16:35 INFO - 'log_level': 'info', 05:16:35 INFO - 'log_name': 'talos', 05:16:35 INFO - 'log_to_console': True, 05:16:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:16:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:16:35 INFO - 'opt_config_files': (), 05:16:35 INFO - 'pip_index': False, 05:16:35 INFO - 'sps_profile': False, 05:16:35 INFO - 'sps_profile_interval': 0, 05:16:35 INFO - 'suite': 'dromaeojs-e10s', 05:16:35 INFO - 'system_bits': '32', 05:16:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:35 INFO - 'title': 'talos-linux64-ix-036', 05:16:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:35 INFO - 'use_talos_json': True, 05:16:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:35 INFO - 'work_dir': 'build'} 05:16:35 INFO - ##### 05:16:35 INFO - ##### Running clobber step. 05:16:35 INFO - ##### 05:16:35 INFO - Running pre-action listener: _resource_record_pre_action 05:16:35 INFO - Running main action method: clobber 05:16:35 INFO - rmtree: /builds/slave/test/build 05:16:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:35 INFO - Running post-action listener: _resource_record_post_action 05:16:35 INFO - ##### 05:16:35 INFO - ##### Running read-buildbot-config step. 05:16:35 INFO - ##### 05:16:35 INFO - Running pre-action listener: _resource_record_pre_action 05:16:35 INFO - Running main action method: read_buildbot_config 05:16:35 INFO - Using buildbot properties: 05:16:35 INFO - { 05:16:35 INFO - "project": "", 05:16:35 INFO - "product": "firefox", 05:16:35 INFO - "script_repo_revision": "production", 05:16:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:16:35 INFO - "repository": "", 05:16:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:16:35 INFO - "buildid": "20160203070736", 05:16:35 INFO - "pgo_build": "False", 05:16:35 INFO - "basedir": "/builds/slave/test", 05:16:35 INFO - "buildnumber": 859, 05:16:35 INFO - "slavename": "talos-linux64-ix-036", 05:16:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:16:35 INFO - "platform": "ubuntu64_hw", 05:16:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:16:35 INFO - "branch": "fx-team", 05:16:35 INFO - "repo_path": "integration/fx-team", 05:16:35 INFO - "revision": "97c27a348f0963da5bce6b667612e7ba2d209078", 05:16:35 INFO - "stage_platform": "linux64", 05:16:35 INFO - "builduid": "019b7fca185e4b33adf5c590d5ec532e", 05:16:35 INFO - "slavebuilddir": "test" 05:16:35 INFO - } 05:16:35 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:16:35 INFO - Running post-action listener: _resource_record_post_action 05:16:35 INFO - ##### 05:16:35 INFO - ##### Running download-and-extract step. 05:16:35 INFO - ##### 05:16:35 INFO - Running pre-action listener: _resource_record_pre_action 05:16:35 INFO - Running main action method: download_and_extract 05:16:35 INFO - mkdir: /builds/slave/test/build/tests 05:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:35 INFO - https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/test_packages.json 05:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/test_packages.json 05:16:35 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:16:35 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:16:36 INFO - Downloaded 1448 bytes. 05:16:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:16:36 INFO - Using the following test package requirements: 05:16:36 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:36 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:16:36 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:16:36 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:36 INFO - u'jsshell-linux-x86_64.zip'], 05:16:36 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:16:36 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:36 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:16:36 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:16:36 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:16:36 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:36 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:16:36 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:36 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:16:36 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:16:36 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:16:36 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:16:36 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:16:37 INFO - Downloaded 21672518 bytes. 05:16:37 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:16:37 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:16:38 INFO - Return code: 0 05:16:38 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:16:38 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:38 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:16:38 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:16:38 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:16:38 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:16:38 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:16:39 INFO - Downloaded 21672518 bytes. 05:16:39 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:16:39 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:16:40 INFO - Return code: 0 05:16:40 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:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:41 INFO - Downloaded 10706582 bytes. 05:16:41 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:16:41 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:16:42 INFO - Return code: 0 05:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:42 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:16:42 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:16:42 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:16:42 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:16:42 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:16:43 INFO - Downloaded 54228511 bytes. 05:16:43 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:16:43 INFO - mkdir: /builds/slave/test/properties 05:16:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:43 INFO - Contents: 05:16:43 INFO - build_url:https://queue.taskcluster.net/v1/task/O9ExpaI2RqmQpcUtU17Gow/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:16:44 INFO - Running post-action listener: _resource_record_post_action 05:16:44 INFO - Running post-action listener: set_extra_try_arguments 05:16:44 INFO - ##### 05:16:44 INFO - ##### Running populate-webroot step. 05:16:44 INFO - ##### 05:16:44 INFO - Running pre-action listener: _resource_record_pre_action 05:16:44 INFO - Running main action method: populate_webroot 05:16:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:44 INFO - '--tppagecycles', 05:16:44 INFO - '7'], 05:16:44 INFO - 'tests': ['tsvgm']}}, 05:16:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:16:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:16:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:16:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:16:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--e10s'], 05:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'tests': ['damp', 'tps']}, 05:16:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--e10s'], 05:16:44 INFO - 'tests': ['damp', 'tps']}, 05:16:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:16:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:44 INFO - 'other': {'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore']}, 05:16:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:16:44 INFO - 'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore']}, 05:16:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:16:44 INFO - 'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore']}, 05:16:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:16:44 INFO - 'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore']}, 05:16:44 INFO - 'other_l64': {'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore']}, 05:16:44 INFO - 'other_nol64': {'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore']}, 05:16:44 INFO - 'svgr': {'tests': ['tsvgx', 05:16:44 INFO - 'tsvgr_opacity', 05:16:44 INFO - 'tart', 05:16:44 INFO - 'tscrollx', 05:16:44 INFO - 'cart']}, 05:16:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:16:44 INFO - 'tests': ['tsvgx', 05:16:44 INFO - 'tsvgr_opacity', 05:16:44 INFO - 'tart', 05:16:44 INFO - 'tscrollx', 05:16:44 INFO - 'cart']}, 05:16:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'tests': ['tp5o']}, 05:16:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--e10s'], 05:16:44 INFO - 'tests': ['tp5o']}, 05:16:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--xperf_path', 05:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:44 INFO - 'tests': ['tp5n']}, 05:16:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--e10s', 05:16:44 INFO - '--xperf_path', 05:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:44 INFO - 'tests': ['tp5n']}}, 05:16:44 INFO - 'talos.zip': {'path': '', 05:16:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:44 INFO - Running post-action listener: _resource_record_post_action 05:16:44 INFO - ##### 05:16:44 INFO - ##### Running create-virtualenv step. 05:16:44 INFO - ##### 05:16:44 INFO - Running pre-action listener: _resource_record_pre_action 05:16:44 INFO - Running main action method: create_virtualenv 05:16:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:44 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:16:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:44 INFO - Using real prefix '/usr' 05:16:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:46 INFO - Installing pip.................done. 05:16:46 INFO - Return code: 0 05:16:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16: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:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:46 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 0x7fdf74974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18783d0>, '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 0x17e3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', '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:46 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:16:46 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:16:46 INFO - Using env: {'DISPLAY': ':0', 05:16:46 INFO - 'HOME': '/home/cltbld', 05:16:46 INFO - 'LANG': 'en_US.UTF-8', 05:16:46 INFO - 'LANGUAGE': 'en_US:en', 05:16:46 INFO - 'LOGNAME': 'cltbld', 05:16:46 INFO - 'MAIL': '/var/mail/cltbld', 05:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:46 INFO - 'MOZ_NO_REMOTE': '1', 05:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:46 INFO - 'NO_EM_RESTART': '1', 05:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:46 INFO - 'PWD': '/builds/slave/test', 05:16:46 INFO - 'SHELL': '/bin/bash', 05:16:46 INFO - 'SHLVL': '1', 05:16:46 INFO - 'TERM': 'linux', 05:16:46 INFO - 'TMOUT': '86400', 05:16:46 INFO - 'USER': 'cltbld', 05:16:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', 05:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:46 INFO - '_': '/tools/buildbot/bin/python'} 05:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:47 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:16:47 INFO - Cleaning up... 05:16:47 INFO - Return code: 0 05:16:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:47 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 0x7fdf74974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18783d0>, '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 0x17e3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', '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:47 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:16:47 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:16:47 INFO - Using env: {'DISPLAY': ':0', 05:16:47 INFO - 'HOME': '/home/cltbld', 05:16:47 INFO - 'LANG': 'en_US.UTF-8', 05:16:47 INFO - 'LANGUAGE': 'en_US:en', 05:16:47 INFO - 'LOGNAME': 'cltbld', 05:16:47 INFO - 'MAIL': '/var/mail/cltbld', 05:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:47 INFO - 'MOZ_NO_REMOTE': '1', 05:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:47 INFO - 'NO_EM_RESTART': '1', 05:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:47 INFO - 'PWD': '/builds/slave/test', 05:16:47 INFO - 'SHELL': '/bin/bash', 05:16:47 INFO - 'SHLVL': '1', 05:16:47 INFO - 'TERM': 'linux', 05:16:47 INFO - 'TMOUT': '86400', 05:16:47 INFO - 'USER': 'cltbld', 05:16:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', 05:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:47 INFO - '_': '/tools/buildbot/bin/python'} 05:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:47 INFO - Downloading/unpacking psutil>=0.7.1 05:16:47 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:47 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:47 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:47 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:47 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:47 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:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:49 INFO - Installing collected packages: psutil 05:16:49 INFO - Running setup.py install for psutil 05:16:49 INFO - building 'psutil._psutil_linux' extension 05:16:49 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:16:49 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:16:49 INFO - building 'psutil._psutil_posix' extension 05:16:49 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:16:49 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:16:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:49 INFO - Successfully installed psutil 05:16:49 INFO - Cleaning up... 05:16:49 INFO - Return code: 0 05:16:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:49 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 0x7fdf74974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18783d0>, '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 0x17e3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', '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:49 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:16:49 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:16:49 INFO - Using env: {'DISPLAY': ':0', 05:16:49 INFO - 'HOME': '/home/cltbld', 05:16:49 INFO - 'LANG': 'en_US.UTF-8', 05:16:49 INFO - 'LANGUAGE': 'en_US:en', 05:16:49 INFO - 'LOGNAME': 'cltbld', 05:16:49 INFO - 'MAIL': '/var/mail/cltbld', 05:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:49 INFO - 'MOZ_NO_REMOTE': '1', 05:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:49 INFO - 'NO_EM_RESTART': '1', 05:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:49 INFO - 'PWD': '/builds/slave/test', 05:16:49 INFO - 'SHELL': '/bin/bash', 05:16:49 INFO - 'SHLVL': '1', 05:16:49 INFO - 'TERM': 'linux', 05:16:49 INFO - 'TMOUT': '86400', 05:16:49 INFO - 'USER': 'cltbld', 05:16:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', 05:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:49 INFO - '_': '/tools/buildbot/bin/python'} 05:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:51 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:16:51 INFO - Installing collected packages: mozsystemmonitor 05:16:51 INFO - Running setup.py install for mozsystemmonitor 05:16:51 INFO - Successfully installed mozsystemmonitor 05:16:51 INFO - Cleaning up... 05:16:51 INFO - Return code: 0 05:16:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:51 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 0x7fdf74974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18783d0>, '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 0x17e3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', '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:51 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:51 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:51 INFO - Using env: {'DISPLAY': ':0', 05:16:51 INFO - 'HOME': '/home/cltbld', 05:16:51 INFO - 'LANG': 'en_US.UTF-8', 05:16:51 INFO - 'LANGUAGE': 'en_US:en', 05:16:51 INFO - 'LOGNAME': 'cltbld', 05:16:51 INFO - 'MAIL': '/var/mail/cltbld', 05:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:51 INFO - 'MOZ_NO_REMOTE': '1', 05:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:51 INFO - 'NO_EM_RESTART': '1', 05:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:51 INFO - 'PWD': '/builds/slave/test', 05:16:51 INFO - 'SHELL': '/bin/bash', 05:16:51 INFO - 'SHLVL': '1', 05:16:51 INFO - 'TERM': 'linux', 05:16:51 INFO - 'TMOUT': '86400', 05:16:51 INFO - 'USER': 'cltbld', 05:16:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', 05:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:51 INFO - '_': '/tools/buildbot/bin/python'} 05:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:54 INFO - Downloading docopt-0.6.1.tar.gz 05:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:54 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:54 INFO - Running setup.py install for blobuploader 05:16:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:54 INFO - Running setup.py install for requests 05:16:55 INFO - Running setup.py install for docopt 05:16:55 INFO - Successfully installed blobuploader requests docopt 05:16:55 INFO - Cleaning up... 05:16:55 INFO - Return code: 0 05:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:55 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 0x7fdf74974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18783d0>, '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 0x17e3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 05:16:55 INFO - 'HOME': '/home/cltbld', 05:16:55 INFO - 'LANG': 'en_US.UTF-8', 05:16:55 INFO - 'LANGUAGE': 'en_US:en', 05:16:55 INFO - 'LOGNAME': 'cltbld', 05:16:55 INFO - 'MAIL': '/var/mail/cltbld', 05:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:55 INFO - 'MOZ_NO_REMOTE': '1', 05:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:55 INFO - 'NO_EM_RESTART': '1', 05:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:55 INFO - 'PWD': '/builds/slave/test', 05:16:55 INFO - 'SHELL': '/bin/bash', 05:16:55 INFO - 'SHLVL': '1', 05:16:55 INFO - 'TERM': 'linux', 05:16:55 INFO - 'TMOUT': '86400', 05:16:55 INFO - 'USER': 'cltbld', 05:16:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', 05:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:55 INFO - '_': '/tools/buildbot/bin/python'} 05:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:55 INFO - Running setup.py (path:/tmp/pip-BeZgf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:55 INFO - Running setup.py (path:/tmp/pip-qU962w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:55 INFO - Running setup.py (path:/tmp/pip-x6qoGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:55 INFO - Running setup.py (path:/tmp/pip-xXO4KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:55 INFO - Running setup.py (path:/tmp/pip-ks1Z8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:55 INFO - Running setup.py (path:/tmp/pip-0roCmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:55 INFO - Running setup.py (path:/tmp/pip-RgE1Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:56 INFO - Running setup.py (path:/tmp/pip-k85qY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:56 INFO - Running setup.py (path:/tmp/pip-qGo_eR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:56 INFO - Running setup.py (path:/tmp/pip-e1_NEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:56 INFO - Running setup.py (path:/tmp/pip-ulyoEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:56 INFO - Running setup.py (path:/tmp/pip-XBFV9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:56 INFO - Running setup.py (path:/tmp/pip-tPr9VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:56 INFO - Running setup.py (path:/tmp/pip-CDhDel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:56 INFO - Running setup.py (path:/tmp/pip-13DHTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:56 INFO - Running setup.py (path:/tmp/pip-UgvdxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:56 INFO - Running setup.py (path:/tmp/pip-ZyziPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:56 INFO - Running setup.py install for manifestparser 05:16:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Running setup.py install for mozcrash 05:16:56 INFO - Running setup.py install for mozdebug 05:16:57 INFO - Running setup.py install for mozdevice 05:16:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozfile 05:16:57 INFO - Running setup.py install for mozhttpd 05:16:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozinfo 05:16:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozInstall 05:16:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozleak 05:16:57 INFO - Running setup.py install for mozlog 05:16:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for moznetwork 05:16:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozprocess 05:16:58 INFO - Running setup.py install for mozprofile 05:16:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Running setup.py install for mozrunner 05:16:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Running setup.py install for mozscreenshot 05:16:58 INFO - Running setup.py install for moztest 05:16:58 INFO - Running setup.py install for mozversion 05:16:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:58 INFO - Cleaning up... 05:16:58 INFO - Return code: 0 05:16:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:58 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 0x7fdf74974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18783d0>, '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 0x17e3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', '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:58 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:58 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:58 INFO - Using env: {'DISPLAY': ':0', 05:16:58 INFO - 'HOME': '/home/cltbld', 05:16:58 INFO - 'LANG': 'en_US.UTF-8', 05:16:58 INFO - 'LANGUAGE': 'en_US:en', 05:16:58 INFO - 'LOGNAME': 'cltbld', 05:16:58 INFO - 'MAIL': '/var/mail/cltbld', 05:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:58 INFO - 'MOZ_NO_REMOTE': '1', 05:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:58 INFO - 'NO_EM_RESTART': '1', 05:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:58 INFO - 'PWD': '/builds/slave/test', 05:16:58 INFO - 'SHELL': '/bin/bash', 05:16:58 INFO - 'SHLVL': '1', 05:16:58 INFO - 'TERM': 'linux', 05:16:58 INFO - 'TMOUT': '86400', 05:16:58 INFO - 'USER': 'cltbld', 05:16:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', 05:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:58 INFO - '_': '/tools/buildbot/bin/python'} 05:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:58 INFO - Running setup.py (path:/tmp/pip-vX1NwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:58 INFO - Running setup.py (path:/tmp/pip-DHJFnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:58 INFO - Running setup.py (path:/tmp/pip-BDEFUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:59 INFO - Running setup.py (path:/tmp/pip-GehyHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:59 INFO - Running setup.py (path:/tmp/pip-zg5SkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:59 INFO - Running setup.py (path:/tmp/pip-ebbM5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:59 INFO - Running setup.py (path:/tmp/pip-qEPX9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:59 INFO - Running setup.py (path:/tmp/pip-Wkj7Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:59 INFO - Running setup.py (path:/tmp/pip-Hnhvq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:59 INFO - Running setup.py (path:/tmp/pip-oNQjCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:59 INFO - Running setup.py (path:/tmp/pip-ZlPDoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:59 INFO - Running setup.py (path:/tmp/pip-_NqpKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:59 INFO - Running setup.py (path:/tmp/pip-PTaQku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:59 INFO - Running setup.py (path:/tmp/pip-9g6WFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:59 INFO - Running setup.py (path:/tmp/pip-4tNhiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:59 INFO - Running setup.py (path:/tmp/pip-6stpA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:59 INFO - Running setup.py (path:/tmp/pip-6wFLsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:00 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:17:00 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:17:00 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:17:00 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:17:00 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:17:00 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:17:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17: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:17: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:17: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:17: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:17: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:17: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:17:01 INFO - Downloading blessings-1.6.tar.gz 05:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:01 INFO - Installing collected packages: blessings 05:17:01 INFO - Running setup.py install for blessings 05:17:02 INFO - Successfully installed blessings 05:17:02 INFO - Cleaning up... 05:17:02 INFO - Return code: 0 05:17:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:02 INFO - Reading from file tmpfile_stdout 05:17:02 INFO - Current package versions: 05:17:02 INFO - argparse == 1.2.1 05:17:02 INFO - blessings == 1.6 05:17:02 INFO - blobuploader == 1.2.4 05:17:02 INFO - docopt == 0.6.1 05:17:02 INFO - manifestparser == 1.1 05:17:02 INFO - mozInstall == 1.12 05:17:02 INFO - mozcrash == 0.16 05:17:02 INFO - mozdebug == 0.1 05:17:02 INFO - mozdevice == 0.48 05:17:02 INFO - mozfile == 1.2 05:17:02 INFO - mozhttpd == 0.7 05:17:02 INFO - mozinfo == 0.9 05:17:02 INFO - mozleak == 0.1 05:17:02 INFO - mozlog == 3.1 05:17:02 INFO - moznetwork == 0.27 05:17:02 INFO - mozprocess == 0.22 05:17:02 INFO - mozprofile == 0.28 05:17:02 INFO - mozrunner == 6.11 05:17:02 INFO - mozscreenshot == 0.1 05:17:02 INFO - mozsystemmonitor == 0.0 05:17:02 INFO - moztest == 0.7 05:17:02 INFO - mozversion == 1.4 05:17:02 INFO - psutil == 3.1.1 05:17:02 INFO - requests == 1.2.3 05:17:02 INFO - wsgiref == 0.1.2 05:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:02 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:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:02 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:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:02 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 0x7fdf74974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18783d0>, '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 0x17e3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', '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:17:02 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:17:02 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:17:02 INFO - Using env: {'DISPLAY': ':0', 05:17:02 INFO - 'HOME': '/home/cltbld', 05:17:02 INFO - 'LANG': 'en_US.UTF-8', 05:17:02 INFO - 'LANGUAGE': 'en_US:en', 05:17:02 INFO - 'LOGNAME': 'cltbld', 05:17:02 INFO - 'MAIL': '/var/mail/cltbld', 05:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:02 INFO - 'MOZ_NO_REMOTE': '1', 05:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:02 INFO - 'NO_EM_RESTART': '1', 05:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:02 INFO - 'PWD': '/builds/slave/test', 05:17:02 INFO - 'SHELL': '/bin/bash', 05:17:02 INFO - 'SHLVL': '1', 05:17:02 INFO - 'TERM': 'linux', 05:17:02 INFO - 'TMOUT': '86400', 05:17:02 INFO - 'USER': 'cltbld', 05:17:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', 05:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:02 INFO - '_': '/tools/buildbot/bin/python'} 05:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:02 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:17:02 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:17:02 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:17:02 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:17:02 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:17:02 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:17:02 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:17:02 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:17:02 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:17:02 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:17:02 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:17:02 INFO - Cleaning up... 05:17:02 INFO - Return code: 0 05:17:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:02 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:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:02 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:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:02 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 0x7fdf74974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18783d0>, '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 0x17e3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', '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:17:02 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:17:02 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:17:02 INFO - Using env: {'DISPLAY': ':0', 05:17:02 INFO - 'HOME': '/home/cltbld', 05:17:02 INFO - 'LANG': 'en_US.UTF-8', 05:17:02 INFO - 'LANGUAGE': 'en_US:en', 05:17:02 INFO - 'LOGNAME': 'cltbld', 05:17:02 INFO - 'MAIL': '/var/mail/cltbld', 05:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:02 INFO - 'MOZ_NO_REMOTE': '1', 05:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:02 INFO - 'NO_EM_RESTART': '1', 05:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:02 INFO - 'PWD': '/builds/slave/test', 05:17:02 INFO - 'SHELL': '/bin/bash', 05:17:02 INFO - 'SHLVL': '1', 05:17:02 INFO - 'TERM': 'linux', 05:17:02 INFO - 'TMOUT': '86400', 05:17:02 INFO - 'USER': 'cltbld', 05:17:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', 05:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:02 INFO - '_': '/tools/buildbot/bin/python'} 05:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:02 INFO - Downloading/unpacking jsonschema 05:17: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:17: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:17: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:17: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:17: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:17: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:17:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:04 INFO - Downloading/unpacking functools32 (from jsonschema) 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:04 INFO - warning: no files found matching '*.txt' 05:17:04 INFO - no previously-included directories found matching 'build' 05:17:04 INFO - no previously-included directories found matching 'dist' 05:17:04 INFO - no previously-included directories found matching '.git*' 05:17:04 INFO - Installing collected packages: jsonschema, functools32 05:17:04 INFO - Running setup.py install for functools32 05:17:04 INFO - warning: no files found matching '*.txt' 05:17:04 INFO - no previously-included directories found matching 'build' 05:17:04 INFO - no previously-included directories found matching 'dist' 05:17:04 INFO - no previously-included directories found matching '.git*' 05:17:04 INFO - Successfully installed jsonschema functools32 05:17:04 INFO - Cleaning up... 05:17:04 INFO - Return code: 0 05:17:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 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 0x7fdf74974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18783d0>, '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 0x17e3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', '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:17:04 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:17:04 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:17:04 INFO - Using env: {'DISPLAY': ':0', 05:17:04 INFO - 'HOME': '/home/cltbld', 05:17:04 INFO - 'LANG': 'en_US.UTF-8', 05:17:04 INFO - 'LANGUAGE': 'en_US:en', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MAIL': '/var/mail/cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SHLVL': '1', 05:17:04 INFO - 'TERM': 'linux', 05:17:04 INFO - 'TMOUT': '86400', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - '_': '/tools/buildbot/bin/python'} 05:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:05 INFO - Downloading/unpacking flake8 05:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:17:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:17:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:07 INFO - no previously-included directories found matching 'docs/_build' 05:17:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:17:07 INFO - Running setup.py install for pep8 05:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:07 INFO - no previously-included directories found matching 'docs/_build' 05:17:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:17:07 INFO - Cleaning up... 05:17:07 INFO - Return code: 0 05:17:07 INFO - Running post-action listener: _resource_record_post_action 05:17:07 INFO - Running post-action listener: _start_resource_monitoring 05:17:07 INFO - Starting resource monitoring. 05:17:07 INFO - ##### 05:17:07 INFO - ##### Running install step. 05:17:07 INFO - ##### 05:17:07 INFO - Running pre-action listener: _resource_record_pre_action 05:17:07 INFO - Running main action method: install 05:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:08 INFO - Reading from file tmpfile_stdout 05:17:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:08 INFO - Reading from file tmpfile_stdout 05:17:08 INFO - Output received: 05:17:08 INFO - Usage: mozinstall [options] installer 05:17:08 INFO - Options: 05:17:08 INFO - -h, --help show this help message and exit 05:17:08 INFO - -d DEST, --destination=DEST 05:17:08 INFO - Directory to install application into. [default: 05:17:08 INFO - "/builds/slave/test"] 05:17:08 INFO - --app=APP Application being installed. [default: firefox] 05:17:08 INFO - mkdir: /builds/slave/test/build/application 05:17:08 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:17:08 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:17:23 INFO - Reading from file tmpfile_stdout 05:17:23 INFO - Output received: 05:17:23 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:23 INFO - Running post-action listener: _resource_record_post_action 05:17:23 INFO - ##### 05:17:23 INFO - ##### Running run-tests step. 05:17:23 INFO - ##### 05:17:23 INFO - Running pre-action listener: _resource_record_pre_action 05:17:23 INFO - Running main action method: run_tests 05:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:23 INFO - Python 2.7.3 05:17:23 INFO - Return code: 0 05:17:23 INFO - grabbing minidump binary from tooltool 05:17:23 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:17:23 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 0x18783d0>, '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 0x17e3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:23 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:17:23 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:17:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:24 INFO - Return code: 0 05:17:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:17:25 INFO - Return code: 0 05:17:25 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-036', '--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:17:25 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-036 --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:17:25 INFO - Using env: {'DISPLAY': ':0', 05:17:25 INFO - 'HOME': '/home/cltbld', 05:17:25 INFO - 'LANG': 'en_US.UTF-8', 05:17:25 INFO - 'LANGUAGE': 'en_US:en', 05:17:25 INFO - 'LOGNAME': 'cltbld', 05:17:25 INFO - 'MAIL': '/var/mail/cltbld', 05:17:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:25 INFO - 'MOZ_NO_REMOTE': '1', 05:17:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:25 INFO - 'NO_EM_RESTART': '1', 05:17:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:25 INFO - 'PWD': '/builds/slave/test', 05:17:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:25 INFO - 'SHELL': '/bin/bash', 05:17:25 INFO - 'SHLVL': '1', 05:17:25 INFO - 'TERM': 'linux', 05:17:25 INFO - 'TMOUT': '86400', 05:17:25 INFO - 'USER': 'cltbld', 05:17:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333', 05:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:25 INFO - '_': '/tools/buildbot/bin/python'} 05:17:25 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-036', '--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:17:25 INFO - mozversion application_buildid: 20160203070736 05:17:25 INFO - mozversion application_changeset: 97c27a348f0963da5bce6b667612e7ba2d209078 05:17:25 INFO - mozversion application_display_name: Nightly 05:17:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:25 INFO - mozversion application_name: Firefox 05:17:25 INFO - mozversion application_remotingname: firefox 05:17:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:17:25 INFO - mozversion application_vendor: Mozilla 05:17:25 INFO - mozversion application_version: 47.0a1 05:17:25 INFO - mozversion platform_buildid: 20160203070736 05:17:25 INFO - mozversion platform_changeset: 97c27a348f0963da5bce6b667612e7ba2d209078 05:17:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:17:25 INFO - mozversion platform_version: 47.0a1 05:17:25 INFO - using testdate: 1454764645 05:17:25 INFO - actual date: 1454764645 05:17:25 INFO - starting webserver on 'localhost:36944' 05:17:25 INFO - SUITE-START | Running 2 tests 05:17:25 INFO - TEST-START | dromaeo_css 05:17:25 INFO - operating with platform_type : linux_ 05:17:25 INFO - Initialising browser for dromaeo_css test... 05:17:25 INFO - TEST-INFO | started process 26778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2WfVe/profile http://localhost:36944/getInfo.html) 05:17:25 INFO - PROCESS | 26778 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 05:17:29 INFO - PROCESS | 26778 | 05:17:29 INFO - PROCESS | 26778 | (process:26858): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:17:30 INFO - PROCESS | 26778 | __metrics Screen width/height:1600/1200 05:17:30 INFO - PROCESS | 26778 | colorDepth:24 05:17:30 INFO - PROCESS | 26778 | Browser inner width/height: 1024/697 05:17:30 INFO - PROCESS | 26778 | __metrics 05:17:30 INFO - PROCESS | 26778 | 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:17:30 ERROR - PROCESS | 26778 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2830: TypeError: this.tabs is undefined 05:17:30 INFO - PROCESS | 26778 | ************************* 05:17:30 INFO - PROCESS | 26778 | A coding exception was thrown in a Promise resolution callback. 05:17:30 INFO - PROCESS | 26778 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 05:17:30 INFO - PROCESS | 26778 | 05:17:30 ERROR - PROCESS | 26778 | Full message: TypeError: this.tabs is undefined 05:17:30 INFO - PROCESS | 26778 | Full stack: .get@chrome://browser/content/tabbrowser.xml:2830:17 05:17:30 INFO - PROCESS | 26778 | ssi_onClose/<@resource:///modules/sessionstore/SessionStore.jsm:1323:9 05:17:30 INFO - PROCESS | 26778 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 05:17:30 INFO - PROCESS | 26778 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 05:17:30 INFO - PROCESS | 26778 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 05:17:30 INFO - PROCESS | 26778 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 05:17:30 INFO - PROCESS | 26778 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 05:17:30 INFO - PROCESS | 26778 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:146:5 05:17:30 INFO - PROCESS | 26778 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:52:5 05:17:30 INFO - PROCESS | 26778 | receiveMessage@resource:///modules/sessionstore/SessionStore.jsm:734:11 05:17:30 INFO - PROCESS | 26778 | 05:17:30 INFO - PROCESS | 26778 | ************************* 05:17:31 INFO - TEST-INFO | 26778: exit 0 05:17:31 INFO - Browser initialized. 05:17:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:31 INFO - TEST-INFO | started process 26907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2WfVe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:32 INFO - PROCESS | 26907 | 05:17:32 INFO - PROCESS | 26907 | (process:26965): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:17:43 INFO - PROCESS | 26907 | RSS: Main: 152666112 05:17:43 INFO - PROCESS | 26907 | 05:18:32 INFO - PROCESS | 26907 | 1454764712988 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:20:43 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36944/tests/dromaeo/cssquery-ext.html) 05:20:44 INFO - PROCESS | 26907 | RSS: Main: 157827072 05:20:44 INFO - PROCESS | 26907 | 05:23:46 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-ext.html (next: http://localhost:36944/tests/dromaeo/cssquery-jquery.html) 05:23:47 INFO - PROCESS | 26907 | RSS: Main: 156188672 05:23:47 INFO - PROCESS | 26907 | 05:26:49 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36944/tests/dromaeo/cssquery-mootools.html) 05:26:49 INFO - PROCESS | 26907 | RSS: Main: 157073408 05:26:49 INFO - PROCESS | 26907 | 05:29:51 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36944/tests/dromaeo/cssquery-prototype.html) 05:29:52 INFO - PROCESS | 26907 | RSS: Main: 154357760 05:29:52 INFO - PROCESS | 26907 | 05:32:54 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36944/tests/dromaeo/cssquery-yui.html) 05:32:55 INFO - PROCESS | 26907 | RSS: Main: 154939392 05:32:55 INFO - PROCESS | 26907 | 05:35:57 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:36944/tests/dromaeo/cssquery-yui.html (next: http://localhost:36944/tests/dromaeo/cssquery-dojo.html) 05:35:58 INFO - PROCESS | 26907 | RSS: Main: 158625792 05:35:58 INFO - PROCESS | 26907 | 05:35:58 INFO - PROCESS | 26907 | __start_tp_report 05:35:58 INFO - PROCESS | 26907 | _x_x_mozilla_page_load 05:35:58 INFO - PROCESS | 26907 | _x_x_mozilla_page_load_details 05:35:58 INFO - PROCESS | 26907 | |i|pagename|runs| 05:35:58 INFO - PROCESS | 26907 | |0;dojo.html;2641.3792758701707;2650.7614314711673;2682.624432579439;2696.420269642028;2713.7828973682103;4538.659600529965;4695.812167513295;4727.078219747142;4729.196036673765;4748.881277968053;4576.862694119173;4583.495815460296;4603.861884143473;4605.447346318447;4694.178518759212;4242.469691288589;4301.333293339521;4322.373255877896;4400.471943366801;4416;208.2717885840917;4289.206496798087;4340.500842403117;4381.75900325482;4410.845620403286;4291.1632231714675;4314.072474417983;4320.978395108004;4347.804348804296;4362.323839804835;4310.4611923509565;4316.3309686998255;4364.694471387004;4377.03705184862;4386.934195987063;4132.194222126686;4146.3158578834455;4229.2598795210715;4370.868873933787;4421.447319085114;4548.658850586219;4561.429821272341;4571.794269257858;4597.356370108188;4617.676762626617;4892;4915.48387419323;4931.186354251544;4944.208926571767;5008.874778130539;4857.198562237227;4927.77824997876;4944.085344211297;4987.152184128707;5055.949440505585;4662.650301227422;4662.673612847102;4681.485036645966;4687.9765601171775;4722.6221902247735;5131.307273518102;5141.922871156936;5143.228515722597;5151.5878729701535;5202.4277329493725;4759.976605029866;4844.660873738804;4887.315775791321;4892.877678058077;4956.975215123974;4926.162552366106;4973.403191617029;4973.975130124326;4975.328330675313;4984.953159836403;4822.855314340575;4876.512348765166;4926.950730492721;4944.035912997003;4946.0355230729665;4811.398575178103;4892.094962431962;4909.435414927258;4912.189488734391;4969.975150124298;4092.1611069730634;4101.794910254475;4112;4132.710710250253;4152.294110001307;3543.539339885798;3625.021244264034;3626.601073881871;3640.381135207021;3658.067192865802;4240.978795106004;4288.078063216423;4294.9785251073545;4327.653787696977;4333.891652708708;4964.60283177345;4988.975055124701;4991.975040124777;5005.72468514228;5029.874253143701;4197.055662475979;4288.421063156434;4288.463942007249;4294.26997410441;4312.870613881526;4402.3396490526675;4407.096545208225;4434.201843668171;4441.911161776747;4442.755648439367;4730.881727956828;4734.976325118421;4735.763211839326;4746.667733258708;4777.641676874248;4856.490068542894;4918.385201849769;4930.901381972412;4972.751362431936;4975.577075948585;4732.52674732524;4757.429108507002;4761.523847615211;4766.070616229802;4798;4890.584300334512;4915.21356582945;4921.50784921505;4926.458089610212;4969.82605608802;4802.855914322576;4905.288733133604;4957.132501812241;4999.250112483157;5024.020316038337;4817.084753896888;4835.6131509479865;4844.297576851407;4856.854294371175;4903.239997800347;4833.03339332128;4843.176659967884;4850.029994001144;4852.75736213195;4899.167141585867;4622.976885115553;4691.788869500812;4699.459562150397;4723.4331880174595;4746.359241502353;4869.975650121868;4884.218525035977;4896.951030489649;4897.559219670246;4915.410150781929;4591.517890621437;4770.069836381872;4782.210935195653;4789.712617242976;4833.081714474239 05:35:58 INFO - PROCESS | 26907 | |1;ext.html;492.3550149304411;495.30409774267144;499.1090902738612;519.8726312053548;520.0457161109364;33112.33775324492;33759;33803.830980845065;33818.66181338192;33846.49230261545;37341.626583734156;37588;37863.05342366442;37864.810675946654;37900.24199516015;7649.120351159632;7906.379192265572;7956.04527456706;7965.522068675869;7971.920280797205;7820.804479887991;7861.174576669453;7943.046834379882;8039.155888631697;8097.919020809775;8040.316573091294;8095.6761729530745;8107.189281071905;8161.183881611851;8190.180981901792;8026.558539280308;8026.839463210761;8030.678772849079;8035.5580443075605;8125.959370203141;7780.649870755773;7966.28303452692;7987.960060199662;7994.040715114165;8013.559254241014;38276.42585361222;38333;38622;38657.61342386568;38902.22195556101;2675.8929642814264;3061.4642437573334;3068.7851850370484;3073.523603841408;3096.90709278722;24675.259742207763;24920.37699057538;25214.117505887207;25225.36936576582;25698.357541061436;3256.576645036154;3258.983705081483;3272.5582046423665;3282.4091663500562;3369.157710572357;144737.55262447346;145210;145472.2726386372;145602;145780.27109864383;47012;47429.5257047432;51977.480225197265;54614.45385546173;55561.722191388784;48287;49307.26039109416;49429.50570494321;49483.50516494789;49489.50510494921;13473.528426505025;13685.384157712728;13747.312634368242;13815.930920345334;13835;9168.81662366749;9170.358074934824;9261.907380926104;9321.347505674674;9374.203192728559;18709.345172919155;18977.620447590973;19066.80933190678;19120.426387208405;19127.043647817554;6898.379145876896;7203.243659415791;7292.562446253136;7298.124225092916;7338.266173382619;836.1930736838858;877.6621000914566;930.3115694386106;1018.0277834667875;1034.2243317511866;24007.63988540173;24329.148479803123;24520.264392068268;24823.50352992966;25239.495210095694;909.7179874239007;945.9877930614176;951.1962391778935;1030.0935177044303;1064.973375665599;12432.627021189379;12496.81254781179;12549.372531373394;13085.803712944313;13139.474421023244;268904;271160;272279;272483;273604;45721.77139114283;46550.76724616355;46605.5339446608;46922.29616555754;46969.5303046972;1179.8938095571439;1186.2348785033605;1192.284629222477;1214.5870404062662;1227.0796902323257;23961;24032.39919001969;24105.51788964246;24128.05374898177;24337.51324973526;38426.61573384231;38923.610763892;39015;39126;39202.80398597989;265538;266293;267398;267760;267883;29194;29819.35993520377;29870.551941721325;30264;30320.090397288117;33793.15517112092;33870.78227568377;34105.65894341025;34561.65438345585;34585;31237.68762312348;32616.510752339207;32678.50982235316;33580;33749.493757594144;32389;32489.552716294405;33262.50106248457;33307.666923331424;33491.66508334885;32616.184595385304;32785;32802.50796238106;32891.50662740109;33172.834135829165;28522.714772852007;28737.137885863456;29684.554731679473;29742.553861692526;29938.550921736627;21589.239626762086;23559;23607;23609.881950590137;23751.287461376185 05:35:58 INFO - PROCESS | 26907 | |2;jquery.html;344.7982929985958;345.37487148261647;345.7666075399105;347.61935680429934;349.1062879029684;14697.559073227807;14996.550103496898;15937;16172.191390430491;16173.838261617366;9914.454704991223;10177.84733229002;13474.5283915063;14974.925125374359;15023.474178403758;4386.824527018915;4446.911061778763;4584.19776539106;4593.012502312003;4659.044895796371;4483.327500874879;4567.497575266718;4568.063546972862;4613.331066995283;4625.213713668668;4511.7969691363805;4534.6825722199455;4719.174144524712;4929.088118698034;4941.308216849644;4730.195866702668;4865.367502224706;4873.244647079709;4885.706857588539;5114.795408183668;4914.483979182206;4915.115279249733;4919.360483137205;4937.21004639256;4961.677490963112;17735.46793596194;17802.198901049353;18348;18705.812941870543;18730.250789968384;1685.7050016247108;1690.8393702598235;1727.4126796889118;1769.575301927541;2169.305822136917;8385.790355241106;8424.83150336996;8661.783455413602;8755.474671519729;8842.248408885253;1729.4033558422325;1748.0560497331426;1811.356968276256;1824.875780735534;1886.1983656945881;52360;53909.73045134788;53954;53983.19025214664;54336.184957225676;9367.531623418801;9536.856947145798;9768.316217864824;9825.213982881352;9904.405735655884;12409.62771116868;12448.25310481374;12458.190217635825;12463.439145238486;12472.937635311766;6269.247690277196;6478.125453063871;6486.902696459557;6545.181852268466;6575.769848055295;5987;5992.790252341147;6039.969800150971;6050.6974651267265;6064.3935606439;3882.456456096149;3984.163325701635;4081.816318265626;4121.093359460914;4213.494380674339;1457.8031965684709;1745.2757105801204;1759.24352528414;1771.2383675019864;1785.098525244743;745.228688307599;914.7484441778564;927.7819712367589;938.8362611816615;946.7491114854569;14619.488317908823;14637.92681036588;14739.92630036843;14916.925415372854;15082.396704131712;828.3745771942146;855.0338117926703;857.4255248983196;905.3979103895967;922.9215516681023;8717.956410218036;9028.503432311154;9156.221721153643;9302.767430814283;9569.665061722806;315160;316993;321651;499858;504094;59834.10248846271;61532.69233653803;62950.68524657348;65352.445042171945;69990.65004675045;1003.6336737090909;1036.9585216591402;1043.0612448796144;1044.8902865199198;1049.1187402581716;13080.476780928657;13828.840983819595;14187.574372768833;14204.502842400467;14649;31502.842485787423;31709.20726981844;32075.35849283048;32182.67817321797;32536.67463325431;39564.40653390259;39960.40059399053;40280.59719402769;40308.59691403049;40405.1918961625;6720.798376048726;6813.557118787263;6860.931390686029;6871.3128687132885;6965.164180298194;9438.24494040489;9836.311458197857;9870.753231169278;9951.054649808257;10371.066604005675;6458.903116453163;7702.229777022477;8657.350698697748;8884.600192991202;9023.233025192669;2527.140772137482;3895.844166233319;5669.659820410789;8911.73264802057;8991.820163596822;8342.87485687703;8502.872456913028;9145.085491450802;9537.427754334762;9637.807243855224;6826.488013399115;6874.793756187322;6947.930520694728;7078.858422831411;7094.396976257076;8075.59622018885;9047.864282035905;9147.496887671243;9168.954155229181;9206.447613143233 05:35:58 INFO - PROCESS | 26907 | |3;mootools.html;1405.810215620891;1417.7802440621704;1559.9532014039582;1731.402666080202;1741.7039103352436;6446.161998940143;6506.707198176082;7367.447441441893;7547.396208303343;7574.545527268361;7069.328413800681;7307.853842923151;7375.336219740222;7385.076865391826;7397.223291554376;2124.9787502124937;2155.7305336832897;2156.91372345106;2157.4067131538873;2162.156758864044;2005.4585261979257;2021.2016253579827;2161.470439742265;2187.5406164705432;2193;2132.2217390652454;2139.3047259640603;2141.5395689926663;2148.581026699794;2157.9460513487134;2154.806067453921;2157.773433789453;2158.082814803702;2160.103557023841;2165.66432203008;2133.893305334727;2182.945426364338;2188.4091295350327;2190.9452263693533;2199.483121466454;7451.068616422947;7475.476716629838;7515.699372025112;7520.623968801593;7521.210272921374;4196.559361267084;4305.246581848164;4311.461067366579;4314.870553883388;4339.587739164775;2846.4734024205586;2858.6998365171567;2921.0944607171846;2921.1528656689534;2927.92680182995;931.0875342164717;967.88869280033;985.9211263098935;999.1557134221571;1003.9698809035667;10204.540795664212;10221.029002244775;10260.230482713827;10281.331713438603;10304.175665946781;4011.5988401160234;4059.4519739835337;4117.053077792065;4133.958660413417;4149.502059752849;8804.163604457566;8819.735407937773;8822.911770882338;8829.117088291248;8843.248323892542;4200.957990420056;4205.432266644025;4216.135692183095;4223.282042052859;4225.873223803229;3117.828519431453;3163.430582495127;3741.663250307485;3743.3262012837404;3819.6753275971855;3499.772514786531;3545.804980726085;3558.1282585766653;3565.71474282062;3567.7502574820032;1122.8820973797633;1127.1208457403238;1134.3024040215207;1135.432283858071;1144.3934714601276;1161.7502237019082;1178.1399578307883;1188.441432526711;1192.505110379183;1210.6791700199453;6756.560823546453;6867.141607299088;6872.931270687329;6877.449804015667;7077.787666370017;430.39314566461763;435.8017102218483;436.4675096382408;437.4400767018158;438.75868272450026;5353.464653534693;5397.892042159214;5433.592480563973;5436.184572314105;5451.291332126798;8445.915540844513;8696.521691306913;8826.602802873886;8893.28853691703;9233.630654773868;8668.133186681407;8701.216890479887;8718.389712720049;8743.956280218557;8747.825043499222;6709;6747.662616869137;6796.864062718817;7143.749968751069;7144.499885008104;6966.442684585322;6996.6151861648095;7010.964945175241;7030.9296907030275;7053.3299336565;8027.669968046439;8197.139300373376;8382.37132215074;8384;8423.115572865006;8310.085890552155;8399.202075802788;8530.274926631306;8578.227959483676;8665.480071195749;6667.799966001027;6880;6936.618485983319;7096.574205547684;7199.172095209118;7043.436525077879;7054.435645148478;7105.8578828422105;7108.324709152622;7115.501914865909;6485.124508191522;6618.139641846529;6696.7656132035145;6786.3892249697765;6835.07726456922;6498.317676644074;6600.273969863215;6639.933600663931;6644.90032649501;6707.731690732316;6640.203175618956;6665;6683.164604424447;6813.250542440229;6857.382835544825;6072.939270607238;6081.878362432815;6110.022396416552;6110.450059494667;6120.265568131853;6188.721507532082;6244.250689917239;6246.968765156145;6264.21697287839;6276.215473065867 05:35:58 INFO - PROCESS | 26907 | |4;prototype.html;300.8691219319596;304.5416647944843;311.3011289654724;311.7210096963219;312.8295079181845;5488.1493368527845;5577.274954255941;5610.803621873235;5615.578831587632;5720.141978703196;5522.254495643087;5550.91673624895;5595.49640532352;5599.41206173351;5606.55147588193;4055.858044968427;4153.501579810427;4260.70175087744;4264.445622069142;4270.572942705728;4144.8549300774475;4156.106437116019;4163.375493675942;4170.145120250341;4178.22702799983;4147.730397524167;4151.211269858717;4157.50109986802;4159.667226621863;4159.854405095823;4151.522574903895;4157.584241575818;4160.833566657345;4162.4796900387455;4167.187398457302;3523.1896663767475;3582.6059133495296;3588.22853086585;3589.6589823966683;3594.4967704521387;5232.790688372461;5322.733863306819;5324.227986941911;5330.573554115662;5331.520163185293;4777.976110119462;4794.760261986921;4841.636877234187;4851.490593487668;4865.19724245499;5812.680302583356;5858.8242352729485;5865.472107510302;5866;5869.618474799125;3853.2852880468204;3863.2080423513394;3940.9014774630864;3947.8026098695236;3948.921021579581;6051.4553690168095;6138.0792881067755;6141.170941922828;6156.199694039746;6157.014877619604;3969.980150099231;3981.9845939285874;3983.6215559521797;3983.64147226751;3994.0613955720382;4020.5175378954714;4038.7778672173313;4041.7372870763306;4046.979765101156;4051.1492586556565;4599.494055653875;4735.029318989667;4738.028704115648;4748.6913350632785;4755.714657120584;5628.155776633538;5757.395473475309;5827.679477628772;5844.8538786529825;5850.0932355484965;1416.1149281698938;1432.749268877942;1435.0313538361563;1438.4749566408395;1438.9856101439061;956.5456408206186;966.9081437263449;967.4437198610827;984.8227319082633;986.4426598971559;4991.9500804991485;5025.648204625714;5066.493350664978;5068.265101560253;5080.237964305384;6003.849903752353;6050.909236361458;6057.242844644419;6070.332263451017;6075.635461872302;5024.522670346311;5030.144875371196;5053.9494605054215;5057.115004874132;5063.949360506422;3191.760617953663;3219.1952011997;3277.131560136566;3281.343731253711;3289.8190599517256;5766.452187042224;5825.563082768725;5832.125181222766;5836.854078648068;5849.239598852122;6231.065340199007;6243.75024999004;6244.718987645567;6249.50003999688;6254.906176407358;5565.1374037024325;5701.2018317435595;5736.885262294731;5756.301890942098;5759.424057594291;6023.48800351975;6052.939470605414;6068.696565171812;6069.605475644069;6077.513798896166;5880.411958804086;5927.792527261525;5935;5939.376365481735;5944.1975333331175;5727.971360143172;5742.799002034909;5745.109508026263;5752.453516915886;5773.3072031356505;3887.1836914248324;4003.779792111345;4005.5593884673244;4009.91980160401;4091.6726661866383;6007.849803754941;6067.666278354733;6087.8782424350375;6091.116788065794;6180.845478863064;5909.349971503218;5933.347331793413;5947.732352044082;5955.91066134017;5960.403959604005;5860.0037993542055;5868.383819699041;5912.556558258062;5933.961556727641;5934.258217722785;5620.775168993195;5734.569907257056;5766.5675074368755;5775.989201889736;5782.537397008314;5973.283206015306;5985.162077309267;6000.21997140369;6003.879922401615;6005.849853753691;5730.770769169353;5762.510186634183;5764.855878603068;5776.624519406225;5809.593328466966 05:35:58 INFO - PROCESS | 26907 | |5;yui.html;649.7043845050503;668.6589839182017;682.1813823411903;721.2823240875326;764.4419573711194;11670.649880503588;11815.940920295408;11822.940885295582;11830.645080647573;11849.940750296248;13258.469661213565;13509.189448633064;13510.729785404286;13548.661283467918;13610.251436171007;767.4512723402765;780.0561320801837;787.5904529644581;795.220683729945;796.5380079553845;792.3067316098413;795.5862951265339;797.8563858505466;798.4969469234375;800.4316934976144;823.275517544563;823.8887750153742;825.896762904637;829.7966998085477;833.2292629317888;812.273015650992;818.5252553518944;822.461287856455;823.279630323467;824;609.9756009759649;611.0467670434092;611.6391329115843;615.1603061820628;615.741388616782;11686;11696.766064678659;11704;11731.88268117325;11755.118366122575;11204.831927521094;11501.76996460066;11621.302721836631;11988.940055299754;12223.816642750366;10783.083437907788;10961.068309193728;11020.614278500214;11064.944675276653;11112.44437778108;3242.2542815152647;3264.853081611333;3308.884189053396;3362.411577973869;3378.797272163678;40966.590334096574;41225.1754964902;41505.79247103745;41544;42168.15663686709;9311.255099592016;9630.422174669542;9748.9025109748;9836.704898853046;9849.75375615601;16143.919280403758;16214.189290535662;16246.106464144586;16269.10519921392;16271.8033065537;6276.340984196685;6309;6363.809085727436;6485.254195767453;6618.602883826986;3706.8517259309324;3715.108373990223;3730.813459327023;3747.5315585551807;3792.677622402127;2733.139061195717;2744.986275068612;2745.492083964433;2767.1283545683045;2773.583962405615;470.06926285954;474.27909577442784;482.32233711635206;482.879280179955;484.43805185984087;613.6134235431649;614.6772944204329;628.4218518962565;643.1253495246461;645.725566634188;7839.529628222325;8617.913820861837;8810.251128654008;9004.909950900537;9042.728718138467;564.7938502446659;580.1703563903574;583.5419195931173;595.1519085303512;603.9094135879653;3633.291508155884;3752.478263692244;3892.5328960524353;3905.1994341159993;3990.461287726178;50480.74759626178;51967;52014;52215.73892130591;54100.72949635305;40646.59353406428;40758.592414076076;42580;42831;43312;39307;39867.60132398639;40077.398839017435;41930.790346048685;42508.78745606314;7826.921730782847;7902.85408615759;8374.916250837414;8436.156384361515;8500.957495212484;29720.554191686708;30003.249918752204;30374.848125760112;30413;30585.54121688132;33580.328393432486;33741;35418.46872296866;38868.222635547696;39136.804315979374;9972.3019388645;10172.542235599563;10236.539355729159;10290.228232882415;10515.158787296845;10808.567657293936;11025.17311201647;11041.944790276319;11223.316502524687;11291.668123667081;10632.362058276529;10650.89349106499;10658.467076646291;10675.679729608124;10744.570217191225;10440.530176142243;10510.737231569272;10513.89486105129;10521.158307335241;10579.788404232026;10639.574417023232;10751.354918704903;10766.569337226736;10779.51492182838;10866.565337386415;9007.459552426875;9092;9325.580348884181;9374.203192728695;9391;9026.81946361056;9296.39573427725;9325.300602454707;9494.715158545254;9531.761705957406 05:35:58 INFO - PROCESS | 26907 | __end_tp_report 05:35:58 INFO - PROCESS | 26907 | __start_cc_report 05:35:58 INFO - PROCESS | 26907 | _x_x_mozilla_cycle_collect,336 05:35:58 INFO - PROCESS | 26907 | __end_cc_report 05:35:58 INFO - PROCESS | 26907 | __startTimestamp1454765758181__endTimestamp 05:35:58 INFO - PROCESS | 26907 | 05:35:58 INFO - PROCESS | 26907 | ------- Summary: start ------- 05:35:58 INFO - PROCESS | 26907 | Number of tests: 6 05:35:58 INFO - PROCESS | 26907 | 05:35:58 INFO - PROCESS | 26907 | [#0] dojo.html Cycles:165 Average:4569.99 Median:4735.76 stddev:582.26 (12.3%) stddev-sans-first:564.04 05:35:58 INFO - PROCESS | 26907 | Values: 2641.4 2650.8 2682.6 2696.4 2713.8 4538.7 4695.8 4727.1 4729.2 4748.9 4576.9 4583.5 4603.9 4605.4 4694.2 4242.5 4301.3 4322.4 4400.5 4416.0 208.3 4289.2 4340.5 4381.8 4410.8 4291.2 4314.1 4321.0 4347.8 4362.3 4310.5 4316.3 4364.7 4377.0 4386.9 4132.2 4146.3 4229.3 4370.9 4421.4 4548.7 4561.4 4571.8 4597.4 4617.7 4892.0 4915.5 4931.2 4944.2 5008.9 4857.2 4927.8 4944.1 4987.2 5055.9 4662.7 4662.7 4681.5 4688.0 4722.6 5131.3 5141.9 5143.2 5151.6 5202.4 4760.0 4844.7 4887.3 4892.9 4957.0 4926.2 4973.4 4974.0 4975.3 4985.0 4822.9 4876.5 4927.0 4944.0 4946.0 4811.4 4892.1 4909.4 4912.2 4970.0 4092.2 4101.8 4112.0 4132.7 4152.3 3543.5 3625.0 3626.6 3640.4 3658.1 4241.0 4288.1 4295.0 4327.7 4333.9 4964.6 4989.0 4992.0 5005.7 5029.9 4197.1 4288.4 4288.5 4294.3 4312.9 4402.3 4407.1 4434.2 4441.9 4442.8 4730.9 4735.0 4735.8 4746.7 4777.6 4856.5 4918.4 4930.9 4972.8 4975.6 4732.5 4757.4 4761.5 4766.1 4798.0 4890.6 4915.2 4921.5 4926.5 4969.8 4802.9 4905.3 4957.1 4999.3 5024.0 4817.1 4835.6 4844.3 4856.9 4903.2 4833.0 4843.2 4850.0 4852.8 4899.2 4623.0 4691.8 4699.5 4723.4 4746.4 4870.0 4884.2 4897.0 4897.6 4915.4 4591.5 4770.1 4782.2 4789.7 4833.1 05:35:58 INFO - PROCESS | 26907 | 05:35:58 INFO - PROCESS | 26907 | [#1] ext.html Cycles:180 Average:38356.61 Median:33399.67 stddev:61582.18 (184.4%) stddev-sans-first:61689.31 05:35:58 INFO - PROCESS | 26907 | Values: 492.4 495.3 499.1 519.9 520.0 33112.3 33759.0 33803.8 33818.7 33846.5 37341.6 37588.0 37863.1 37864.8 37900.2 7649.1 7906.4 7956.0 7965.5 7971.9 7820.8 7861.2 7943.0 8039.2 8097.9 8040.3 8095.7 8107.2 8161.2 8190.2 8026.6 8026.8 8030.7 8035.6 8126.0 7780.6 7966.3 7988.0 7994.0 8013.6 38276.4 38333.0 38622.0 38657.6 38902.2 2675.9 3061.5 3068.8 3073.5 3096.9 24675.3 24920.4 25214.1 25225.4 25698.4 3256.6 3259.0 3272.6 3282.4 3369.2 144737.6 145210.0 145472.3 145602.0 145780.3 47012.0 47429.5 51977.5 54614.5 55561.7 48287.0 49307.3 49429.5 49483.5 49489.5 13473.5 13685.4 13747.3 13815.9 13835.0 9168.8 9170.4 9261.9 9321.3 9374.2 18709.3 18977.6 19066.8 19120.4 19127.0 6898.4 7203.2 7292.6 7298.1 7338.3 836.2 877.7 930.3 1018.0 1034.2 24007.6 24329.1 24520.3 24823.5 25239.5 909.7 946.0 951.2 1030.1 1065.0 12432.6 12496.8 12549.4 13085.8 13139.5 268904.0 271160.0 272279.0 272483.0 273604.0 45721.8 46550.8 46605.5 46922.3 46969.5 1179.9 1186.2 1192.3 1214.6 1227.1 23961.0 24032.4 24105.5 24128.1 24337.5 38426.6 38923.6 39015.0 39126.0 39202.8 265538.0 266293.0 267398.0 267760.0 267883.0 29194.0 29819.4 29870.6 30264.0 30320.1 33793.2 33870.8 34105.7 34561.7 34585.0 31237.7 32616.5 32678.5 33580.0 33749.5 32389.0 32489.6 33262.5 33307.7 33491.7 32616.2 32785.0 32802.5 32891.5 33172.8 28522.7 28737.1 29684.6 29742.6 29938.6 21589.2 23559.0 23607.0 23609.9 23751.3 05:35:58 INFO - PROCESS | 26907 | 05:35:58 INFO - PROCESS | 26907 | [#2] jquery.html Cycles:180 Average:22251.23 Median:4879.48 stddev:65903.95 (1350.6%) stddev-sans-first:66068.30 05:35:58 INFO - PROCESS | 26907 | Values: 344.8 345.4 345.8 347.6 349.1 14697.6 14996.6 15937.0 16172.2 16173.8 9914.5 10177.8 13474.5 14974.9 15023.5 4386.8 4446.9 4584.2 4593.0 4659.0 4483.3 4567.5 4568.1 4613.3 4625.2 4511.8 4534.7 4719.2 4929.1 4941.3 4730.2 4865.4 4873.2 4885.7 5114.8 4914.5 4915.1 4919.4 4937.2 4961.7 17735.5 17802.2 18348.0 18705.8 18730.3 1685.7 1690.8 1727.4 1769.6 2169.3 8385.8 8424.8 8661.8 8755.5 8842.2 1729.4 1748.1 1811.4 1824.9 1886.2 52360.0 53909.7 53954.0 53983.2 54336.2 9367.5 9536.9 9768.3 9825.2 9904.4 12409.6 12448.3 12458.2 12463.4 12472.9 6269.2 6478.1 6486.9 6545.2 6575.8 5987.0 5992.8 6040.0 6050.7 6064.4 3882.5 3984.2 4081.8 4121.1 4213.5 1457.8 1745.3 1759.2 1771.2 1785.1 745.2 914.7 927.8 938.8 946.7 14619.5 14637.9 14739.9 14916.9 15082.4 828.4 855.0 857.4 905.4 922.9 8718.0 9028.5 9156.2 9302.8 9569.7 315160.0 316993.0 321651.0 499858.0 504094.0 59834.1 61532.7 62950.7 65352.4 69990.7 1003.6 1037.0 1043.1 1044.9 1049.1 13080.5 13828.8 14187.6 14204.5 14649.0 31502.8 31709.2 32075.4 32182.7 32536.7 39564.4 39960.4 40280.6 40308.6 40405.2 6720.8 6813.6 6860.9 6871.3 6965.2 9438.2 9836.3 9870.8 9951.1 10371.1 6458.9 7702.2 8657.4 8884.6 9023.2 2527.1 3895.8 5669.7 8911.7 8991.8 8342.9 8502.9 9145.1 9537.4 9637.8 6826.5 6874.8 6947.9 7078.9 7094.4 8075.6 9047.9 9147.5 9169.0 9206.4 05:35:58 INFO - PROCESS | 26907 | 05:35:58 INFO - PROCESS | 26907 | [#3] mootools.html Cycles:180 Average:5181.72 Median:6154.49 stddev:2743.06 (44.6%) stddev-sans-first:2736.07 05:35:58 INFO - PROCESS | 26907 | Values: 1405.8 1417.8 1560.0 1731.4 1741.7 6446.2 6506.7 7367.4 7547.4 7574.5 7069.3 7307.9 7375.3 7385.1 7397.2 2125.0 2155.7 2156.9 2157.4 2162.2 2005.5 2021.2 2161.5 2187.5 2193.0 2132.2 2139.3 2141.5 2148.6 2157.9 2154.8 2157.8 2158.1 2160.1 2165.7 2133.9 2182.9 2188.4 2190.9 2199.5 7451.1 7475.5 7515.7 7520.6 7521.2 4196.6 4305.2 4311.5 4314.9 4339.6 2846.5 2858.7 2921.1 2921.2 2927.9 931.1 967.9 985.9 999.2 1004.0 10204.5 10221.0 10260.2 10281.3 10304.2 4011.6 4059.5 4117.1 4134.0 4149.5 8804.2 8819.7 8822.9 8829.1 8843.2 4201.0 4205.4 4216.1 4223.3 4225.9 3117.8 3163.4 3741.7 3743.3 3819.7 3499.8 3545.8 3558.1 3565.7 3567.8 1122.9 1127.1 1134.3 1135.4 1144.4 1161.8 1178.1 1188.4 1192.5 1210.7 6756.6 6867.1 6872.9 6877.4 7077.8 430.4 435.8 436.5 437.4 438.8 5353.5 5397.9 5433.6 5436.2 5451.3 8445.9 8696.5 8826.6 8893.3 9233.6 8668.1 8701.2 8718.4 8744.0 8747.8 6709.0 6747.7 6796.9 7143.7 7144.5 6966.4 6996.6 7011.0 7030.9 7053.3 8027.7 8197.1 8382.4 8384.0 8423.1 8310.1 8399.2 8530.3 8578.2 8665.5 6667.8 6880.0 6936.6 7096.6 7199.2 7043.4 7054.4 7105.9 7108.3 7115.5 6485.1 6618.1 6696.8 6786.4 6835.1 6498.3 6600.3 6639.9 6644.9 6707.7 6640.2 6665.0 6683.2 6813.3 6857.4 6072.9 6081.9 6110.0 6110.5 6120.3 6188.7 6244.3 6247.0 6264.2 6276.2 05:35:58 INFO - PROCESS | 26907 | 05:35:58 INFO - PROCESS | 26907 | [#4] prototype.html Cycles:180 Average:4806.11 Median:5597.45 stddev:1462.15 (26.1%) stddev-sans-first:1426.62 05:35:58 INFO - PROCESS | 26907 | Values: 300.9 304.5 311.3 311.7 312.8 5488.1 5577.3 5610.8 5615.6 5720.1 5522.3 5550.9 5595.5 5599.4 5606.6 4055.9 4153.5 4260.7 4264.4 4270.6 4144.9 4156.1 4163.4 4170.1 4178.2 4147.7 4151.2 4157.5 4159.7 4159.9 4151.5 4157.6 4160.8 4162.5 4167.2 3523.2 3582.6 3588.2 3589.7 3594.5 5232.8 5322.7 5324.2 5330.6 5331.5 4778.0 4794.8 4841.6 4851.5 4865.2 5812.7 5858.8 5865.5 5866.0 5869.6 3853.3 3863.2 3940.9 3947.8 3948.9 6051.5 6138.1 6141.2 6156.2 6157.0 3970.0 3982.0 3983.6 3983.6 3994.1 4020.5 4038.8 4041.7 4047.0 4051.1 4599.5 4735.0 4738.0 4748.7 4755.7 5628.2 5757.4 5827.7 5844.9 5850.1 1416.1 1432.7 1435.0 1438.5 1439.0 956.5 966.9 967.4 984.8 986.4 4992.0 5025.6 5066.5 5068.3 5080.2 6003.8 6050.9 6057.2 6070.3 6075.6 5024.5 5030.1 5053.9 5057.1 5063.9 3191.8 3219.2 3277.1 3281.3 3289.8 5766.5 5825.6 5832.1 5836.9 5849.2 6231.1 6243.8 6244.7 6249.5 6254.9 5565.1 5701.2 5736.9 5756.3 5759.4 6023.5 6052.9 6068.7 6069.6 6077.5 5880.4 5927.8 5935.0 5939.4 5944.2 5728.0 5742.8 5745.1 5752.5 5773.3 3887.2 4003.8 4005.6 4009.9 4091.7 6007.8 6067.7 6087.9 6091.1 6180.8 5909.3 5933.3 5947.7 5955.9 5960.4 5860.0 5868.4 5912.6 5934.0 5934.3 5620.8 5734.6 5766.6 5776.0 5782.5 5973.3 5985.2 6000.2 6003.9 6005.8 5730.8 5762.5 5764.9 5776.6 5809.6 05:35:58 INFO - PROCESS | 26907 | 05:35:58 INFO - PROCESS | 26907 | [#5] yui.html Cycles:180 Average:12315.52 Median:41365.48 stddev:13665.95 (33.0%) stddev-sans-first:13676.20 05:35:58 INFO - PROCESS | 26907 | Values: 649.7 668.7 682.2 721.3 764.4 11670.6 11815.9 11822.9 11830.6 11849.9 13258.5 13509.2 13510.7 13548.7 13610.3 767.5 780.1 787.6 795.2 796.5 792.3 795.6 797.9 798.5 800.4 823.3 823.9 825.9 829.8 833.2 812.3 818.5 822.5 823.3 824.0 610.0 611.0 611.6 615.2 615.7 11686.0 11696.8 11704.0 11731.9 11755.1 11204.8 11501.8 11621.3 11988.9 12223.8 10783.1 10961.1 11020.6 11064.9 11112.4 3242.3 3264.9 3308.9 3362.4 3378.8 40966.6 41225.2 41505.8 41544.0 42168.2 9311.3 9630.4 9748.9 9836.7 9849.8 16143.9 16214.2 16246.1 16269.1 16271.8 6276.3 6309.0 6363.8 6485.3 6618.6 3706.9 3715.1 3730.8 3747.5 3792.7 2733.1 2745.0 2745.5 2767.1 2773.6 470.1 474.3 482.3 482.9 484.4 613.6 614.7 628.4 643.1 645.7 7839.5 8617.9 8810.3 9004.9 9042.7 564.8 580.2 583.5 595.2 603.9 3633.3 3752.5 3892.5 3905.2 3990.5 50480.7 51967.0 52014.0 52215.7 54100.7 40646.6 40758.6 42580.0 42831.0 43312.0 39307.0 39867.6 40077.4 41930.8 42508.8 7826.9 7902.9 8374.9 8436.2 8501.0 29720.6 30003.2 30374.8 30413.0 30585.5 33580.3 33741.0 35418.5 38868.2 39136.8 9972.3 10172.5 10236.5 10290.2 10515.2 10808.6 11025.2 11041.9 11223.3 11291.7 10632.4 10650.9 10658.5 10675.7 10744.6 10440.5 10510.7 10513.9 10521.2 10579.8 10639.6 10751.4 10766.6 10779.5 10866.6 9007.5 9092.0 9325.6 9374.2 9391.0 9026.8 9296.4 9325.3 9494.7 9531.8 05:35:58 INFO - PROCESS | 26907 | -------- Summary: end -------- 05:35:58 INFO - PROCESS | 26907 | 05:35:58 INFO - TEST-INFO | 26907: exit 0 05:35:58 INFO - TEST-OK | dromaeo_css | took 1113655ms 05:35:58 INFO - TEST-START | kraken 05:35:58 INFO - operating with platform_type : linux_ 05:35:58 INFO - Initialising browser for kraken test... 05:35:58 INFO - TEST-INFO | started process 27153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWD6Ykn/profile http://localhost:36944/getInfo.html) 05:35:59 INFO - PROCESS | 27153 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 05:36:03 INFO - PROCESS | 27153 | 05:36:03 INFO - PROCESS | 27153 | (process:27224): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:36:03 INFO - PROCESS | 27153 | __metrics Screen width/height:1600/1200 05:36:03 INFO - PROCESS | 27153 | colorDepth:24 05:36:03 INFO - PROCESS | 27153 | Browser inner width/height: 1024/697 05:36:03 INFO - PROCESS | 27153 | __metrics 05:36:04 INFO - PROCESS | 27153 | 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:36:04 ERROR - PROCESS | 27153 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2830: TypeError: this.tabs is undefined 05:36:04 INFO - PROCESS | 27153 | ************************* 05:36:04 INFO - PROCESS | 27153 | A coding exception was thrown in a Promise resolution callback. 05:36:04 INFO - PROCESS | 27153 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 05:36:04 INFO - PROCESS | 27153 | 05:36:04 ERROR - PROCESS | 27153 | Full message: TypeError: this.tabs is undefined 05:36:04 INFO - PROCESS | 27153 | Full stack: .get@chrome://browser/content/tabbrowser.xml:2830:17 05:36:04 INFO - PROCESS | 27153 | ssi_onClose/<@resource:///modules/sessionstore/SessionStore.jsm:1323:9 05:36:04 INFO - PROCESS | 27153 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 05:36:04 INFO - PROCESS | 27153 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 05:36:04 INFO - PROCESS | 27153 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 05:36:04 INFO - PROCESS | 27153 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 05:36:04 INFO - PROCESS | 27153 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 05:36:04 INFO - PROCESS | 27153 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:146:5 05:36:04 INFO - PROCESS | 27153 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:52:5 05:36:04 INFO - PROCESS | 27153 | receiveMessage@resource:///modules/sessionstore/SessionStore.jsm:734:11 05:36:04 INFO - PROCESS | 27153 | 05:36:04 INFO - PROCESS | 27153 | ************************* 05:36:04 INFO - TEST-INFO | 27153: exit 0 05:36:04 INFO - Browser initialized. 05:36:04 INFO - Running cycle 1/1 for kraken test... 05:36:04 INFO - TEST-INFO | started process 27273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWD6Ykn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:06 INFO - PROCESS | 27273 | 05:36:06 INFO - PROCESS | 27273 | (process:27331): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:36:16 INFO - PROCESS | 27273 | RSS: Main: 152715264 05:36:16 INFO - PROCESS | 27273 | 05:36:19 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36944/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:20 INFO - PROCESS | 27273 | RSS: Main: 156966912 05:36:20 INFO - PROCESS | 27273 | 05:36:22 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36944/tests/kraken/driver.html?testName=audio-dft) 05:36:23 INFO - PROCESS | 27273 | RSS: Main: 159432704 05:36:23 INFO - PROCESS | 27273 | 05:36:26 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36944/tests/kraken/driver.html?testName=audio-fft) 05:36:27 INFO - PROCESS | 27273 | RSS: Main: 151740416 05:36:27 INFO - PROCESS | 27273 | 05:36:29 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36944/tests/kraken/driver.html?testName=audio-oscillator) 05:36:29 INFO - PROCESS | 27273 | RSS: Main: 150368256 05:36:29 INFO - PROCESS | 27273 | 05:36:32 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:32 INFO - PROCESS | 27273 | RSS: Main: 152018944 05:36:32 INFO - PROCESS | 27273 | 05:36:35 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36944/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:36 INFO - PROCESS | 27273 | RSS: Main: 153329664 05:36:36 INFO - PROCESS | 27273 | 05:36:39 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36944/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:40 INFO - PROCESS | 27273 | RSS: Main: 153284608 05:36:40 INFO - PROCESS | 27273 | 05:36:43 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36944/tests/kraken/driver.html?testName=json-parse-financial) 05:36:43 INFO - PROCESS | 27273 | RSS: Main: 153780224 05:36:43 INFO - PROCESS | 27273 | 05:36:45 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:46 INFO - PROCESS | 27273 | RSS: Main: 154320896 05:36:46 INFO - PROCESS | 27273 | 05:36:48 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:48 INFO - PROCESS | 27273 | RSS: Main: 152924160 05:36:48 INFO - PROCESS | 27273 | 05:36:50 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:51 INFO - PROCESS | 27273 | RSS: Main: 153468928 05:36:51 INFO - PROCESS | 27273 | 05:36:54 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:54 INFO - PROCESS | 27273 | RSS: Main: 153686016 05:36:54 INFO - PROCESS | 27273 | 05:36:57 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:57 INFO - PROCESS | 27273 | RSS: Main: 154189824 05:36:57 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:36944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36944/tests/kraken/driver.html?testName=ai-astar) 05:36:59 INFO - PROCESS | 27273 | RSS: Main: 154419200 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | __start_tp_report 05:36:59 INFO - PROCESS | 27273 | _x_x_mozilla_page_load 05:36:59 INFO - PROCESS | 27273 | _x_x_mozilla_page_load_details 05:36:59 INFO - PROCESS | 27273 | |i|pagename|runs| 05:36:59 INFO - PROCESS | 27273 | |0;ai-astar;114;108;116;115;116;125;113;113;113;114 05:36:59 INFO - PROCESS | 27273 | |1;audio-beat-detection;173;134;166;168;141;157;166;136;173;133 05:36:59 INFO - PROCESS | 27273 | |2;audio-dft;163;163;165;164;164;167;165;163;165;163 05:36:59 INFO - PROCESS | 27273 | |3;audio-fft;75;73;74;75;78;139;76;74;73;74 05:36:59 INFO - PROCESS | 27273 | |4;audio-oscillator;98;98;133;97;98;98;139;97;99;133 05:36:59 INFO - PROCESS | 27273 | |5;imaging-gaussian-blur;120;116;115;119;116;116;115;116;115;115 05:36:59 INFO - PROCESS | 27273 | |6;imaging-darkroom;149;150;148;147;148;149;150;147;148;150 05:36:59 INFO - PROCESS | 27273 | |7;imaging-desaturate;97;96;97;97;97;98;97;97;97;97 05:36:59 INFO - PROCESS | 27273 | |8;json-parse-financial;69;68;69;70;68;67;67;75;69;66 05:36:59 INFO - PROCESS | 27273 | |9;json-stringify-tinderbox;68;69;69;70;72;70;71;70;69;69 05:36:59 INFO - PROCESS | 27273 | |10;stanford-crypto-aes;84;85;86;86;86;86;85;84;86;94 05:36:59 INFO - PROCESS | 27273 | |11;stanford-crypto-ccm;124;128;139;127;132;124;125;127;123;123 05:36:59 INFO - PROCESS | 27273 | |12;stanford-crypto-pbkdf2;143;154;151;156;143;144;150;153;159;141 05:36:59 INFO - PROCESS | 27273 | |13;stanford-crypto-sha256-iterative;72;75;73;74;75;71;71;70;70;69 05:36:59 INFO - PROCESS | 27273 | __end_tp_report 05:36:59 INFO - PROCESS | 27273 | __start_cc_report 05:36:59 INFO - PROCESS | 27273 | _x_x_mozilla_cycle_collect,803 05:36:59 INFO - PROCESS | 27273 | __end_cc_report 05:36:59 INFO - PROCESS | 27273 | __startTimestamp1454765819904__endTimestamp 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | ------- Summary: start ------- 05:36:59 INFO - PROCESS | 27273 | Number of tests: 14 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.50 stddev:4.27 (3.7%) stddev-sans-first:4.52 05:36:59 INFO - PROCESS | 27273 | Values: 114.0 108.0 116.0 115.0 116.0 125.0 113.0 113.0 113.0 114.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:166.00 stddev:16.81 (10.1%) stddev-sans-first:16.48 05:36:59 INFO - PROCESS | 27273 | Values: 173.0 134.0 166.0 168.0 141.0 157.0 166.0 136.0 173.0 133.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:1.32 (0.8%) stddev-sans-first:1.32 05:36:59 INFO - PROCESS | 27273 | Values: 163.0 163.0 165.0 164.0 164.0 167.0 165.0 163.0 165.0 163.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.50 stddev:20.40 (27.4%) stddev-sans-first:21.52 05:36:59 INFO - PROCESS | 27273 | Values: 75.0 73.0 74.0 75.0 78.0 139.0 76.0 74.0 73.0 74.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:98.00 stddev:18.02 (18.4%) stddev-sans-first:18.67 05:36:59 INFO - PROCESS | 27273 | Values: 98.0 98.0 133.0 97.0 98.0 98.0 139.0 97.0 99.0 133.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:1.77 (1.5%) stddev-sans-first:1.27 05:36:59 INFO - PROCESS | 27273 | Values: 120.0 116.0 115.0 119.0 116.0 116.0 115.0 116.0 115.0 115.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.17 (0.8%) stddev-sans-first:1.24 05:36:59 INFO - PROCESS | 27273 | Values: 149.0 150.0 148.0 147.0 148.0 149.0 150.0 147.0 148.0 150.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:36:59 INFO - PROCESS | 27273 | Values: 97.0 96.0 97.0 97.0 97.0 98.0 97.0 97.0 97.0 97.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:69.00 stddev:2.49 (3.6%) stddev-sans-first:2.64 05:36:59 INFO - PROCESS | 27273 | Values: 69.0 68.0 69.0 70.0 68.0 67.0 67.0 75.0 69.0 66.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:1.16 (1.7%) stddev-sans-first:1.05 05:36:59 INFO - PROCESS | 27273 | Values: 68.0 69.0 69.0 70.0 72.0 70.0 71.0 70.0 69.0 69.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:2.86 (3.3%) stddev-sans-first:2.92 05:36:59 INFO - PROCESS | 27273 | Values: 84.0 85.0 86.0 86.0 86.0 86.0 85.0 84.0 86.0 94.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:127.00 stddev:4.98 (3.9%) stddev-sans-first:5.15 05:36:59 INFO - PROCESS | 27273 | Values: 124.0 128.0 139.0 127.0 132.0 124.0 125.0 127.0 123.0 123.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:152.00 stddev:6.28 (4.1%) stddev-sans-first:6.21 05:36:59 INFO - PROCESS | 27273 | Values: 143.0 154.0 151.0 156.0 143.0 144.0 150.0 153.0 159.0 141.0 05:36:59 INFO - PROCESS | 27273 | 05:36:59 INFO - PROCESS | 27273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.50 stddev:2.16 (3.0%) stddev-sans-first:2.29 05:36:59 INFO - PROCESS | 27273 | Values: 72.0 75.0 73.0 74.0 75.0 71.0 71.0 70.0 70.0 69.0 05:36:59 INFO - PROCESS | 27273 | -------- Summary: end -------- 05:36:59 INFO - PROCESS | 27273 | 05:37:00 INFO - TEST-INFO | 27273: exit 0 05:37:00 INFO - TEST-OK | kraken | took 61978ms 05:37:00 INFO - SUITE-END | took 1175s 05:37:01 INFO - Completed test suite (00:19:35) 05:37:01 INFO - Working with test: dromaeo_css 05:37:01 INFO - Generating results file: dromaeo_css 05:37:01 INFO - Working with test: kraken 05:37:01 INFO - Generating results file: kraken 05:37:01 INFO - javascript benchmark 05:37:01 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 05:37:01 INFO - process_Request line: dromaeo_css 6196.27 graph.html#tests=[[72,132,43]] 05:37:01 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:37:01 INFO - process_Request line: kraken 1558.90 graph.html#tests=[[232,132,43]] 05:37:01 INFO - RETURN: dromaeo_css: 6196.27 05:37:01 INFO - RETURN: kraken: 1558.90 05:37:01 INFO - javascript benchmark 05:37:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2641.3792758701707, 2650.7614314711673, 2682.624432579439, 2696.420269642028, 2713.7828973682103, 4538.659600529965, 4695.812167513295, 4727.078219747142, 4729.196036673765, 4748.881277968053, 4576.862694119173, 4583.495815460296, 4603.861884143473, 4605.447346318447, 4694.178518759212, 4242.469691288589, 4301.333293339521, 4322.373255877896, 4400.471943366801, 4416.0, 208.2717885840917, 4289.206496798087, 4340.500842403117, 4381.75900325482, 4410.845620403286, 4291.1632231714675, 4314.072474417983, 4320.978395108004, 4347.804348804296, 4362.323839804835, 4310.4611923509565, 4316.3309686998255, 4364.694471387004, 4377.03705184862, 4386.934195987063, 4132.194222126686, 4146.3158578834455, 4229.2598795210715, 4370.868873933787, 4421.447319085114, 4548.658850586219, 4561.429821272341, 4571.794269257858, 4597.356370108188, 4617.676762626617, 4892.0, 4915.48387419323, 4931.186354251544, 4944.208926571767, 5008.874778130539, 4857.198562237227, 4927.77824997876, 4944.085344211297, 4987.152184128707, 5055.949440505585, 4662.650301227422, 4662.673612847102, 4681.485036645966, 4687.9765601171775, 4722.6221902247735, 5131.307273518102, 5141.922871156936, 5143.228515722597, 5151.5878729701535, 5202.4277329493725, 4759.976605029866, 4844.660873738804, 4887.315775791321, 4892.877678058077, 4956.975215123974, 4926.162552366106, 4973.403191617029, 4973.975130124326, 4975.328330675313, 4984.953159836403, 4822.855314340575, 4876.512348765166, 4926.950730492721, 4944.035912997003, 4946.0355230729665, 4811.398575178103, 4892.094962431962, 4909.435414927258, 4912.189488734391, 4969.975150124298, 4092.1611069730634, 4101.794910254475, 4112.0, 4132.710710250253, 4152.294110001307, 3543.539339885798, 3625.021244264034, 3626.601073881871, 3640.381135207021, 3658.067192865802, 4240.978795106004, 4288.078063216423, 4294.9785251073545, 4327.653787696977, 4333.891652708708, 4964.60283177345, 4988.975055124701, 4991.975040124777, 5005.72468514228, 5029.874253143701, 4197.055662475979, 4288.421063156434, 4288.463942007249, 4294.26997410441, 4312.870613881526, 4402.3396490526675, 4407.096545208225, 4434.201843668171, 4441.911161776747, 4442.755648439367, 4730.881727956828, 4734.976325118421, 4735.763211839326, 4746.667733258708, 4777.641676874248, 4856.490068542894, 4918.385201849769, 4930.901381972412, 4972.751362431936, 4975.577075948585, 4732.52674732524, 4757.429108507002, 4761.523847615211, 4766.070616229802, 4798.0, 4890.584300334512, 4915.21356582945, 4921.50784921505, 4926.458089610212, 4969.82605608802, 4802.855914322576, 4905.288733133604, 4957.132501812241, 4999.250112483157, 5024.020316038337, 4817.084753896888, 4835.6131509479865, 4844.297576851407, 4856.854294371175, 4903.239997800347, 4833.03339332128, 4843.176659967884, 4850.029994001144, 4852.75736213195, 4899.167141585867, 4622.976885115553, 4691.788869500812, 4699.459562150397, 4723.4331880174595, 4746.359241502353, 4869.975650121868, 4884.218525035977, 4896.951030489649, 4897.559219670246, 4915.410150781929, 4591.517890621437, 4770.069836381872, 4782.210935195653, 4789.712617242976, 4833.081714474239], "unit": "score", "name": "dojo.html", "value": 4536.882717072792}, {"lowerIsBetter": false, "replicates": [492.3550149304411, 495.30409774267144, 499.1090902738612, 519.8726312053548, 520.0457161109364, 33112.33775324492, 33759.0, 33803.830980845065, 33818.66181338192, 33846.49230261545, 37341.626583734156, 37588.0, 37863.05342366442, 37864.810675946654, 37900.24199516015, 7649.120351159632, 7906.379192265572, 7956.04527456706, 7965.522068675869, 7971.920280797205, 7820.804479887991, 7861.174576669453, 7943.046834379882, 8039.155888631697, 8097.919020809775, 8040.316573091294, 8095.6761729530745, 8107.189281071905, 8161.183881611851, 8190.180981901792, 8026.558539280308, 8026.839463210761, 8030.678772849079, 8035.5580443075605, 8125.959370203141, 7780.649870755773, 7966.28303452692, 7987.960060199662, 7994.040715114165, 8013.559254241014, 38276.42585361222, 38333.0, 38622.0, 38657.61342386568, 38902.22195556101, 2675.8929642814264, 3061.4642437573334, 3068.7851850370484, 3073.523603841408, 3096.90709278722, 24675.259742207763, 24920.37699057538, 25214.117505887207, 25225.36936576582, 25698.357541061436, 3256.576645036154, 3258.983705081483, 3272.5582046423665, 3282.4091663500562, 3369.157710572357, 144737.55262447346, 145210.0, 145472.2726386372, 145602.0, 145780.27109864383, 47012.0, 47429.5257047432, 51977.480225197265, 54614.45385546173, 55561.722191388784, 48287.0, 49307.26039109416, 49429.50570494321, 49483.50516494789, 49489.50510494921, 13473.528426505025, 13685.384157712728, 13747.312634368242, 13815.930920345334, 13835.0, 9168.81662366749, 9170.358074934824, 9261.907380926104, 9321.347505674674, 9374.203192728559, 18709.345172919155, 18977.620447590973, 19066.80933190678, 19120.426387208405, 19127.043647817554, 6898.379145876896, 7203.243659415791, 7292.562446253136, 7298.124225092916, 7338.266173382619, 836.1930736838858, 877.6621000914566, 930.3115694386106, 1018.0277834667875, 1034.2243317511866, 24007.63988540173, 24329.148479803123, 24520.264392068268, 24823.50352992966, 25239.495210095694, 909.7179874239007, 945.9877930614176, 951.1962391778935, 1030.0935177044303, 1064.973375665599, 12432.627021189379, 12496.81254781179, 12549.372531373394, 13085.803712944313, 13139.474421023244, 268904.0, 271160.0, 272279.0, 272483.0, 273604.0, 45721.77139114283, 46550.76724616355, 46605.5339446608, 46922.29616555754, 46969.5303046972, 1179.8938095571439, 1186.2348785033605, 1192.284629222477, 1214.5870404062662, 1227.0796902323257, 23961.0, 24032.39919001969, 24105.51788964246, 24128.05374898177, 24337.51324973526, 38426.61573384231, 38923.610763892, 39015.0, 39126.0, 39202.80398597989, 265538.0, 266293.0, 267398.0, 267760.0, 267883.0, 29194.0, 29819.35993520377, 29870.551941721325, 30264.0, 30320.090397288117, 33793.15517112092, 33870.78227568377, 34105.65894341025, 34561.65438345585, 34585.0, 31237.68762312348, 32616.510752339207, 32678.50982235316, 33580.0, 33749.493757594144, 32389.0, 32489.552716294405, 33262.50106248457, 33307.666923331424, 33491.66508334885, 32616.184595385304, 32785.0, 32802.50796238106, 32891.50662740109, 33172.834135829165, 28522.714772852007, 28737.137885863456, 29684.554731679473, 29742.553861692526, 29938.550921736627, 21589.239626762086, 23559.0, 23607.0, 23609.881950590137, 23751.287461376185], "unit": "score", "name": "ext.html", "value": 16198.033334169819}, {"lowerIsBetter": false, "replicates": [344.7982929985958, 345.37487148261647, 345.7666075399105, 347.61935680429934, 349.1062879029684, 14697.559073227807, 14996.550103496898, 15937.0, 16172.191390430491, 16173.838261617366, 9914.454704991223, 10177.84733229002, 13474.5283915063, 14974.925125374359, 15023.474178403758, 4386.824527018915, 4446.911061778763, 4584.19776539106, 4593.012502312003, 4659.044895796371, 4483.327500874879, 4567.497575266718, 4568.063546972862, 4613.331066995283, 4625.213713668668, 4511.7969691363805, 4534.6825722199455, 4719.174144524712, 4929.088118698034, 4941.308216849644, 4730.195866702668, 4865.367502224706, 4873.244647079709, 4885.706857588539, 5114.795408183668, 4914.483979182206, 4915.115279249733, 4919.360483137205, 4937.21004639256, 4961.677490963112, 17735.46793596194, 17802.198901049353, 18348.0, 18705.812941870543, 18730.250789968384, 1685.7050016247108, 1690.8393702598235, 1727.4126796889118, 1769.575301927541, 2169.305822136917, 8385.790355241106, 8424.83150336996, 8661.783455413602, 8755.474671519729, 8842.248408885253, 1729.4033558422325, 1748.0560497331426, 1811.356968276256, 1824.875780735534, 1886.1983656945881, 52360.0, 53909.73045134788, 53954.0, 53983.19025214664, 54336.184957225676, 9367.531623418801, 9536.856947145798, 9768.316217864824, 9825.213982881352, 9904.405735655884, 12409.62771116868, 12448.25310481374, 12458.190217635825, 12463.439145238486, 12472.937635311766, 6269.247690277196, 6478.125453063871, 6486.902696459557, 6545.181852268466, 6575.769848055295, 5987.0, 5992.790252341147, 6039.969800150971, 6050.6974651267265, 6064.3935606439, 3882.456456096149, 3984.163325701635, 4081.816318265626, 4121.093359460914, 4213.494380674339, 1457.8031965684709, 1745.2757105801204, 1759.24352528414, 1771.2383675019864, 1785.098525244743, 745.228688307599, 914.7484441778564, 927.7819712367589, 938.8362611816615, 946.7491114854569, 14619.488317908823, 14637.92681036588, 14739.92630036843, 14916.925415372854, 15082.396704131712, 828.3745771942146, 855.0338117926703, 857.4255248983196, 905.3979103895967, 922.9215516681023, 8717.956410218036, 9028.503432311154, 9156.221721153643, 9302.767430814283, 9569.665061722806, 315160.0, 316993.0, 321651.0, 499858.0, 504094.0, 59834.10248846271, 61532.69233653803, 62950.68524657348, 65352.445042171945, 69990.65004675045, 1003.6336737090909, 1036.9585216591402, 1043.0612448796144, 1044.8902865199198, 1049.1187402581716, 13080.476780928657, 13828.840983819595, 14187.574372768833, 14204.502842400467, 14649.0, 31502.842485787423, 31709.20726981844, 32075.35849283048, 32182.67817321797, 32536.67463325431, 39564.40653390259, 39960.40059399053, 40280.59719402769, 40308.59691403049, 40405.1918961625, 6720.798376048726, 6813.557118787263, 6860.931390686029, 6871.3128687132885, 6965.164180298194, 9438.24494040489, 9836.311458197857, 9870.753231169278, 9951.054649808257, 10371.066604005675, 6458.903116453163, 7702.229777022477, 8657.350698697748, 8884.600192991202, 9023.233025192669, 2527.140772137482, 3895.844166233319, 5669.659820410789, 8911.73264802057, 8991.820163596822, 8342.87485687703, 8502.872456913028, 9145.085491450802, 9537.427754334762, 9637.807243855224, 6826.488013399115, 6874.793756187322, 6947.930520694728, 7078.858422831411, 7094.396976257076, 8075.59622018885, 9047.864282035905, 9147.496887671243, 9168.954155229181, 9206.447613143233], "unit": "score", "name": "jquery.html", "value": 7322.005842275483}, {"lowerIsBetter": false, "replicates": [1405.810215620891, 1417.7802440621704, 1559.9532014039582, 1731.402666080202, 1741.7039103352436, 6446.161998940143, 6506.707198176082, 7367.447441441893, 7547.396208303343, 7574.545527268361, 7069.328413800681, 7307.853842923151, 7375.336219740222, 7385.076865391826, 7397.223291554376, 2124.9787502124937, 2155.7305336832897, 2156.91372345106, 2157.4067131538873, 2162.156758864044, 2005.4585261979257, 2021.2016253579827, 2161.470439742265, 2187.5406164705432, 2193.0, 2132.2217390652454, 2139.3047259640603, 2141.5395689926663, 2148.581026699794, 2157.9460513487134, 2154.806067453921, 2157.773433789453, 2158.082814803702, 2160.103557023841, 2165.66432203008, 2133.893305334727, 2182.945426364338, 2188.4091295350327, 2190.9452263693533, 2199.483121466454, 7451.068616422947, 7475.476716629838, 7515.699372025112, 7520.623968801593, 7521.210272921374, 4196.559361267084, 4305.246581848164, 4311.461067366579, 4314.870553883388, 4339.587739164775, 2846.4734024205586, 2858.6998365171567, 2921.0944607171846, 2921.1528656689534, 2927.92680182995, 931.0875342164717, 967.88869280033, 985.9211263098935, 999.1557134221571, 1003.9698809035667, 10204.540795664212, 10221.029002244775, 10260.230482713827, 10281.331713438603, 10304.175665946781, 4011.5988401160234, 4059.4519739835337, 4117.053077792065, 4133.958660413417, 4149.502059752849, 8804.163604457566, 8819.735407937773, 8822.911770882338, 8829.117088291248, 8843.248323892542, 4200.957990420056, 4205.432266644025, 4216.135692183095, 4223.282042052859, 4225.873223803229, 3117.828519431453, 3163.430582495127, 3741.663250307485, 3743.3262012837404, 3819.6753275971855, 3499.772514786531, 3545.804980726085, 3558.1282585766653, 3565.71474282062, 3567.7502574820032, 1122.8820973797633, 1127.1208457403238, 1134.3024040215207, 1135.432283858071, 1144.3934714601276, 1161.7502237019082, 1178.1399578307883, 1188.441432526711, 1192.505110379183, 1210.6791700199453, 6756.560823546453, 6867.141607299088, 6872.931270687329, 6877.449804015667, 7077.787666370017, 430.39314566461763, 435.8017102218483, 436.4675096382408, 437.4400767018158, 438.75868272450026, 5353.464653534693, 5397.892042159214, 5433.592480563973, 5436.184572314105, 5451.291332126798, 8445.915540844513, 8696.521691306913, 8826.602802873886, 8893.28853691703, 9233.630654773868, 8668.133186681407, 8701.216890479887, 8718.389712720049, 8743.956280218557, 8747.825043499222, 6709.0, 6747.662616869137, 6796.864062718817, 7143.749968751069, 7144.499885008104, 6966.442684585322, 6996.6151861648095, 7010.964945175241, 7030.9296907030275, 7053.3299336565, 8027.669968046439, 8197.139300373376, 8382.37132215074, 8384.0, 8423.115572865006, 8310.085890552155, 8399.202075802788, 8530.274926631306, 8578.227959483676, 8665.480071195749, 6667.799966001027, 6880.0, 6936.618485983319, 7096.574205547684, 7199.172095209118, 7043.436525077879, 7054.435645148478, 7105.8578828422105, 7108.324709152622, 7115.501914865909, 6485.124508191522, 6618.139641846529, 6696.7656132035145, 6786.3892249697765, 6835.07726456922, 6498.317676644074, 6600.273969863215, 6639.933600663931, 6644.90032649501, 6707.731690732316, 6640.203175618956, 6665.0, 6683.164604424447, 6813.250542440229, 6857.382835544825, 6072.939270607238, 6081.878362432815, 6110.022396416552, 6110.450059494667, 6120.265568131853, 6188.721507532082, 6244.250689917239, 6246.968765156145, 6264.21697287839, 6276.215473065867], "unit": "score", "name": "mootools.html", "value": 4170.840044721049}, {"lowerIsBetter": false, "replicates": [300.8691219319596, 304.5416647944843, 311.3011289654724, 311.7210096963219, 312.8295079181845, 5488.1493368527845, 5577.274954255941, 5610.803621873235, 5615.578831587632, 5720.141978703196, 5522.254495643087, 5550.91673624895, 5595.49640532352, 5599.41206173351, 5606.55147588193, 4055.858044968427, 4153.501579810427, 4260.70175087744, 4264.445622069142, 4270.572942705728, 4144.8549300774475, 4156.106437116019, 4163.375493675942, 4170.145120250341, 4178.22702799983, 4147.730397524167, 4151.211269858717, 4157.50109986802, 4159.667226621863, 4159.854405095823, 4151.522574903895, 4157.584241575818, 4160.833566657345, 4162.4796900387455, 4167.187398457302, 3523.1896663767475, 3582.6059133495296, 3588.22853086585, 3589.6589823966683, 3594.4967704521387, 5232.790688372461, 5322.733863306819, 5324.227986941911, 5330.573554115662, 5331.520163185293, 4777.976110119462, 4794.760261986921, 4841.636877234187, 4851.490593487668, 4865.19724245499, 5812.680302583356, 5858.8242352729485, 5865.472107510302, 5866.0, 5869.618474799125, 3853.2852880468204, 3863.2080423513394, 3940.9014774630864, 3947.8026098695236, 3948.921021579581, 6051.4553690168095, 6138.0792881067755, 6141.170941922828, 6156.199694039746, 6157.014877619604, 3969.980150099231, 3981.9845939285874, 3983.6215559521797, 3983.64147226751, 3994.0613955720382, 4020.5175378954714, 4038.7778672173313, 4041.7372870763306, 4046.979765101156, 4051.1492586556565, 4599.494055653875, 4735.029318989667, 4738.028704115648, 4748.6913350632785, 4755.714657120584, 5628.155776633538, 5757.395473475309, 5827.679477628772, 5844.8538786529825, 5850.0932355484965, 1416.1149281698938, 1432.749268877942, 1435.0313538361563, 1438.4749566408395, 1438.9856101439061, 956.5456408206186, 966.9081437263449, 967.4437198610827, 984.8227319082633, 986.4426598971559, 4991.9500804991485, 5025.648204625714, 5066.493350664978, 5068.265101560253, 5080.237964305384, 6003.849903752353, 6050.909236361458, 6057.242844644419, 6070.332263451017, 6075.635461872302, 5024.522670346311, 5030.144875371196, 5053.9494605054215, 5057.115004874132, 5063.949360506422, 3191.760617953663, 3219.1952011997, 3277.131560136566, 3281.343731253711, 3289.8190599517256, 5766.452187042224, 5825.563082768725, 5832.125181222766, 5836.854078648068, 5849.239598852122, 6231.065340199007, 6243.75024999004, 6244.718987645567, 6249.50003999688, 6254.906176407358, 5565.1374037024325, 5701.2018317435595, 5736.885262294731, 5756.301890942098, 5759.424057594291, 6023.48800351975, 6052.939470605414, 6068.696565171812, 6069.605475644069, 6077.513798896166, 5880.411958804086, 5927.792527261525, 5935.0, 5939.376365481735, 5944.1975333331175, 5727.971360143172, 5742.799002034909, 5745.109508026263, 5752.453516915886, 5773.3072031356505, 3887.1836914248324, 4003.779792111345, 4005.5593884673244, 4009.91980160401, 4091.6726661866383, 6007.849803754941, 6067.666278354733, 6087.8782424350375, 6091.116788065794, 6180.845478863064, 5909.349971503218, 5933.347331793413, 5947.732352044082, 5955.91066134017, 5960.403959604005, 5860.0037993542055, 5868.383819699041, 5912.556558258062, 5933.961556727641, 5934.258217722785, 5620.775168993195, 5734.569907257056, 5766.5675074368755, 5775.989201889736, 5782.537397008314, 5973.283206015306, 5985.162077309267, 6000.21997140369, 6003.879922401615, 6005.849853753691, 5730.770769169353, 5762.510186634183, 5764.855878603068, 5776.624519406225, 5809.593328466966], "unit": "score", "name": "prototype.html", "value": 4331.8882571664135}, {"lowerIsBetter": false, "replicates": [649.7043845050503, 668.6589839182017, 682.1813823411903, 721.2823240875326, 764.4419573711194, 11670.649880503588, 11815.940920295408, 11822.940885295582, 11830.645080647573, 11849.940750296248, 13258.469661213565, 13509.189448633064, 13510.729785404286, 13548.661283467918, 13610.251436171007, 767.4512723402765, 780.0561320801837, 787.5904529644581, 795.220683729945, 796.5380079553845, 792.3067316098413, 795.5862951265339, 797.8563858505466, 798.4969469234375, 800.4316934976144, 823.275517544563, 823.8887750153742, 825.896762904637, 829.7966998085477, 833.2292629317888, 812.273015650992, 818.5252553518944, 822.461287856455, 823.279630323467, 824.0, 609.9756009759649, 611.0467670434092, 611.6391329115843, 615.1603061820628, 615.741388616782, 11686.0, 11696.766064678659, 11704.0, 11731.88268117325, 11755.118366122575, 11204.831927521094, 11501.76996460066, 11621.302721836631, 11988.940055299754, 12223.816642750366, 10783.083437907788, 10961.068309193728, 11020.614278500214, 11064.944675276653, 11112.44437778108, 3242.2542815152647, 3264.853081611333, 3308.884189053396, 3362.411577973869, 3378.797272163678, 40966.590334096574, 41225.1754964902, 41505.79247103745, 41544.0, 42168.15663686709, 9311.255099592016, 9630.422174669542, 9748.9025109748, 9836.704898853046, 9849.75375615601, 16143.919280403758, 16214.189290535662, 16246.106464144586, 16269.10519921392, 16271.8033065537, 6276.340984196685, 6309.0, 6363.809085727436, 6485.254195767453, 6618.602883826986, 3706.8517259309324, 3715.108373990223, 3730.813459327023, 3747.5315585551807, 3792.677622402127, 2733.139061195717, 2744.986275068612, 2745.492083964433, 2767.1283545683045, 2773.583962405615, 470.06926285954, 474.27909577442784, 482.32233711635206, 482.879280179955, 484.43805185984087, 613.6134235431649, 614.6772944204329, 628.4218518962565, 643.1253495246461, 645.725566634188, 7839.529628222325, 8617.913820861837, 8810.251128654008, 9004.909950900537, 9042.728718138467, 564.7938502446659, 580.1703563903574, 583.5419195931173, 595.1519085303512, 603.9094135879653, 3633.291508155884, 3752.478263692244, 3892.5328960524353, 3905.1994341159993, 3990.461287726178, 50480.74759626178, 51967.0, 52014.0, 52215.73892130591, 54100.72949635305, 40646.59353406428, 40758.592414076076, 42580.0, 42831.0, 43312.0, 39307.0, 39867.60132398639, 40077.398839017435, 41930.790346048685, 42508.78745606314, 7826.921730782847, 7902.85408615759, 8374.916250837414, 8436.156384361515, 8500.957495212484, 29720.554191686708, 30003.249918752204, 30374.848125760112, 30413.0, 30585.54121688132, 33580.328393432486, 33741.0, 35418.46872296866, 38868.222635547696, 39136.804315979374, 9972.3019388645, 10172.542235599563, 10236.539355729159, 10290.228232882415, 10515.158787296845, 10808.567657293936, 11025.17311201647, 11041.944790276319, 11223.316502524687, 11291.668123667081, 10632.362058276529, 10650.89349106499, 10658.467076646291, 10675.679729608124, 10744.570217191225, 10440.530176142243, 10510.737231569272, 10513.89486105129, 10521.158307335241, 10579.788404232026, 10639.574417023232, 10751.354918704903, 10766.569337226736, 10779.51492182838, 10866.565337386415, 9007.459552426875, 9092.0, 9325.580348884181, 9374.203192728695, 9391.0, 9026.81946361056, 9296.39573427725, 9325.300602454707, 9494.715158545254, 9531.761705957406], "unit": "score", "name": "yui.html", "value": 5820.912570925559}], "name": "dromaeo_css", "value": 6196.270136379616}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 116.0, 115.0, 116.0, 125.0, 113.0, 113.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [173.0, 134.0, 166.0, 168.0, 141.0, 157.0, 166.0, 136.0, 173.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 154.7}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 165.0, 164.0, 164.0, 167.0, 165.0, 163.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 74.0, 75.0, 78.0, 139.0, 76.0, 74.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 133.0, 97.0, 98.0, 98.0, 139.0, 97.0, 99.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 115.0, 119.0, 116.0, 116.0, 115.0, 116.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.3}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 148.0, 147.0, 148.0, 149.0, 150.0, 147.0, 148.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 148.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 97.0, 98.0, 97.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 70.0, 68.0, 67.0, 67.0, 75.0, 69.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 70.0, 72.0, 70.0, 71.0, 70.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 86.0, 86.0, 86.0, 85.0, 84.0, 86.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [124.0, 128.0, 139.0, 127.0, 132.0, 124.0, 125.0, 127.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [143.0, 154.0, 151.0, 156.0, 143.0, 144.0, 150.0, 153.0, 159.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 73.0, 74.0, 75.0, 71.0, 71.0, 70.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1558.9}]} 05:37:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1558.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6196.27"}}} 05:37:01 INFO - Return code: 0 05:37:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:37:01 ERROR - # TBPL SUCCESS # 05:37:01 INFO - Running post-action listener: _resource_record_post_action 05:37:01 INFO - Running post-run listener: _resource_record_post_run 05:37:02 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 530440192; Read time: 0; Write time: 643004 05:37:02 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240734208; Read time: 0; Write time: 377016 05:37:02 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289554432; Read time: 0; Write time: 265948 05:37:02 INFO - Running post-run listener: _upload_blobber_files 05:37:02 INFO - Blob upload gear active. 05:37:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:02 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:37:02 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:37:02 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:37:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:37:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:37:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:03 INFO - (blobuploader) - INFO - Done attempting. 05:37:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:37:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:37:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:04 INFO - (blobuploader) - INFO - Done attempting. 05:37:04 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:04 INFO - Return code: 0 05:37:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c50892cba17ac253bbfba5d7ca8671dfaa830166cf87bf25b15f0c43bf9e3be8720215342f750837fd5bc9bb14c5600e7fb8d7c49bd909a1300090f00a2ab22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fecb27a4231f4ee046d860bc3438657d7948da87b60b892ae73a34215a29e8b31ce0bab1575e73974443c96182a1e5283d5ced9edb7dc52a6f5cda78e69b681"} 05:37:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:04 INFO - Contents: 05:37:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c50892cba17ac253bbfba5d7ca8671dfaa830166cf87bf25b15f0c43bf9e3be8720215342f750837fd5bc9bb14c5600e7fb8d7c49bd909a1300090f00a2ab22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fecb27a4231f4ee046d860bc3438657d7948da87b60b892ae73a34215a29e8b31ce0bab1575e73974443c96182a1e5283d5ced9edb7dc52a6f5cda78e69b681"} 05:37:04 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:04 INFO - Copying logs to upload dir... 05:37:04 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.476908 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-02-06 05:37:04.175984) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 05:37:04.179199) ========= 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=14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333 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/4c50892cba17ac253bbfba5d7ca8671dfaa830166cf87bf25b15f0c43bf9e3be8720215342f750837fd5bc9bb14c5600e7fb8d7c49bd909a1300090f00a2ab22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fecb27a4231f4ee046d860bc3438657d7948da87b60b892ae73a34215a29e8b31ce0bab1575e73974443c96182a1e5283d5ced9edb7dc52a6f5cda78e69b681"} 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.011491 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/4c50892cba17ac253bbfba5d7ca8671dfaa830166cf87bf25b15f0c43bf9e3be8720215342f750837fd5bc9bb14c5600e7fb8d7c49bd909a1300090f00a2ab22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fecb27a4231f4ee046d860bc3438657d7948da87b60b892ae73a34215a29e8b31ce0bab1575e73974443c96182a1e5283d5ced9edb7dc52a6f5cda78e69b681"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 05:37:04.203649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:37:04.203979) ========= 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=14ef55db36f7623abb31b9cf000001d5-1454764592.336309-1452427333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:37:04.289475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 05:37:04.290216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 05:37:04.290865) ========= ========= Total master_lag: 0.28 =========